-- Logs begin at Sat 2024-08-17 22:08:53 WIB, end at Sat 2024-08-17 22:10:00 WIB. -- Aug 17 22:09:00 tube-rivo-audio kernel: meson-mmc: actual_clock :400000, HHI_nand: 0x80 Aug 17 22:09:00 tube-rivo-audio kernel: meson-mmc: [meson_mmc_clk_set_rate_v3] after clock: 0x1000023c Aug 17 22:09:00 tube-rivo-audio kernel: meson-mmc: actual_clock :0, HHI_nand: 0x80 Aug 17 22:09:00 tube-rivo-audio kernel: meson-mmc: [meson_mmc_clk_set_rate_v3] after clock: 0x1000023c Aug 17 22:09:00 tube-rivo-audio kernel: meson-mmc: actual_clock :400000, HHI_nand: 0x80 Aug 17 22:09:00 tube-rivo-audio kernel: meson-mmc: [meson_mmc_clk_set_rate_v3] after clock: 0x1000023c Aug 17 22:09:00 tube-rivo-audio kernel: sdio_read_cis: 2 callbacks suppressed Aug 17 22:09:00 tube-rivo-audio kernel: sdio: queuing unknown CIS tuple 0x80 (2 bytes) Aug 17 22:09:00 tube-rivo-audio kernel: sdio: queuing unknown CIS tuple 0x80 (3 bytes) Aug 17 22:09:00 tube-rivo-audio kernel: sdio: queuing unknown CIS tuple 0x80 (3 bytes) Aug 17 22:09:00 tube-rivo-audio kernel: sdio: queuing unknown CIS tuple 0x80 (7 bytes) Aug 17 22:09:00 tube-rivo-audio kernel: sdio: queuing unknown CIS tuple 0x81 (9 bytes) Aug 17 22:09:00 tube-rivo-audio kernel: sdio: queuing unknown CIS tuple 0x8e (9 bytes) Aug 17 22:09:00 tube-rivo-audio kernel: meson-aml-mmc ffe03000.sdio: divider requested rate 200000000 != actual rate 199999997: ret=0 Aug 17 22:09:00 tube-rivo-audio kernel: meson-mmc: actual_clock :199999997, HHI_nand: 0x80 Aug 17 22:09:00 tube-rivo-audio kernel: meson-mmc: [meson_mmc_clk_set_rate_v3] after clock: 0x10000245 Aug 17 22:09:00 tube-rivo-audio kernel: meson-mmc: Data 1 aligned delay is 0 Aug 17 22:09:00 tube-rivo-audio kernel: meson-mmc: sdio: clk 199999997 tuning start Aug 17 22:09:00 tube-rivo-audio kernel: meson-mmc: Tuning transfer error: nmatch=0 tuning_err:0xffffffac Aug 17 22:09:00 tube-rivo-audio kernel: meson-mmc: sdio: rx_tuning_result[1] = 40 Aug 17 22:09:00 tube-rivo-audio kernel: meson-mmc: sdio: rx_tuning_result[2] = 40 Aug 17 22:09:00 tube-rivo-audio kernel: meson-mmc: sdio: rx_tuning_result[3] = 40 Aug 17 22:09:00 tube-rivo-audio kernel: meson-mmc: sdio: rx_tuning_result[4] = 40 Aug 17 22:09:00 tube-rivo-audio kernel: meson-mmc: [prev_map] fixed_adj_win_map:30 Aug 17 22:09:00 tube-rivo-audio kernel: meson-mmc: [0]=0 Aug 17 22:09:00 tube-rivo-audio kernel: meson-mmc: [1]=1 Aug 17 22:09:00 tube-rivo-audio kernel: meson-mmc: [2]=1 Aug 17 22:09:00 tube-rivo-audio kernel: meson-mmc: [3]=1 Aug 17 22:09:00 tube-rivo-audio kernel: meson-mmc: [4]=1 Aug 17 22:09:00 tube-rivo-audio kernel: meson-mmc: [_find_fixed_adj_valid_win]retry test fixed adj... Aug 17 22:09:00 tube-rivo-audio kernel: meson-mmc: step:4, delay1:0x4104104, delay2:0x4004104 Aug 17 22:09:00 tube-rivo-audio kernel: meson-mmc: Tuning transfer error: nmatch=0 tuning_err:0xffffffac Aug 17 22:09:00 tube-rivo-audio kernel: meson-mmc: sdio: rx_tuning_result[1] = 40 Aug 17 22:09:00 tube-rivo-audio kernel: meson-mmc: sdio: rx_tuning_result[2] = 40 Aug 17 22:09:00 tube-rivo-audio kernel: meson-mmc: sdio: rx_tuning_result[3] = 40 Aug 17 22:09:00 tube-rivo-audio kernel: meson-mmc: sdio: rx_tuning_result[4] = 40 Aug 17 22:09:00 tube-rivo-audio kernel: meson-mmc: [_find_fixed_adj_valid_win]retry test fixed adj... Aug 17 22:09:00 tube-rivo-audio kernel: meson-mmc: step:8, delay1:0x8208208, delay2:0x8008208 Aug 17 22:09:00 tube-rivo-audio kernel: meson-mmc: Tuning transfer error: nmatch=0 tuning_err:0xffffffac Aug 17 22:09:00 tube-rivo-audio kernel: meson-mmc: sdio: rx_tuning_result[1] = 40 Aug 17 22:09:00 tube-rivo-audio kernel: meson-mmc: sdio: rx_tuning_result[2] = 40 Aug 17 22:09:00 tube-rivo-audio kernel: meson-mmc: sdio: rx_tuning_result[3] = 40 Aug 17 22:09:00 tube-rivo-audio kernel: meson-mmc: sdio: rx_tuning_result[4] = 40 Aug 17 22:09:00 tube-rivo-audio kernel: meson-mmc: [_find_fixed_adj_valid_win]retry test fixed adj... Aug 17 22:09:00 tube-rivo-audio kernel: meson-mmc: step:12, delay1:0xc30c30c, delay2:0xc00c30c Aug 17 22:09:00 tube-rivo-audio kernel: meson-mmc: sdio: rx_tuning_result[0] = 40 Aug 17 22:09:00 tube-rivo-audio kernel: meson-mmc: Tuning transfer error: nmatch=0 tuning_err:0xffffffac Aug 17 22:09:00 tube-rivo-audio kernel: meson-mmc: sdio: rx_tuning_result[2] = 40 Aug 17 22:09:00 tube-rivo-audio kernel: meson-mmc: sdio: rx_tuning_result[3] = 40 Aug 17 22:09:00 tube-rivo-audio kernel: meson-mmc: sdio: rx_tuning_result[4] = 40 Aug 17 22:09:00 tube-rivo-audio kernel: meson-mmc: [>>>>>>>>bitmap_xor_dst] fixed_adj_win_map:2 Aug 17 22:09:00 tube-rivo-audio kernel: meson-mmc: [0]=0 Aug 17 22:09:00 tube-rivo-audio kernel: meson-mmc: [1]=1 Aug 17 22:09:00 tube-rivo-audio kernel: meson-mmc: [2]=0 Aug 17 22:09:00 tube-rivo-audio kernel: meson-mmc: [3]=0 Aug 17 22:09:00 tube-rivo-audio kernel: meson-mmc: [4]=0 Aug 17 22:09:00 tube-rivo-audio kernel: meson-mmc: [_find_fixed_adj_valid_win] fir_adj:1 Aug 17 22:09:00 tube-rivo-audio kernel: meson-mmc: [>>>>>>>>prev_map_range] fixed_adj_win_map:495 Aug 17 22:09:00 tube-rivo-audio kernel: meson-mmc: [1]=1 Aug 17 22:09:00 tube-rivo-audio kernel: meson-mmc: [2]=1 Aug 17 22:09:00 tube-rivo-audio kernel: meson-mmc: [3]=1 Aug 17 22:09:00 tube-rivo-audio kernel: meson-mmc: [4]=1 Aug 17 22:09:00 tube-rivo-audio kernel: meson-mmc: [0]=0 Aug 17 22:09:00 tube-rivo-audio kernel: meson-mmc: left:3, right:0, mid:4, size:4 Aug 17 22:09:00 tube-rivo-audio kernel: meson-mmc: step:0, delay1:0x0, delay2:0x0 Aug 17 22:09:00 tube-rivo-audio kernel: meson-mmc: sdio: sd_emmc_regs->gclock=0x10000245,sd_emmc_regs->gadjust=0x32000 Aug 17 22:09:00 tube-rivo-audio kernel: meson-mmc: delay1:0x0, delay2:0x0 Aug 17 22:09:00 tube-rivo-audio kernel: sdioh_start: set sd_f2_blocksize 256 Aug 17 22:09:00 tube-rivo-audio kernel: dhd_bus_devreset: == WLAN ON == Aug 17 22:09:00 tube-rivo-audio kernel: F1 signature read @0x18000000=0x17294359 Aug 17 22:09:00 tube-rivo-audio kernel: F1 signature OK, socitype:0x1 chip:0x4359 rev:0x9 pkg:0x2 Aug 17 22:09:00 tube-rivo-audio kernel: DHD: dongle ram size is set to 917504(orig 917504) at 0x160000 Aug 17 22:09:00 tube-rivo-audio kernel: dhd_bus_set_default_min_res_mask: Unhandled chip id Aug 17 22:09:00 tube-rivo-audio kernel: dhd_os_open_image: /lib/firmware/brcm/config_bcm4359c0_ag.txt (185 bytes) open success Aug 17 22:09:00 tube-rivo-audio kernel: dhd_conf_read_sdio_params: dhd_slpauto = 0 Aug 17 22:09:00 tube-rivo-audio kernel: dhd_conf_read_others: ccode = ALL Aug 17 22:09:00 tube-rivo-audio kernel: dhd_conf_read_others: regrev = 38 Aug 17 22:09:00 tube-rivo-audio kernel: dhd_conf_read_nv_by_chip: nv_by_chip_count=5 Aug 17 22:09:00 tube-rivo-audio kernel: dhd_conf_read_nv_by_chip: chip=0xa9a6, chiprev=0, name=nvram_ap6212.txt Aug 17 22:09:00 tube-rivo-audio kernel: dhd_conf_read_nv_by_chip: chip=0xa9a6, chiprev=1, name=nvram_ap6212a.txt Aug 17 22:09:00 tube-rivo-audio kernel: dhd_conf_read_nv_by_chip: chip=0x4345, chiprev=6, name=nvram_ap6255.txt Aug 17 22:09:00 tube-rivo-audio kernel: dhd_conf_read_nv_by_chip: chip=0x4354, chiprev=2, name=nvram_ap6356.txt Aug 17 22:09:00 tube-rivo-audio kernel: dhd_conf_read_nv_by_chip: chip=0x4359, chiprev=9, name=nvram_ap6359sa.txt Aug 17 22:09:00 tube-rivo-audio kernel: Final fw_path=/lib/firmware/brcm/fw_bcm4359c0_ag.bin Aug 17 22:09:00 tube-rivo-audio kernel: Final nv_path=/lib/firmware/brcm/nvram_ap6359sa.txt Aug 17 22:09:00 tube-rivo-audio kernel: Final clm_path=/lib/firmware/brcm/clm.blob Aug 17 22:09:00 tube-rivo-audio kernel: Final conf_path=/lib/firmware/brcm/config_bcm4359c0_ag.txt Aug 17 22:09:00 tube-rivo-audio kernel: dhd_os_open_image: /lib/firmware/brcm/fw_bcm4359c0_ag.bin (595758 bytes) open success Aug 17 22:09:00 tube-rivo-audio kernel: dhd_os_open_image: /lib/firmware/brcm/nvram_ap6359sa.txt (5861 bytes) open success Aug 17 22:09:00 tube-rivo-audio kernel: [43B blob data] Aug 17 22:09:00 tube-rivo-audio kernel: dhdsdio_write_vars: Download, Upload and compare of NVRAM succeeded. Aug 17 22:09:00 tube-rivo-audio haveged[2817]: haveged: ver: 1.9.1; arch: generic; vend: ; build: (gcc 8.3.0 CTV); collect: 128K Aug 17 22:09:00 tube-rivo-audio haveged[2817]: haveged: cpu: (VC); data: 16K (D); inst: 16K (D); idx: 12/40; sz: 15012/57848 Aug 17 22:09:00 tube-rivo-audio haveged[2817]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 7.99741 Aug 17 22:09:00 tube-rivo-audio haveged[2817]: haveged: fills: 0, generated: 0 Aug 17 22:09:00 tube-rivo-audio kernel: dhd_bus_init: enable 0x06, ready 0x06 (waited 0us) Aug 17 22:09:00 tube-rivo-audio kernel: si_get_pmu_reg_addr: addrRET: 18000670 Aug 17 22:09:00 tube-rivo-audio kernel: bcmsdh_oob_intr_register: HW_OOB irq=70 flags=0x8 Aug 17 22:09:00 tube-rivo-audio kernel: dhd_get_memdump_info: File [/data/misc/wifi/.memdump.info] doesn't exist Aug 17 22:09:00 tube-rivo-audio kernel: dhd_get_memdump_info: MEMDUMP ENABLED = 2 Aug 17 22:09:00 tube-rivo-audio kernel: dhd_tcpack_suppress_set: TCP ACK Suppress mode 0 -> mode 1 Aug 17 22:09:00 tube-rivo-audio kernel: dhd_apply_default_clm: Ignore clm file /lib/firmware/brcm/clm.blob Aug 17 22:09:00 tube-rivo-audio kernel: Firmware up: op_mode=0x0405, MAC=70:4a:0e:ab:c4:ba Aug 17 22:09:00 tube-rivo-audio kernel: Driver: 1.579.77.41.10 (r) Firmware: wl0: Jan 19 2018 12:14:30 version 9.87.51.11.8 (a85e25e@shgit) (r) FWID 01-cb5aa0a5 CLM: 9.7.5 Aug 17 22:09:00 tube-rivo-audio kernel: dhd_txglom_enable: enable 1 Aug 17 22:09:00 tube-rivo-audio kernel: dhd_conf_set_txglom_params: txglom_mode=copy Aug 17 22:09:00 tube-rivo-audio kernel: dhd_conf_set_txglom_params: txglomsize=36, deferred_tx_len=0 Aug 17 22:09:00 tube-rivo-audio kernel: dhd_conf_set_txglom_params: txinrx_thres=128, dhd_txminmax=-1 Aug 17 22:09:00 tube-rivo-audio kernel: dhd_conf_set_txglom_params: tx_max_offset=0, txctl_tmo_fix=300 Aug 17 22:09:00 tube-rivo-audio kernel: dhd_conf_get_disable_proptx: fw_proptx=0, disable_proptx=1 Aug 17 22:09:00 tube-rivo-audio kernel: dhd_pno_init: Support Android Location Service Aug 17 22:09:00 tube-rivo-audio kernel: rtt_do_get_ioctl: failed to send getbuf proxd iovar (CMD ID : 1), status=-23 Aug 17 22:09:00 tube-rivo-audio kernel: dhd_rtt_init : FTM is not supported Aug 17 22:09:00 tube-rivo-audio kernel: dhd_preinit_ioctls: SensorHub diabled 0 Aug 17 22:09:00 tube-rivo-audio kernel: dhd_preinit_ioctls failed to set ShubHub disable Aug 17 22:09:00 tube-rivo-audio kernel: failed to set WNM capabilities Aug 17 22:09:00 tube-rivo-audio kernel: dhd_conf_set_country: set country ALL, revision 38 Aug 17 22:09:00 tube-rivo-audio kernel: CONFIG-ERROR) dhd_conf_set_bufiovar: country setting failed -2 Aug 17 22:09:00 tube-rivo-audio kernel: Country code: US (US/0) Aug 17 22:09:00 tube-rivo-audio kernel: CONFIG-ERROR) dhd_conf_set_intiovar: txbf setting failed -23 Aug 17 22:09:00 tube-rivo-audio kernel: wl_android_wifi_on: Success Aug 17 22:09:00 tube-rivo-audio kernel: dhd_open : the lock is released. Aug 17 22:09:00 tube-rivo-audio kernel: dhd_open: Exit ret=0 Aug 17 22:09:00 tube-rivo-audio sudo[3107]: pam_unix(sudo:session): session closed for user root Aug 17 22:09:00 tube-rivo-audio nmbd[3064]: [2024/08/17 22:09:00.585581, 0] ../lib/util/become_daemon.c:149(daemon_status) Aug 17 22:09:00 tube-rivo-audio nmbd[3064]: daemon_status: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ... Aug 17 22:09:00 tube-rivo-audio nmbd[3064]: [2024/08/17 22:09:00.585771, 0] ../source3/nmbd/nmbd_subnetdb.c:254(create_subnets) Aug 17 22:09:00 tube-rivo-audio nmbd[3064]: NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6). Aug 17 22:09:00 tube-rivo-audio dhcpcd[2841]: dummy0: soliciting a DHCP lease Aug 17 22:09:00 tube-rivo-audio dhcpcd[2841]: wlan0: carrier acquired Aug 17 22:09:00 tube-rivo-audio dhcpcd[2841]: dummy0: soliciting a DHCP lease Aug 17 22:09:00 tube-rivo-audio dhcpcd[2841]: wlan0: carrier acquired Aug 17 22:09:00 tube-rivo-audio dhcpcd[2841]: wlan0: IAID 0e:ab:c4:ba Aug 17 22:09:00 tube-rivo-audio dhcpcd[2841]: wlan0: IAID 0e:ab:c4:ba Aug 17 22:09:00 tube-rivo-audio sudo[3114]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Aug 17 22:09:00 tube-rivo-audio sudo[3114]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 22:09:00 tube-rivo-audio sudo[3114]: pam_unix(sudo:session): session closed for user root Aug 17 22:09:00 tube-rivo-audio sudo[3122]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Aug 17 22:09:00 tube-rivo-audio sudo[3122]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 22:09:00 tube-rivo-audio sudo[3122]: pam_unix(sudo:session): session closed for user root Aug 17 22:09:00 tube-rivo-audio sudo[3125]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Aug 17 22:09:00 tube-rivo-audio sudo[3125]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 22:09:00 tube-rivo-audio sh[2773]: eth0: carrier acquired Aug 17 22:09:00 tube-rivo-audio dhcpcd[2821]: eth0: carrier acquired Aug 17 22:09:00 tube-rivo-audio kernel: meson6-dwmac ff3f0000.ethernet eth0: Link is Up - 100Mbps/Full - flow control off Aug 17 22:09:00 tube-rivo-audio dhcpcd[2841]: wlan0: soliciting a DHCP lease Aug 17 22:09:00 tube-rivo-audio dhcpcd[2841]: eth0: carrier acquired Aug 17 22:09:00 tube-rivo-audio dhcpcd[2841]: wlan0: soliciting a DHCP lease Aug 17 22:09:00 tube-rivo-audio dhcpcd[2841]: eth0: carrier acquired Aug 17 22:09:00 tube-rivo-audio sh[2773]: eth0: IAID 00:17:2c:01 Aug 17 22:09:00 tube-rivo-audio dhcpcd[2821]: eth0: IAID 00:17:2c:01 Aug 17 22:09:00 tube-rivo-audio dhcpcd[2841]: eth0: IAID 00:17:2c:01 Aug 17 22:09:00 tube-rivo-audio dhcpcd[2841]: eth0: IAID 00:17:2c:01 Aug 17 22:09:00 tube-rivo-audio sh[2773]: eth0: soliciting an IPv6 router Aug 17 22:09:00 tube-rivo-audio dhcpcd[2821]: eth0: soliciting an IPv6 router Aug 17 22:09:00 tube-rivo-audio kernel: meson_uart ffd24000.serial: ttyS1 use xtal(24M) 24000000 change 0 to 9600 Aug 17 22:09:00 tube-rivo-audio kernel: meson_uart ffd24000.serial: ttyS1 use xtal(24M) 24000000 change 9600 to 9600 Aug 17 22:09:00 tube-rivo-audio kernel: meson_uart ffd24000.serial: ttyS1 use xtal(24M) 24000000 change 9600 to 115200 Aug 17 22:09:00 tube-rivo-audio ntpd[3058]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Aug 17 22:09:01 tube-rivo-audio dhcpcd[2841]: eth0: rebinding lease of 192.168.1.36 Aug 17 22:09:01 tube-rivo-audio dhcpcd[2841]: eth0: rebinding lease of 192.168.1.36 Aug 17 22:09:01 tube-rivo-audio sh[2773]: eth0: rebinding lease of 192.168.1.36 Aug 17 22:09:01 tube-rivo-audio dhcpcd[2821]: eth0: rebinding lease of 192.168.1.36 Aug 17 22:09:01 tube-rivo-audio dhcpcd[2841]: eth0: soliciting an IPv6 router Aug 17 22:09:01 tube-rivo-audio dhcpcd[2841]: eth0: soliciting an IPv6 router Aug 17 22:09:01 tube-rivo-audio dhcpcd[2841]: eth0: probing address 192.168.1.36/24 Aug 17 22:09:01 tube-rivo-audio dhcpcd[2841]: eth0: probing address 192.168.1.36/24 Aug 17 22:09:01 tube-rivo-audio sh[2773]: eth0: probing address 192.168.1.36/24 Aug 17 22:09:01 tube-rivo-audio dhcpcd[2821]: eth0: probing address 192.168.1.36/24 Aug 17 22:09:01 tube-rivo-audio dhcpcd[2841]: wlan0: soliciting an IPv6 router Aug 17 22:09:01 tube-rivo-audio dhcpcd[2841]: wlan0: soliciting an IPv6 router Aug 17 22:09:01 tube-rivo-audio ifplugd(eth0)[3090]: Link beat detected. Aug 17 22:09:01 tube-rivo-audio ifplugd(eth0)[3090]: Executing '/etc/ifplugd/ifplugd.action eth0 up'. Aug 17 22:09:01 tube-rivo-audio ifplugd(eth0)[3090]: client: ifup: waiting for lock on /run/network/ifstate.eth0 Aug 17 22:09:01 tube-rivo-audio ntpd[3058]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Aug 17 22:09:02 tube-rivo-audio sudo[3125]: pam_unix(sudo:session): session closed for user root Aug 17 22:09:02 tube-rivo-audio wireless.js[2837]: SETTING APPROPRIATE REG DOMAIN: Aug 17 22:09:02 tube-rivo-audio sudo[3138]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Aug 17 22:09:02 tube-rivo-audio sudo[3138]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 22:09:02 tube-rivo-audio sudo[3138]: pam_unix(sudo:session): session closed for user root Aug 17 22:09:02 tube-rivo-audio sudo[3141]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg set Aug 17 22:09:02 tube-rivo-audio sudo[3141]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 22:09:02 tube-rivo-audio sudo[3141]: pam_unix(sudo:session): session closed for user root Aug 17 22:09:02 tube-rivo-audio wireless.js[2837]: Failed to set new reg domain: Error: Command failed: /usr/bin/sudo /sbin/ifconfig wlan0 up && /usr/bin/sudo /sbin/iw reg set Aug 17 22:09:02 tube-rivo-audio wireless.js[2837]: Start wireless flow Aug 17 22:09:02 tube-rivo-audio wireless.js[2837]: Stopped hotspot (if there).. Aug 17 22:09:02 tube-rivo-audio ntpd[3058]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Aug 17 22:09:02 tube-rivo-audio sudo[3146]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Aug 17 22:09:02 tube-rivo-audio sudo[3146]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 22:09:02 tube-rivo-audio sudo[3146]: pam_unix(sudo:session): session closed for user root Aug 17 22:09:02 tube-rivo-audio sudo[3149]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Aug 17 22:09:02 tube-rivo-audio sudo[3149]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 22:09:02 tube-rivo-audio kernel: dhd_stop: Enter ffffffc04e9e2000 Aug 17 22:09:02 tube-rivo-audio kernel: CFGP2P-ERROR) wl_cfgp2p_disable_discovery : do nothing, not initialized Aug 17 22:09:02 tube-rivo-audio kernel: CFGP2P-ERROR) wl_cfgp2p_deinit_priv : In Aug 17 22:09:02 tube-rivo-audio kernel: dhd_tcpack_suppress_set: TCP ACK Suppress mode 1 -> mode 0 Aug 17 22:09:02 tube-rivo-audio kernel: wl_android_wifi_off in 1 Aug 17 22:09:02 tube-rivo-audio kernel: wl_android_wifi_off in 2: g_wifi_on=1, on_failure=1 Aug 17 22:09:02 tube-rivo-audio kernel: dhd_dbg_detach_pkt_monitor, 2204 Aug 17 22:09:02 tube-rivo-audio kernel: dhd_bus_devreset: == Power OFF == Aug 17 22:09:02 tube-rivo-audio kernel: bcmsdh_oob_intr_unregister: Enter Aug 17 22:09:02 tube-rivo-audio kernel: dhd_txglom_enable: enable 0 Aug 17 22:09:02 tube-rivo-audio kernel: dhd_conf_set_txglom_params: txglom_mode=copy Aug 17 22:09:02 tube-rivo-audio kernel: dhd_conf_set_txglom_params: txglomsize=0, deferred_tx_len=0 Aug 17 22:09:02 tube-rivo-audio kernel: dhd_conf_set_txglom_params: txinrx_thres=128, dhd_txminmax=-1 Aug 17 22:09:02 tube-rivo-audio kernel: dhd_conf_set_txglom_params: tx_max_offset=0, txctl_tmo_fix=300 Aug 17 22:09:02 tube-rivo-audio kernel: dhd_bus_devreset: WLAN OFF DONE Aug 17 22:09:02 tube-rivo-audio kernel: wifi_platform_set_power = 0 Aug 17 22:09:02 tube-rivo-audio kernel: ======== PULL WL_REG_ON(-1) LOW! ======== Aug 17 22:09:02 tube-rivo-audio kernel: aml_wifi wifi: [extern_wifi_set_enable] WIFI Disable! 482 Aug 17 22:09:03 tube-rivo-audio dhcpcd[2841]: wlan0: carrier lost Aug 17 22:09:03 tube-rivo-audio dhcpcd[2841]: wlan0: carrier lost Aug 17 22:09:03 tube-rivo-audio kernel: wl_android_wifi_off out Aug 17 22:09:03 tube-rivo-audio kernel: wl_ext_iapsta_dettach_netdev: Enter Aug 17 22:09:03 tube-rivo-audio kernel: dhd_stop: Exit Aug 17 22:09:03 tube-rivo-audio sudo[3149]: pam_unix(sudo:session): session closed for user root Aug 17 22:09:03 tube-rivo-audio wireless.js[2837]: DHCP IP Aug 17 22:09:03 tube-rivo-audio wireless.js[2837]: Start ap Aug 17 22:09:03 tube-rivo-audio wpa_supplicant[3156]: Successfully initialized wpa_supplicant Aug 17 22:09:03 tube-rivo-audio kernel: dhd_open: Enter ffffffc04e9e2000 Aug 17 22:09:03 tube-rivo-audio kernel: dhd_open : no mutex held. set lock Aug 17 22:09:03 tube-rivo-audio kernel: Dongle Host Driver, version 1.579.77.41.10 (r) Aug 17 22:09:03 tube-rivo-audio kernel: wl_ext_iapsta_attach_netdev: ifidx=0, bssidx=0 Aug 17 22:09:03 tube-rivo-audio kernel: wl_android_wifi_on in 1 Aug 17 22:09:03 tube-rivo-audio kernel: wl_android_wifi_on in 2: g_wifi_on=0 Aug 17 22:09:03 tube-rivo-audio kernel: wifi_platform_set_power = 1 Aug 17 22:09:03 tube-rivo-audio kernel: ======== PULL WL_REG_ON(-1) HIGH! ======== Aug 17 22:09:03 tube-rivo-audio kernel: aml_wifi wifi: [extern_wifi_set_enable] WIFI Disable! 482 Aug 17 22:09:03 tube-rivo-audio sudo[3160]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd Aug 17 22:09:03 tube-rivo-audio sudo[3160]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 22:09:03 tube-rivo-audio dhcpcd[3168]: sending commands to master dhcpcd process Aug 17 22:09:03 tube-rivo-audio dhcpcd[2841]: control command: /sbin/dhcpcd Aug 17 22:09:03 tube-rivo-audio dhcpcd[2841]: control command: /sbin/dhcpcd Aug 17 22:09:03 tube-rivo-audio sudo[3160]: pam_unix(sudo:session): session closed for user root Aug 17 22:09:03 tube-rivo-audio kernel: aml_wifi wifi: [extern_wifi_set_enable] WIFI Enable! 482 Aug 17 22:09:03 tube-rivo-audio kernel: sdio_reset_comm(): Aug 17 22:09:03 tube-rivo-audio kernel: meson-mmc: actual_clock :400000, HHI_nand: 0x80 Aug 17 22:09:03 tube-rivo-audio kernel: meson-mmc: [meson_mmc_clk_set_rate_v3] after clock: 0x1000023c Aug 17 22:09:03 tube-rivo-audio kernel: meson-mmc: actual_clock :0, HHI_nand: 0x80 Aug 17 22:09:03 tube-rivo-audio kernel: meson-mmc: [meson_mmc_clk_set_rate_v3] after clock: 0x1000023c Aug 17 22:09:03 tube-rivo-audio kernel: meson-mmc: actual_clock :400000, HHI_nand: 0x80 Aug 17 22:09:03 tube-rivo-audio kernel: meson-mmc: [meson_mmc_clk_set_rate_v3] after clock: 0x1000023c Aug 17 22:09:03 tube-rivo-audio kernel: sdio: queuing unknown CIS tuple 0x80 (2 bytes) Aug 17 22:09:03 tube-rivo-audio kernel: sdio: queuing unknown CIS tuple 0x80 (3 bytes) Aug 17 22:09:03 tube-rivo-audio kernel: sdio: queuing unknown CIS tuple 0x80 (3 bytes) Aug 17 22:09:03 tube-rivo-audio kernel: sdio: queuing unknown CIS tuple 0x80 (7 bytes) Aug 17 22:09:04 tube-rivo-audio kernel: meson-aml-mmc ffe03000.sdio: divider requested rate 200000000 != actual rate 199999997: ret=0 Aug 17 22:09:04 tube-rivo-audio kernel: meson-mmc: actual_clock :199999997, HHI_nand: 0x80 Aug 17 22:09:04 tube-rivo-audio kernel: meson-mmc: [meson_mmc_clk_set_rate_v3] after clock: 0x10000245 Aug 17 22:09:04 tube-rivo-audio kernel: meson-mmc: Data 1 aligned delay is 0 Aug 17 22:09:04 tube-rivo-audio kernel: meson-mmc: sdio: clk 199999997 tuning start Aug 17 22:09:04 tube-rivo-audio kernel: meson-mmc: Tuning transfer error: nmatch=0 tuning_err:0xffffffac Aug 17 22:09:04 tube-rivo-audio kernel: meson-mmc: sdio: rx_tuning_result[1] = 40 Aug 17 22:09:04 tube-rivo-audio kernel: meson-mmc: sdio: rx_tuning_result[2] = 40 Aug 17 22:09:04 tube-rivo-audio kernel: meson-mmc: sdio: rx_tuning_result[3] = 40 Aug 17 22:09:04 tube-rivo-audio kernel: meson-mmc: sdio: rx_tuning_result[4] = 40 Aug 17 22:09:04 tube-rivo-audio kernel: meson-mmc: [prev_map] fixed_adj_win_map:30 Aug 17 22:09:04 tube-rivo-audio kernel: meson-mmc: [0]=0 Aug 17 22:09:04 tube-rivo-audio kernel: meson-mmc: [1]=1 Aug 17 22:09:04 tube-rivo-audio kernel: meson-mmc: [2]=1 Aug 17 22:09:04 tube-rivo-audio kernel: meson-mmc: [3]=1 Aug 17 22:09:04 tube-rivo-audio kernel: meson-mmc: [4]=1 Aug 17 22:09:04 tube-rivo-audio kernel: meson-mmc: [_find_fixed_adj_valid_win]retry test fixed adj... Aug 17 22:09:04 tube-rivo-audio kernel: meson-mmc: step:4, delay1:0x4104104, delay2:0x4004104 Aug 17 22:09:04 tube-rivo-audio kernel: meson-mmc: Tuning transfer error: nmatch=0 tuning_err:0xffffffac Aug 17 22:09:04 tube-rivo-audio kernel: meson-mmc: sdio: rx_tuning_result[1] = 40 Aug 17 22:09:04 tube-rivo-audio kernel: meson-mmc: sdio: rx_tuning_result[2] = 40 Aug 17 22:09:04 tube-rivo-audio kernel: meson-mmc: sdio: rx_tuning_result[3] = 40 Aug 17 22:09:04 tube-rivo-audio kernel: meson-mmc: sdio: rx_tuning_result[4] = 40 Aug 17 22:09:04 tube-rivo-audio kernel: meson-mmc: [_find_fixed_adj_valid_win]retry test fixed adj... Aug 17 22:09:04 tube-rivo-audio kernel: meson-mmc: step:8, delay1:0x8208208, delay2:0x8008208 Aug 17 22:09:04 tube-rivo-audio kernel: meson-mmc: Tuning transfer error: nmatch=0 tuning_err:0xffffffac Aug 17 22:09:04 tube-rivo-audio kernel: meson-mmc: sdio: rx_tuning_result[1] = 40 Aug 17 22:09:04 tube-rivo-audio kernel: meson-mmc: sdio: rx_tuning_result[2] = 40 Aug 17 22:09:04 tube-rivo-audio kernel: meson-mmc: sdio: rx_tuning_result[3] = 40 Aug 17 22:09:04 tube-rivo-audio kernel: meson-mmc: sdio: rx_tuning_result[4] = 40 Aug 17 22:09:04 tube-rivo-audio kernel: meson-mmc: [_find_fixed_adj_valid_win]retry test fixed adj... Aug 17 22:09:04 tube-rivo-audio kernel: meson-mmc: step:12, delay1:0xc30c30c, delay2:0xc00c30c Aug 17 22:09:04 tube-rivo-audio kernel: meson-mmc: sdio: rx_tuning_result[0] = 40 Aug 17 22:09:04 tube-rivo-audio kernel: meson-mmc: Tuning transfer error: nmatch=2 tuning_err:0xffffffac Aug 17 22:09:04 tube-rivo-audio kernel: meson-mmc: sdio: rx_tuning_result[2] = 40 Aug 17 22:09:04 tube-rivo-audio kernel: meson-mmc: sdio: rx_tuning_result[3] = 40 Aug 17 22:09:04 tube-rivo-audio kernel: meson-mmc: sdio: rx_tuning_result[4] = 40 Aug 17 22:09:04 tube-rivo-audio kernel: meson-mmc: [>>>>>>>>bitmap_xor_dst] fixed_adj_win_map:2 Aug 17 22:09:04 tube-rivo-audio kernel: meson-mmc: [0]=0 Aug 17 22:09:04 tube-rivo-audio kernel: meson-mmc: [1]=1 Aug 17 22:09:04 tube-rivo-audio kernel: meson-mmc: [2]=0 Aug 17 22:09:04 tube-rivo-audio kernel: meson-mmc: [3]=0 Aug 17 22:09:04 tube-rivo-audio kernel: meson-mmc: [4]=0 Aug 17 22:09:04 tube-rivo-audio kernel: meson-mmc: [_find_fixed_adj_valid_win] fir_adj:1 Aug 17 22:09:04 tube-rivo-audio kernel: meson-mmc: [>>>>>>>>prev_map_range] fixed_adj_win_map:495 Aug 17 22:09:04 tube-rivo-audio kernel: meson-mmc: [1]=1 Aug 17 22:09:04 tube-rivo-audio kernel: meson-mmc: [2]=1 Aug 17 22:09:04 tube-rivo-audio kernel: meson-mmc: [3]=1 Aug 17 22:09:04 tube-rivo-audio kernel: meson-mmc: [4]=1 Aug 17 22:09:04 tube-rivo-audio kernel: meson-mmc: [0]=0 Aug 17 22:09:04 tube-rivo-audio kernel: meson-mmc: left:3, right:0, mid:4, size:4 Aug 17 22:09:04 tube-rivo-audio kernel: meson-mmc: step:0, delay1:0x0, delay2:0x0 Aug 17 22:09:04 tube-rivo-audio kernel: meson-mmc: sdio: sd_emmc_regs->gclock=0x10000245,sd_emmc_regs->gadjust=0x32000 Aug 17 22:09:04 tube-rivo-audio kernel: meson-mmc: delay1:0x0, delay2:0x0 Aug 17 22:09:04 tube-rivo-audio kernel: sdioh_start: set sd_f2_blocksize 256 Aug 17 22:09:04 tube-rivo-audio kernel: dhd_bus_devreset: == WLAN ON == Aug 17 22:09:04 tube-rivo-audio kernel: F1 signature read @0x18000000=0x17294359 Aug 17 22:09:04 tube-rivo-audio kernel: F1 signature OK, socitype:0x1 chip:0x4359 rev:0x9 pkg:0x2 Aug 17 22:09:04 tube-rivo-audio kernel: DHD: dongle ram size is set to 917504(orig 917504) at 0x160000 Aug 17 22:09:04 tube-rivo-audio kernel: dhd_bus_set_default_min_res_mask: Unhandled chip id Aug 17 22:09:04 tube-rivo-audio kernel: dhd_os_open_image: /lib/firmware/brcm/config_bcm4359c0_ag.txt (185 bytes) open success Aug 17 22:09:04 tube-rivo-audio kernel: dhd_conf_read_sdio_params: dhd_slpauto = 0 Aug 17 22:09:04 tube-rivo-audio kernel: dhd_conf_read_others: ccode = ALL Aug 17 22:09:04 tube-rivo-audio kernel: dhd_conf_read_others: regrev = 38 Aug 17 22:09:04 tube-rivo-audio kernel: dhd_conf_read_nv_by_chip: nv_by_chip_count=5 Aug 17 22:09:04 tube-rivo-audio kernel: dhd_conf_read_nv_by_chip: chip=0xa9a6, chiprev=0, name=nvram_ap6212.txt Aug 17 22:09:04 tube-rivo-audio kernel: dhd_conf_read_nv_by_chip: chip=0xa9a6, chiprev=1, name=nvram_ap6212a.txt Aug 17 22:09:04 tube-rivo-audio kernel: dhd_conf_read_nv_by_chip: chip=0x4345, chiprev=6, name=nvram_ap6255.txt Aug 17 22:09:04 tube-rivo-audio kernel: dhd_conf_read_nv_by_chip: chip=0x4354, chiprev=2, name=nvram_ap6356.txt Aug 17 22:09:04 tube-rivo-audio kernel: dhd_conf_read_nv_by_chip: chip=0x4359, chiprev=9, name=nvram_ap6359sa.txt Aug 17 22:09:04 tube-rivo-audio kernel: Final fw_path=/lib/firmware/brcm/fw_bcm4359c0_ag.bin Aug 17 22:09:04 tube-rivo-audio kernel: Final nv_path=/lib/firmware/brcm/nvram_ap6359sa.txt Aug 17 22:09:04 tube-rivo-audio kernel: Final clm_path=/lib/firmware/brcm/clm.blob Aug 17 22:09:04 tube-rivo-audio kernel: Final conf_path=/lib/firmware/brcm/config_bcm4359c0_ag.txt Aug 17 22:09:04 tube-rivo-audio kernel: dhd_os_open_image: /lib/firmware/brcm/fw_bcm4359c0_ag.bin (595758 bytes) open success Aug 17 22:09:04 tube-rivo-audio wireless.js[2837]: trying... Aug 17 22:09:04 tube-rivo-audio kernel: dhd_os_open_image: /lib/firmware/brcm/nvram_ap6359sa.txt (5861 bytes) open success Aug 17 22:09:04 tube-rivo-audio kernel: [43B blob data] Aug 17 22:09:04 tube-rivo-audio kernel: dhdsdio_write_vars: Download, Upload and compare of NVRAM succeeded. Aug 17 22:09:04 tube-rivo-audio kernel: dhd_bus_init: enable 0x06, ready 0x06 (waited 0us) Aug 17 22:09:04 tube-rivo-audio kernel: si_get_pmu_reg_addr: addrRET: 18000670 Aug 17 22:09:04 tube-rivo-audio kernel: bcmsdh_oob_intr_register: HW_OOB irq=70 flags=0x8 Aug 17 22:09:04 tube-rivo-audio kernel: dhd_get_memdump_info: File [/data/misc/wifi/.memdump.info] doesn't exist Aug 17 22:09:04 tube-rivo-audio kernel: dhd_get_memdump_info: MEMDUMP ENABLED = 2 Aug 17 22:09:04 tube-rivo-audio kernel: dhd_tcpack_suppress_set: TCP ACK Suppress mode 0 -> mode 1 Aug 17 22:09:04 tube-rivo-audio kernel: dhd_apply_default_clm: Ignore clm file /lib/firmware/brcm/clm.blob Aug 17 22:09:04 tube-rivo-audio kernel: Firmware up: op_mode=0x0405, MAC=70:4a:0e:ab:c4:ba Aug 17 22:09:04 tube-rivo-audio kernel: Driver: 1.579.77.41.10 (r) Firmware: wl0: Jan 19 2018 12:14:30 version 9.87.51.11.8 (a85e25e@shgit) (r) FWID 01-cb5aa0a5 CLM: 9.7.5 Aug 17 22:09:04 tube-rivo-audio kernel: dhd_txglom_enable: enable 1 Aug 17 22:09:04 tube-rivo-audio kernel: dhd_conf_set_txglom_params: txglom_mode=copy Aug 17 22:09:04 tube-rivo-audio kernel: dhd_conf_set_txglom_params: txglomsize=36, deferred_tx_len=0 Aug 17 22:09:04 tube-rivo-audio kernel: dhd_conf_set_txglom_params: txinrx_thres=128, dhd_txminmax=-1 Aug 17 22:09:04 tube-rivo-audio kernel: dhd_conf_set_txglom_params: tx_max_offset=0, txctl_tmo_fix=300 Aug 17 22:09:04 tube-rivo-audio kernel: dhd_conf_get_disable_proptx: fw_proptx=0, disable_proptx=1 Aug 17 22:09:04 tube-rivo-audio kernel: dhd_pno_init: Support Android Location Service Aug 17 22:09:04 tube-rivo-audio kernel: rtt_do_get_ioctl: failed to send getbuf proxd iovar (CMD ID : 1), status=-23 Aug 17 22:09:04 tube-rivo-audio kernel: dhd_rtt_init : FTM is not supported Aug 17 22:09:04 tube-rivo-audio kernel: dhd_preinit_ioctls: SensorHub diabled 0 Aug 17 22:09:04 tube-rivo-audio kernel: dhd_preinit_ioctls failed to set ShubHub disable Aug 17 22:09:04 tube-rivo-audio kernel: failed to set WNM capabilities Aug 17 22:09:04 tube-rivo-audio kernel: dhd_conf_set_country: set country ALL, revision 38 Aug 17 22:09:04 tube-rivo-audio kernel: CONFIG-ERROR) dhd_conf_set_bufiovar: country setting failed -2 Aug 17 22:09:04 tube-rivo-audio kernel: Country code: US (US/0) Aug 17 22:09:04 tube-rivo-audio kernel: CONFIG-ERROR) dhd_conf_set_intiovar: txbf setting failed -23 Aug 17 22:09:04 tube-rivo-audio kernel: wl_android_wifi_on: Success Aug 17 22:09:04 tube-rivo-audio dhcpcd[2841]: wlan0: carrier acquired Aug 17 22:09:04 tube-rivo-audio kernel: dhd_open : the lock is released. Aug 17 22:09:04 tube-rivo-audio kernel: dhd_open: Exit ret=0 Aug 17 22:09:04 tube-rivo-audio dhcpcd[2841]: wlan0: carrier acquired Aug 17 22:09:04 tube-rivo-audio volumio-remote-updater[2843]: [2024-08-17 22:09:04] [info] asio async_connect error: system:111 (Connection refused) Aug 17 22:09:04 tube-rivo-audio volumio-remote-updater[2843]: [2024-08-17 22:09:04] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Aug 17 22:09:04 tube-rivo-audio volumio-remote-updater[2843]: [2024-08-17 22:09:04] [error] handle_connect error: Underlying Transport Error Aug 17 22:09:04 tube-rivo-audio dhcpcd[2841]: wlan0: IAID 0e:ab:c4:ba Aug 17 22:09:04 tube-rivo-audio dhcpcd[2841]: wlan0: carrier lost Aug 17 22:09:04 tube-rivo-audio dhcpcd[2841]: wlan0: IAID 0e:ab:c4:ba Aug 17 22:09:04 tube-rivo-audio dhcpcd[2841]: wlan0: carrier lost Aug 17 22:09:04 tube-rivo-audio sudo[3170]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 17 22:09:04 tube-rivo-audio sudo[3170]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 22:09:04 tube-rivo-audio sudo[3170]: pam_unix(sudo:session): session closed for user root Aug 17 22:09:04 tube-rivo-audio kernel: P2P interface registered Aug 17 22:09:04 tube-rivo-audio kernel: wl_cfgp2p_add_p2p_disc_if: wdev: ffffffc04ac33400, wdev->net: (null) Aug 17 22:09:04 tube-rivo-audio kernel: [35B blob data] Aug 17 22:09:04 tube-rivo-audio kernel: P2P interface started Aug 17 22:09:04 tube-rivo-audio systemd[1]: systemd-rfkill.service: Succeeded. Aug 17 22:09:05 tube-rivo-audio wireless.js[2837]: trying... Aug 17 22:09:05 tube-rivo-audio sudo[3185]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 17 22:09:05 tube-rivo-audio sudo[3185]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 22:09:05 tube-rivo-audio sudo[3185]: pam_unix(sudo:session): session closed for user root Aug 17 22:09:05 tube-rivo-audio sh[2773]: eth0: leased 192.168.1.36 for 604800 seconds Aug 17 22:09:05 tube-rivo-audio sh[2773]: eth0: adding route to 192.168.1.0/24 Aug 17 22:09:05 tube-rivo-audio sh[2773]: eth0: adding default route via 192.168.1.1 Aug 17 22:09:05 tube-rivo-audio dhcpcd[2821]: eth0: leased 192.168.1.36 for 604800 seconds Aug 17 22:09:05 tube-rivo-audio avahi-daemon[2839]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.1.36. Aug 17 22:09:05 tube-rivo-audio dhcpcd[2821]: eth0: adding route to 192.168.1.0/24 Aug 17 22:09:05 tube-rivo-audio dhcpcd[2821]: eth0: adding default route via 192.168.1.1 Aug 17 22:09:05 tube-rivo-audio avahi-daemon[2839]: New relevant interface eth0.IPv4 for mDNS. Aug 17 22:09:05 tube-rivo-audio avahi-daemon[2839]: Registering new address record for 192.168.1.36 on eth0.IPv4. Aug 17 22:09:06 tube-rivo-audio ntpd[3058]: ntpd exiting on signal 15 (Terminated) Aug 17 22:09:06 tube-rivo-audio systemd[1]: Stopping Network Time Service... Aug 17 22:09:06 tube-rivo-audio systemd[1]: ntp.service: Succeeded. Aug 17 22:09:06 tube-rivo-audio systemd[1]: Stopped Network Time Service. Aug 17 22:09:06 tube-rivo-audio systemd[1]: Starting Network Time Service... Aug 17 22:09:06 tube-rivo-audio wireless.js[2837]: trying... Aug 17 22:09:06 tube-rivo-audio sudo[3225]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 17 22:09:06 tube-rivo-audio sudo[3225]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 22:09:06 tube-rivo-audio ntpd[3220]: ntpd 4.2.8p12@1.3728-o (1): Starting Aug 17 22:09:06 tube-rivo-audio ntpd[3220]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Aug 17 22:09:06 tube-rivo-audio systemd[1]: Started Network Time Service. Aug 17 22:09:06 tube-rivo-audio sh[2773]: forked to background, child pid 3230 Aug 17 22:09:06 tube-rivo-audio dhcpcd[2821]: forked to background, child pid 3230 Aug 17 22:09:06 tube-rivo-audio sudo[3225]: pam_unix(sudo:session): session closed for user root Aug 17 22:09:06 tube-rivo-audio ntpd[3229]: proto: precision = 1.208 usec (-20) Aug 17 22:09:06 tube-rivo-audio ntpd[3229]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Aug 17 22:09:06 tube-rivo-audio ntpd[3229]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Aug 17 22:09:06 tube-rivo-audio ntpd[3229]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 599 days ago Aug 17 22:09:06 tube-rivo-audio ntpd[3229]: Listen and drop on 0 v6wildcard [::]:123 Aug 17 22:09:06 tube-rivo-audio ntpd[3229]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Aug 17 22:09:06 tube-rivo-audio ntpd[3229]: Listen normally on 2 lo 127.0.0.1:123 Aug 17 22:09:06 tube-rivo-audio ntpd[3229]: Listen normally on 3 eth0 192.168.1.36:123 Aug 17 22:09:06 tube-rivo-audio ntpd[3229]: Listening on routing socket on fd #20 for interface updates Aug 17 22:09:06 tube-rivo-audio ntpd[3229]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Aug 17 22:09:06 tube-rivo-audio ntpd[3229]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Aug 17 22:09:06 tube-rivo-audio ifplugd(eth0)[3090]: client: ifup: interface eth0 already configured Aug 17 22:09:06 tube-rivo-audio sh[2773]: eth0=eth0 Aug 17 22:09:06 tube-rivo-audio kernel: usb 1-1.1: USB disconnect, device number 3 Aug 17 22:09:06 tube-rivo-audio ifplugd(eth0)[3090]: Program executed successfully. Aug 17 22:09:06 tube-rivo-audio wpa_supplicant[3183]: wlan0: Trying to associate with 40:ae:30:11:1d:f9 (SSID='Audio_Wifi' freq=2437 MHz) Aug 17 22:09:06 tube-rivo-audio kernel: Connecting with 40:ae:30:11:1d:f9 ssid "Audio_Wifi", len (10) channel=6 Aug 17 22:09:06 tube-rivo-audio kernel: dhd_dbg_start_pkt_monitor, 1724 Aug 17 22:09:06 tube-rivo-audio kernel: wl_iw_event: Link UP with 40:ae:30:11:1d:f9 Aug 17 22:09:06 tube-rivo-audio kernel: wl_bss_connect_done succeeded with 40:ae:30:11:1d:f9 Aug 17 22:09:06 tube-rivo-audio kernel: CFG80211-ERROR) wl_cfg80211_scan_abort : scan abort failed Aug 17 22:09:06 tube-rivo-audio wpa_supplicant[3183]: wlan0: Associated with 40:ae:30:11:1d:f9 Aug 17 22:09:06 tube-rivo-audio wpa_supplicant[3183]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Aug 17 22:09:06 tube-rivo-audio kernel: wl_bss_connect_done succeeded with 40:ae:30:11:1d:f9 vndr_oui: 00-90-4C 00-0C-43 Aug 17 22:09:06 tube-rivo-audio wpa_supplicant[3183]: wlan0: WPA: Key negotiation completed with 40:ae:30:11:1d:f9 [PTK=CCMP GTK=CCMP] Aug 17 22:09:06 tube-rivo-audio wpa_supplicant[3183]: wlan0: CTRL-EVENT-CONNECTED - Connection to 40:ae:30:11:1d:f9 completed [id=0 id_str=] Aug 17 22:09:06 tube-rivo-audio dhcpcd[2841]: wlan0: carrier acquired Aug 17 22:09:06 tube-rivo-audio dhcpcd[2841]: wlan0: carrier acquired Aug 17 22:09:06 tube-rivo-audio dhcpcd[2841]: wlan0: IAID 0e:ab:c4:ba Aug 17 22:09:06 tube-rivo-audio dhcpcd[2841]: wlan0: IAID 0e:ab:c4:ba Aug 17 22:09:06 tube-rivo-audio dhcpcd[2841]: eth0: leased 192.168.1.36 for 604800 seconds Aug 17 22:09:06 tube-rivo-audio dhcpcd[2841]: eth0: leased 192.168.1.36 for 604800 seconds Aug 17 22:09:06 tube-rivo-audio dhcpcd[2841]: eth0: adding route to 192.168.1.0/24 Aug 17 22:09:06 tube-rivo-audio dhcpcd[2841]: eth0: adding default route via 192.168.1.1 Aug 17 22:09:06 tube-rivo-audio dhcpcd[2841]: eth0: adding route to 192.168.1.0/24 Aug 17 22:09:06 tube-rivo-audio dhcpcd[2841]: eth0: adding default route via 192.168.1.1 Aug 17 22:09:06 tube-rivo-audio ntpd[3229]: ntpd exiting on signal 15 (Terminated) Aug 17 22:09:06 tube-rivo-audio systemd[1]: Stopping Network Time Service... Aug 17 22:09:06 tube-rivo-audio systemd[1]: ntp.service: Succeeded. Aug 17 22:09:07 tube-rivo-audio systemd[1]: Stopped Network Time Service. Aug 17 22:09:07 tube-rivo-audio systemd[1]: Starting Network Time Service... Aug 17 22:09:07 tube-rivo-audio ntpd[3290]: ntpd 4.2.8p12@1.3728-o (1): Starting Aug 17 22:09:07 tube-rivo-audio ntpd[3290]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Aug 17 22:09:07 tube-rivo-audio systemd[1]: Started Network Time Service. Aug 17 22:09:07 tube-rivo-audio ntpd[3296]: proto: precision = 1.209 usec (-20) Aug 17 22:09:07 tube-rivo-audio dhcpcd[2841]: forked to background, child pid 3297 Aug 17 22:09:07 tube-rivo-audio dhcpcd[2841]: forked to background, child pid 3297 Aug 17 22:09:07 tube-rivo-audio ntpd[3296]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Aug 17 22:09:07 tube-rivo-audio dhcpcd[3297]: wlan0: soliciting an IPv6 router Aug 17 22:09:07 tube-rivo-audio systemd[1]: Started DHCP Client Daemon. Aug 17 22:09:07 tube-rivo-audio ntpd[3296]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Aug 17 22:09:07 tube-rivo-audio ntpd[3296]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 599 days ago Aug 17 22:09:07 tube-rivo-audio ntpd[3296]: Listen and drop on 0 v6wildcard [::]:123 Aug 17 22:09:07 tube-rivo-audio ntpd[3296]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Aug 17 22:09:07 tube-rivo-audio ntpd[3296]: Listen normally on 2 lo 127.0.0.1:123 Aug 17 22:09:07 tube-rivo-audio ntpd[3296]: Listen normally on 3 eth0 192.168.1.36:123 Aug 17 22:09:07 tube-rivo-audio ntpd[3296]: Listening on routing socket on fd #20 for interface updates Aug 17 22:09:07 tube-rivo-audio ntpd[3296]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Aug 17 22:09:07 tube-rivo-audio ntpd[3296]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Aug 17 22:09:07 tube-rivo-audio dhcpcd[3297]: wlan0: rebinding lease of 192.168.1.33 Aug 17 22:09:07 tube-rivo-audio wireless.js[2837]: trying... Aug 17 22:09:07 tube-rivo-audio sudo[3300]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 17 22:09:07 tube-rivo-audio sudo[3300]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 22:09:07 tube-rivo-audio sudo[3300]: pam_unix(sudo:session): session closed for user root Aug 17 22:09:07 tube-rivo-audio dhcpcd[3297]: wlan0: probing address 192.168.1.33/24 Aug 17 22:09:08 tube-rivo-audio ntpd[3296]: Soliciting pool server 203.114.74.17 Aug 17 22:09:08 tube-rivo-audio wireless.js[2837]: trying... Aug 17 22:09:08 tube-rivo-audio sudo[3303]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 17 22:09:08 tube-rivo-audio sudo[3303]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 22:09:08 tube-rivo-audio sudo[3303]: pam_unix(sudo:session): session closed for user root Aug 17 22:09:08 tube-rivo-audio kernel: meson_uart ffd24000.serial: ttyS1 use xtal(24M) 24000000 change 115200 to 2000000 Aug 17 22:09:08 tube-rivo-audio systemd[1]: Starting Bluetooth service... Aug 17 22:09:08 tube-rivo-audio systemd[1]: Starting Load/Save RF Kill Switch Status... Aug 17 22:09:08 tube-rivo-audio systemd[1]: Started Load/Save RF Kill Switch Status. Aug 17 22:09:08 tube-rivo-audio bluetoothd[3308]: Bluetooth daemon 5.50 Aug 17 22:09:08 tube-rivo-audio bluetoothd[3308]: Unknown key AutoConnectTimeout for group General in /etc/bluetooth/main.conf Aug 17 22:09:08 tube-rivo-audio systemd[1]: Started Bluetooth service. Aug 17 22:09:08 tube-rivo-audio systemd[1]: Reached target Bluetooth. Aug 17 22:09:08 tube-rivo-audio bluetoothd[3308]: Starting SDP server Aug 17 22:09:08 tube-rivo-audio bluetoothd[3308]: Excluding (cli) sap Aug 17 22:09:08 tube-rivo-audio bluetoothd[3308]: Bluetooth management interface 1.14 initialized Aug 17 22:09:08 tube-rivo-audio dbus-daemon[2845]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.5' (uid=0 pid=3308 comm="/usr/lib/bluetooth/bluetoothd --noplugin=sap " label="kernel") Aug 17 22:09:08 tube-rivo-audio systemd[1]: Starting Hostname Service... Aug 17 22:09:08 tube-rivo-audio kernel: IPVS: Creating netns size=1928 id=2 Aug 17 22:09:08 tube-rivo-audio dbus-daemon[2845]: [system] Successfully activated service 'org.freedesktop.hostname1' Aug 17 22:09:08 tube-rivo-audio systemd[1]: Started Hostname Service. Aug 17 22:09:09 tube-rivo-audio ntpd[3296]: Soliciting pool server 202.162.32.12 Aug 17 22:09:09 tube-rivo-audio ntpd[3296]: Soliciting pool server 116.12.47.30 Aug 17 22:09:09 tube-rivo-audio wireless.js[2837]: trying... Aug 17 22:09:09 tube-rivo-audio sudo[3316]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 17 22:09:09 tube-rivo-audio sudo[3316]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 22:09:09 tube-rivo-audio sudo[3316]: pam_unix(sudo:session): session closed for user root Aug 17 22:09:10 tube-rivo-audio ntpd[3296]: Soliciting pool server 103.169.192.230 Aug 17 22:09:10 tube-rivo-audio ntpd[3296]: Soliciting pool server 172.232.235.123 Aug 17 22:09:10 tube-rivo-audio ntpd[3296]: Soliciting pool server 202.65.114.202 Aug 17 22:09:10 tube-rivo-audio wireless.js[2837]: trying... Aug 17 22:09:10 tube-rivo-audio sudo[3319]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 17 22:09:10 tube-rivo-audio sudo[3319]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 22:09:10 tube-rivo-audio sudo[3319]: pam_unix(sudo:session): session closed for user root Aug 17 22:09:10 tube-rivo-audio nmbd[3064]: [2024/08/17 22:09:10.591456, 0] ../lib/util/become_daemon.c:138(daemon_ready) Aug 17 22:09:10 tube-rivo-audio kernel: nf_conntrack: default automatic helper assignment has been turned off for security reasons and CT-based firewall rule not found. Use the iptables CT target to attach helpers instead. Aug 17 22:09:10 tube-rivo-audio systemd[1]: Started Samba NMB Daemon. Aug 17 22:09:10 tube-rivo-audio nmbd[3064]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Aug 17 22:09:10 tube-rivo-audio systemd[1]: Starting Samba Winbind Daemon... Aug 17 22:09:10 tube-rivo-audio winbindd[3321]: [2024/08/17 22:09:10.942031, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Aug 17 22:09:10 tube-rivo-audio winbindd[3321]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Aug 17 22:09:10 tube-rivo-audio winbindd[3321]: [2024/08/17 22:09:10.954476, 0] ../lib/util/become_daemon.c:138(daemon_ready) Aug 17 22:09:10 tube-rivo-audio winbindd[3321]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Aug 17 22:09:10 tube-rivo-audio systemd[1]: Started Samba Winbind Daemon. Aug 17 22:09:10 tube-rivo-audio systemd[1]: Starting Samba SMB Daemon... Aug 17 22:09:11 tube-rivo-audio ntpd[3296]: Soliciting pool server 172.232.224.156 Aug 17 22:09:11 tube-rivo-audio ntpd[3296]: Soliciting pool server 103.177.8.14 Aug 17 22:09:11 tube-rivo-audio ntpd[3296]: Soliciting pool server 103.177.8.230 Aug 17 22:09:11 tube-rivo-audio ntpd[3296]: Soliciting pool server 103.17.182.30 Aug 17 22:09:11 tube-rivo-audio wireless.js[2837]: trying... Aug 17 22:09:11 tube-rivo-audio sudo[3328]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 17 22:09:11 tube-rivo-audio sudo[3328]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 22:09:11 tube-rivo-audio sudo[3328]: pam_unix(sudo:session): session closed for user root Aug 17 22:09:11 tube-rivo-audio winbindd[3321]: [2024/08/17 22:09:11.465953, 0] ../source3/winbindd/wb_lookupsids.c:659(wb_lookupsids_recv) Aug 17 22:09:11 tube-rivo-audio winbindd[3321]: res_names->count = 3, expected 4 Aug 17 22:09:11 tube-rivo-audio systemd[1]: Started Samba SMB Daemon. Aug 17 22:09:11 tube-rivo-audio smbd[3326]: [2024/08/17 22:09:11.493396, 0] ../lib/util/become_daemon.c:138(daemon_ready) Aug 17 22:09:11 tube-rivo-audio smbd[3326]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Aug 17 22:09:11 tube-rivo-audio volumio-remote-updater[2843]: [2024-08-17 22:09:11] [info] asio async_connect error: system:111 (Connection refused) Aug 17 22:09:11 tube-rivo-audio volumio-remote-updater[2843]: [2024-08-17 22:09:11] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Aug 17 22:09:11 tube-rivo-audio volumio-remote-updater[2843]: [2024-08-17 22:09:11] [error] handle_connect error: Underlying Transport Error Aug 17 22:09:12 tube-rivo-audio ntpd[3296]: Soliciting pool server 114.30.89.30 Aug 17 22:09:12 tube-rivo-audio ntpd[3296]: Soliciting pool server 14.102.153.110 Aug 17 22:09:12 tube-rivo-audio ntpd[3296]: Soliciting pool server 27.54.117.72 Aug 17 22:09:12 tube-rivo-audio wireless.js[2837]: trying... Aug 17 22:09:12 tube-rivo-audio sudo[3338]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 17 22:09:12 tube-rivo-audio sudo[3338]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 22:09:12 tube-rivo-audio sudo[3338]: pam_unix(sudo:session): session closed for user root Aug 17 22:09:12 tube-rivo-audio dhcpcd[3297]: wlan0: leased 192.168.1.33 for 604800 seconds Aug 17 22:09:12 tube-rivo-audio avahi-daemon[2839]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.33. Aug 17 22:09:12 tube-rivo-audio dhcpcd[3297]: wlan0: adding route to 192.168.1.0/24 Aug 17 22:09:12 tube-rivo-audio dhcpcd[3297]: wlan0: adding default route via 192.168.1.1 Aug 17 22:09:12 tube-rivo-audio avahi-daemon[2839]: New relevant interface wlan0.IPv4 for mDNS. Aug 17 22:09:12 tube-rivo-audio avahi-daemon[2839]: Registering new address record for 192.168.1.33 on wlan0.IPv4. Aug 17 22:09:12 tube-rivo-audio ntpd[3296]: ntpd exiting on signal 15 (Terminated) Aug 17 22:09:12 tube-rivo-audio systemd[1]: Stopping Network Time Service... Aug 17 22:09:12 tube-rivo-audio ntpd[3296]: 203.114.74.17 local addr 192.168.1.36 -> Aug 17 22:09:12 tube-rivo-audio ntpd[3296]: 116.12.47.30 local addr 192.168.1.36 -> Aug 17 22:09:12 tube-rivo-audio ntpd[3296]: 202.162.32.12 local addr 192.168.1.36 -> Aug 17 22:09:12 tube-rivo-audio ntpd[3296]: 172.232.235.123 local addr 192.168.1.36 -> Aug 17 22:09:12 tube-rivo-audio ntpd[3296]: 103.169.192.230 local addr 192.168.1.36 -> Aug 17 22:09:12 tube-rivo-audio ntpd[3296]: 202.65.114.202 local addr 192.168.1.36 -> Aug 17 22:09:12 tube-rivo-audio ntpd[3296]: 172.232.224.156 local addr 192.168.1.36 -> Aug 17 22:09:12 tube-rivo-audio ntpd[3296]: 103.177.8.230 local addr 192.168.1.36 -> Aug 17 22:09:12 tube-rivo-audio ntpd[3296]: 103.17.182.30 local addr 192.168.1.36 -> Aug 17 22:09:12 tube-rivo-audio ntpd[3296]: 103.177.8.14 local addr 192.168.1.36 -> Aug 17 22:09:12 tube-rivo-audio ntpd[3296]: 14.102.153.110 local addr 192.168.1.36 -> Aug 17 22:09:12 tube-rivo-audio ntpd[3296]: 27.54.117.72 local addr 192.168.1.36 -> Aug 17 22:09:12 tube-rivo-audio ntpd[3296]: 114.30.89.30 local addr 192.168.1.36 -> Aug 17 22:09:12 tube-rivo-audio systemd[1]: ntp.service: Succeeded. Aug 17 22:09:12 tube-rivo-audio systemd[1]: Stopped Network Time Service. Aug 17 22:09:12 tube-rivo-audio systemd[1]: Starting Network Time Service... Aug 17 22:09:12 tube-rivo-audio ntpd[3373]: ntpd 4.2.8p12@1.3728-o (1): Starting Aug 17 22:09:12 tube-rivo-audio ntpd[3373]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Aug 17 22:09:12 tube-rivo-audio systemd[1]: Started Network Time Service. Aug 17 22:09:12 tube-rivo-audio ntpd[3379]: proto: precision = 1.209 usec (-20) Aug 17 22:09:12 tube-rivo-audio ntpd[3379]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Aug 17 22:09:12 tube-rivo-audio ntpd[3379]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Aug 17 22:09:12 tube-rivo-audio ntpd[3379]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 599 days ago Aug 17 22:09:12 tube-rivo-audio ntpd[3379]: Listen and drop on 0 v6wildcard [::]:123 Aug 17 22:09:12 tube-rivo-audio ntpd[3379]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Aug 17 22:09:12 tube-rivo-audio ntpd[3379]: Listen normally on 2 lo 127.0.0.1:123 Aug 17 22:09:12 tube-rivo-audio ntpd[3379]: Listen normally on 3 eth0 192.168.1.36:123 Aug 17 22:09:12 tube-rivo-audio ntpd[3379]: Listen normally on 4 wlan0 192.168.1.33:123 Aug 17 22:09:12 tube-rivo-audio ntpd[3379]: Listening on routing socket on fd #21 for interface updates Aug 17 22:09:12 tube-rivo-audio ntpd[3379]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Aug 17 22:09:12 tube-rivo-audio ntpd[3379]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Aug 17 22:09:13 tube-rivo-audio wireless.js[2837]: trying... Aug 17 22:09:13 tube-rivo-audio sudo[3382]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 17 22:09:13 tube-rivo-audio sudo[3382]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 22:09:13 tube-rivo-audio sudo[3382]: pam_unix(sudo:session): session closed for user root Aug 17 22:09:13 tube-rivo-audio wireless.js[2837]: Connected to: ----Audio_Wifi Aug 17 22:09:13 tube-rivo-audio wireless.js[2837]: ---- Aug 17 22:09:13 tube-rivo-audio sudo[3385]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 17 22:09:13 tube-rivo-audio sudo[3385]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 22:09:13 tube-rivo-audio sudo[3385]: pam_unix(sudo:session): session closed for user root Aug 17 22:09:13 tube-rivo-audio wireless.js[2837]: ... joined AP, wlan0 IPv4 is 192.168.1.33, ipV6 is undefined Aug 17 22:09:13 tube-rivo-audio wireless.js[2837]: It's done! AP Aug 17 22:09:13 tube-rivo-audio systemd[1]: Started Wireless Services. Aug 17 22:09:13 tube-rivo-audio systemd[1]: Started Volumio Backend Module. Aug 17 22:09:13 tube-rivo-audio systemd[1]: Started Volumio Cpu Tweaker. Aug 17 22:09:13 tube-rivo-audio systemd[1]: Reached target Multi-User System. Aug 17 22:09:13 tube-rivo-audio systemd[1]: Reached target Graphical Interface. Aug 17 22:09:13 tube-rivo-audio systemd[1]: Starting Update UTMP about System Runlevel Changes... Aug 17 22:09:13 tube-rivo-audio systemd[1]: systemd-rfkill.service: Succeeded. Aug 17 22:09:13 tube-rivo-audio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Aug 17 22:09:13 tube-rivo-audio systemd[1]: Started Update UTMP about System Runlevel Changes. Aug 17 22:09:13 tube-rivo-audio systemd[1]: Startup finished in 12.819s (kernel) + 20.350s (userspace) = 33.169s. Aug 17 22:09:13 tube-rivo-audio volumio-cpu-tweak[3392]: Setting RT Priority for mpd Aug 17 22:09:13 tube-rivo-audio volumio-cpu-tweak[3392]: chrt: cannot obtain the list of tasks: No such file or directory Aug 17 22:09:13 tube-rivo-audio volumio-cpu-tweak[3392]: Setting MPD Affinity Aug 17 22:09:13 tube-rivo-audio volumio-cpu-tweak[3392]: pid 3's current affinity mask: 1 Aug 17 22:09:13 tube-rivo-audio volumio-cpu-tweak[3392]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input Aug 17 22:09:13 tube-rivo-audio volumio-cpu-tweak[3392]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance Aug 17 22:09:13 tube-rivo-audio systemd[1]: volumio_cpu_tweak.service: Succeeded. Aug 17 22:09:13 tube-rivo-audio ntpd[3379]: Soliciting pool server 203.114.74.17 Aug 17 22:09:14 tube-rivo-audio ntpd[3379]: Soliciting pool server 202.162.32.12 Aug 17 22:09:14 tube-rivo-audio ntpd[3379]: Soliciting pool server 27.54.117.72 Aug 17 22:09:15 tube-rivo-audio ntpd[3379]: Soliciting pool server 103.177.8.14 Aug 17 22:09:15 tube-rivo-audio ntpd[3379]: Soliciting pool server 172.232.235.123 Aug 17 22:09:15 tube-rivo-audio ntpd[3379]: Soliciting pool server 116.12.46.30 Aug 17 22:09:16 tube-rivo-audio volumio[3391]: info: ------------------------------------------- Aug 17 22:09:16 tube-rivo-audio volumio[3391]: info: ----- Volumio3 ---- Aug 17 22:09:16 tube-rivo-audio volumio[3391]: info: ------------------------------------------- Aug 17 22:09:16 tube-rivo-audio volumio[3391]: info: ----- System startup ---- Aug 17 22:09:16 tube-rivo-audio volumio[3391]: info: ------------------------------------------- Aug 17 22:09:16 tube-rivo-audio ntpd[3379]: Soliciting pool server 116.12.47.30 Aug 17 22:09:16 tube-rivo-audio ntpd[3379]: Soliciting pool server 103.169.192.230 Aug 17 22:09:16 tube-rivo-audio ntpd[3379]: Soliciting pool server 103.177.8.230 Aug 17 22:09:16 tube-rivo-audio ntpd[3379]: Soliciting pool server 103.169.192.229 Aug 17 22:09:17 tube-rivo-audio volumio[3391]: info: MYVOLUMIO Environment detected Aug 17 22:09:17 tube-rivo-audio ntpd[3379]: Soliciting pool server 103.134.77.146 Aug 17 22:09:17 tube-rivo-audio ntpd[3379]: Soliciting pool server 103.17.182.30 Aug 17 22:09:17 tube-rivo-audio volumio[3391]: info: Plugin folders cleanup Aug 17 22:09:17 tube-rivo-audio volumio[3391]: info: Scanning into folder /volumio/app/plugins/ Aug 17 22:09:17 tube-rivo-audio volumio[3391]: info: Scanning category audio_interface Aug 17 22:09:17 tube-rivo-audio volumio[3391]: info: Scanning category miscellanea Aug 17 22:09:17 tube-rivo-audio volumio[3391]: info: Scanning category music_service Aug 17 22:09:17 tube-rivo-audio volumio[3391]: info: Scanning category plugins.json Aug 17 22:09:17 tube-rivo-audio volumio[3391]: info: Scanning category system_controller Aug 17 22:09:17 tube-rivo-audio volumio[3391]: info: Scanning category user_interface Aug 17 22:09:17 tube-rivo-audio volumio[3391]: info: Scanning into folder /data/plugins/ Aug 17 22:09:17 tube-rivo-audio volumio[3391]: info: Scanning category audio_interface Aug 17 22:09:17 tube-rivo-audio volumio[3391]: info: Plugin folders cleanup completed Aug 17 22:09:17 tube-rivo-audio volumio[3391]: info: ------------------------------------------- Aug 17 22:09:17 tube-rivo-audio volumio[3391]: info: ----- Core plugins startup ---- Aug 17 22:09:17 tube-rivo-audio volumio[3391]: info: ------------------------------------------- Aug 17 22:09:17 tube-rivo-audio volumio[3391]: info: Loading plugins from folder /volumio/app/plugins/ Aug 17 22:09:17 tube-rivo-audio volumio[3391]: info: Adding plugin bluetooth to MyMusic Plugins Aug 17 22:09:17 tube-rivo-audio volumio[3391]: info: Adding plugin multiroom to MyMusic Plugins Aug 17 22:09:17 tube-rivo-audio volumio[3391]: info: Adding plugin upnp to MyMusic Plugins Aug 17 22:09:17 tube-rivo-audio volumio[3391]: info: Adding plugin metavolumio to MyMusic Plugins Aug 17 22:09:17 tube-rivo-audio volumio[3391]: info: Adding plugin airplay_emulation to MyMusic Plugins Aug 17 22:09:17 tube-rivo-audio volumio[3391]: info: Adding plugin cd_controller to MyMusic Plugins Aug 17 22:09:17 tube-rivo-audio volumio[3391]: info: Adding plugin raat to MyMusic Plugins Aug 17 22:09:17 tube-rivo-audio volumio[3391]: info: Adding plugin smart_inputs to MyMusic Plugins Aug 17 22:09:17 tube-rivo-audio volumio[3391]: info: Adding plugin tidalconnect to MyMusic Plugins Aug 17 22:09:17 tube-rivo-audio volumio[3391]: info: Adding plugin upnp_browser to MyMusic Plugins Aug 17 22:09:17 tube-rivo-audio volumio[3391]: info: Loading plugins from folder /data/plugins/ Aug 17 22:09:17 tube-rivo-audio volumio[3391]: info: Loading plugin "system"... Aug 17 22:09:17 tube-rivo-audio volumio[3391]: info: Loading plugin "appearance"... Aug 17 22:09:18 tube-rivo-audio ntpd[3379]: Soliciting pool server 114.30.89.30 Aug 17 22:09:18 tube-rivo-audio ntpd[3379]: Soliciting pool server 119.110.74.101 Aug 17 22:09:19 tube-rivo-audio volumio[3391]: info: Loading plugin "network"... Aug 17 22:09:19 tube-rivo-audio volumio[3391]: info: Refreshing Cached IP Addresses Aug 17 22:09:19 tube-rivo-audio sudo[3423]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 17 22:09:19 tube-rivo-audio sudo[3423]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 22:09:19 tube-rivo-audio volumio[3391]: info: Loading plugin "services"... Aug 17 22:09:19 tube-rivo-audio sudo[3425]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 17 22:09:19 tube-rivo-audio sudo[3425]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 22:09:19 tube-rivo-audio sudo[3423]: pam_unix(sudo:session): session closed for user root Aug 17 22:09:19 tube-rivo-audio volumio[3391]: info: Loading plugin "alsa_controller"... Aug 17 22:09:19 tube-rivo-audio sudo[3425]: pam_unix(sudo:session): session closed for user root Aug 17 22:09:19 tube-rivo-audio sudo[3428]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Aug 17 22:09:19 tube-rivo-audio sudo[3428]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 22:09:19 tube-rivo-audio kernel: wl_escan_set_scan: ioctl_ver=2 Aug 17 22:09:19 tube-rivo-audio kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04e9e2000 drv_status 0x0 e_type 69 e_states 8 Aug 17 22:09:19 tube-rivo-audio kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04e9e2000 drv_status 0x0 e_type 69 e_states 8 Aug 17 22:09:19 tube-rivo-audio kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04e9e2000 drv_status 0x0 e_type 69 e_states 8 Aug 17 22:09:19 tube-rivo-audio kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04e9e2000 drv_status 0x0 e_type 69 e_states 8 Aug 17 22:09:19 tube-rivo-audio kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04e9e2000 drv_status 0x0 e_type 69 e_states 8 Aug 17 22:09:19 tube-rivo-audio kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04e9e2000 drv_status 0x0 e_type 69 e_states 8 Aug 17 22:09:19 tube-rivo-audio kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04e9e2000 drv_status 0x0 e_type 69 e_states 8 Aug 17 22:09:19 tube-rivo-audio ntpd[3379]: Soliciting pool server 2001:df0:3140:fac1:b090:12:1980:c01 Aug 17 22:09:19 tube-rivo-audio kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04e9e2000 drv_status 0x0 e_type 69 e_states 8 Aug 17 22:09:19 tube-rivo-audio kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04e9e2000 drv_status 0x0 e_type 69 e_states 8 Aug 17 22:09:19 tube-rivo-audio kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04e9e2000 drv_status 0x0 e_type 69 e_states 8 Aug 17 22:09:19 tube-rivo-audio kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04e9e2000 drv_status 0x0 e_type 69 e_states 8 Aug 17 22:09:19 tube-rivo-audio volumio[3391]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 17 22:09:19 tube-rivo-audio volumio[3391]: info: Loading plugin "wizard"... Aug 17 22:09:19 tube-rivo-audio kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04e9e2000 drv_status 0x0 e_type 69 e_states 8 Aug 17 22:09:19 tube-rivo-audio volumio[3391]: info: Loading plugin "networkfs"... Aug 17 22:09:19 tube-rivo-audio kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04e9e2000 drv_status 0x0 e_type 69 e_states 8 Aug 17 22:09:19 tube-rivo-audio kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04e9e2000 drv_status 0x0 e_type 69 e_states 8 Aug 17 22:09:19 tube-rivo-audio kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04e9e2000 drv_status 0x0 e_type 69 e_states 8 Aug 17 22:09:19 tube-rivo-audio volumio[3391]: info: Starting Udev Watcher for removable devices Aug 17 22:09:19 tube-rivo-audio kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04e9e2000 drv_status 0x0 e_type 69 e_states 8 Aug 17 22:09:19 tube-rivo-audio volumio[3391]: info: Ignoring mount for partition: BOOT Aug 17 22:09:19 tube-rivo-audio volumio[3391]: info: Ignoring mount for partition: volumio Aug 17 22:09:19 tube-rivo-audio volumio[3391]: info: Ignoring mount for partition: volumio_data Aug 17 22:09:19 tube-rivo-audio volumio[3391]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 17 22:09:19 tube-rivo-audio volumio[3391]: info: Loading plugin "volumio_command_line_client"... Aug 17 22:09:19 tube-rivo-audio volumio[3391]: info: Plugin upnp is not enabled Aug 17 22:09:19 tube-rivo-audio volumio[3391]: info: Loading plugin "my_music"... Aug 17 22:09:19 tube-rivo-audio volumio[3391]: info: Loading plugin "mpd"... Aug 17 22:09:20 tube-rivo-audio kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04e9e2000 drv_status 0x0 e_type 69 e_states 8 Aug 17 22:09:20 tube-rivo-audio kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04e9e2000 drv_status 0x0 e_type 69 e_states 8 Aug 17 22:09:20 tube-rivo-audio kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04e9e2000 drv_status 0x0 e_type 69 e_states 8 Aug 17 22:09:20 tube-rivo-audio kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04e9e2000 drv_status 0x0 e_type 69 e_states 8 Aug 17 22:09:20 tube-rivo-audio kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04e9e2000 drv_status 0x0 e_type 69 e_states 8 Aug 17 22:09:20 tube-rivo-audio kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04e9e2000 drv_status 0x0 e_type 69 e_states 8 Aug 17 22:09:20 tube-rivo-audio volumio[3391]: info: Plugin upnp_browser is not enabled Aug 17 22:09:20 tube-rivo-audio volumio[3391]: info: Loading plugin "bluetooth"... Aug 17 22:09:20 tube-rivo-audio kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04e9e2000 drv_status 0x0 e_type 69 e_states 8 Aug 17 22:09:20 tube-rivo-audio volumio[3391]: info: [1723907360755] Starting BluetoothController Aug 17 22:09:20 tube-rivo-audio volumio[3391]: info: Loading plugin "alarm-clock"... Aug 17 22:09:20 tube-rivo-audio kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04e9e2000 drv_status 0x0 e_type 69 e_states 8 Aug 17 22:09:21 tube-rivo-audio kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04e9e2000 drv_status 0x0 e_type 69 e_states 8 Aug 17 22:09:21 tube-rivo-audio volumio[3391]: info: Loading plugin "manifestui"... Aug 17 22:09:21 tube-rivo-audio kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04e9e2000 drv_status 0x0 e_type 69 e_states 8 Aug 17 22:09:21 tube-rivo-audio volumio[3391]: info: Loading plugin "metavolumio"... Aug 17 22:09:21 tube-rivo-audio kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04e9e2000 drv_status 0x0 e_type 69 e_states 8 Aug 17 22:09:21 tube-rivo-audio kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04e9e2000 drv_status 0x0 e_type 69 e_states 8 Aug 17 22:09:43 tube-rivo-audio ntpd[3379]: receive: Unexpected origin timestamp 0xea6b3ba1.bfcc324f does not match aorg 0000000000.00000000 from server@103.169.192.230 xmt 0xea6b3bb7.e8d2114f Aug 17 22:09:43 tube-rivo-audio ntpd[3379]: receive: Unexpected origin timestamp 0xea6b3ba1.bfc9e1d7 does not match aorg 0000000000.00000000 from server@103.169.192.229 xmt 0xea6b3bb7.e8c71739 Aug 17 22:09:43 tube-rivo-audio ntpd[3379]: receive: Unexpected origin timestamp 0xea6b3ba1.bfd0b462 does not match aorg 0000000000.00000000 from server@103.177.8.14 xmt 0xea6b3bb7.ee8527c9 Aug 17 22:09:43 tube-rivo-audio ntpd[3379]: receive: Unexpected origin timestamp 0xea6b3ba1.bfbe86df does not match aorg 0000000000.00000000 from server@114.30.89.30 xmt 0xea6b3bb7.ec9446d2 Aug 17 22:09:44 tube-rivo-audio volumio-remote-updater[2843]: [2024-08-17 22:09:44] [connect] Successful connection Aug 17 22:09:44 tube-rivo-audio kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04e9e2000 drv_status 0x0 e_type 69 e_states 8 Aug 17 22:09:45 tube-rivo-audio kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04e9e2000 drv_status 0x0 e_type 69 e_states 8 Aug 17 22:09:45 tube-rivo-audio kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04e9e2000 drv_status 0x0 e_type 69 e_states 8 Aug 17 22:09:45 tube-rivo-audio volumio[3391]: info: Plugin airplay_emulation is not enabled Aug 17 22:09:45 tube-rivo-audio volumio[3391]: info: Plugin cd_controller is not enabled Aug 17 22:09:45 tube-rivo-audio volumio[3391]: info: Loading plugin "last_100"... Aug 17 22:09:45 tube-rivo-audio volumio[3391]: info: Plugin raat is not enabled Aug 17 22:09:45 tube-rivo-audio volumio[3391]: info: Loading plugin "streaming_services"... Aug 17 22:09:45 tube-rivo-audio kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04e9e2000 drv_status 0x0 e_type 69 e_states 8 Aug 17 22:09:45 tube-rivo-audio kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04e9e2000 drv_status 0x0 e_type 69 e_states 8 Aug 17 22:09:46 tube-rivo-audio kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04e9e2000 drv_status 0x0 e_type 69 e_states 0 Aug 17 22:09:46 tube-rivo-audio sudo[3428]: pam_unix(sudo:session): session closed for user root Aug 17 22:09:46 tube-rivo-audio volumio[3391]: info: Starting Streaming Service Transparent Proxy Aug 17 22:09:46 tube-rivo-audio volumio[3391]: info: Loading plugin "tidalconnect"... Aug 17 22:09:47 tube-rivo-audio volumio[3391]: info: Loading plugin "webradio"... Aug 17 22:09:47 tube-rivo-audio volumio[3391]: info: Loading plugin "i2s_dacs"... Aug 17 22:09:47 tube-rivo-audio volumio[3391]: info: I2S DAC not set, start Auto-detection Aug 17 22:09:47 tube-rivo-audio volumio[3391]: info: Loading plugin "volumiodiscovery"... Aug 17 22:09:47 tube-rivo-audio volumio[3391]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Aug 17 22:09:47 tube-rivo-audio volumio[3391]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 17 22:09:47 tube-rivo-audio node[3391]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Aug 17 22:09:47 tube-rivo-audio volumio[3391]: *** WARNING *** For more information see Aug 17 22:09:47 tube-rivo-audio volumio[3391]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Aug 17 22:09:47 tube-rivo-audio volumio[3391]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 17 22:09:47 tube-rivo-audio volumio[3391]: *** WARNING *** For more information see Aug 17 22:09:47 tube-rivo-audio node[3391]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 17 22:09:47 tube-rivo-audio node[3391]: *** WARNING *** For more information see Aug 17 22:09:47 tube-rivo-audio node[3391]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Aug 17 22:09:47 tube-rivo-audio node[3391]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 17 22:09:47 tube-rivo-audio node[3391]: *** WARNING *** For more information see Aug 17 22:09:47 tube-rivo-audio volumio[3391]: info: Discovery: Started advertising with name: Tube Rivo Audio Aug 17 22:09:47 tube-rivo-audio volumio[3391]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 17 22:09:47 tube-rivo-audio volumio[3391]: info: Plugin multiroom is not enabled Aug 17 22:09:47 tube-rivo-audio volumio[3391]: info: Loading plugin "outputs"... Aug 17 22:09:47 tube-rivo-audio volumio[3391]: info: Loading plugin "albumart"... Aug 17 22:09:47 tube-rivo-audio volumio[3391]: info: Plugin example_plugin is not enabled Aug 17 22:09:47 tube-rivo-audio volumio[3391]: info: Loading plugin "hi_res_audio"... Aug 17 22:09:48 tube-rivo-audio volumio[3391]: Forking 3 albumart workers Aug 17 22:09:48 tube-rivo-audio volumio[3391]: STREAMING PROXY: Starting server on port 3245 Aug 17 22:09:48 tube-rivo-audio volumio[3391]: Node JS runtime: 14 Aug 17 22:09:48 tube-rivo-audio systemd[1]: systemd-fsckd.service: Succeeded. Aug 17 22:09:49 tube-rivo-audio volumio[3391]: Starting albumart workers Aug 17 22:09:49 tube-rivo-audio volumio[3391]: Starting albumart workers Aug 17 22:09:49 tube-rivo-audio volumio[3391]: Starting albumart workers Aug 17 22:09:49 tube-rivo-audio volumio[3391]: info: Applying required configuration parameters for plugin hi_res_audio Aug 17 22:09:49 tube-rivo-audio volumio[3391]: info: Loading plugin "inputs"... Aug 17 22:09:50 tube-rivo-audio volumio[3391]: info: Loading plugin "qobuz"... Aug 17 22:09:52 tube-rivo-audio volumio[3391]: info: Plugin smart_inputs is not enabled Aug 17 22:09:52 tube-rivo-audio volumio[3391]: info: Loading plugin "tidal"... Aug 17 22:09:54 tube-rivo-audio volumio[3391]: info: Loading plugin "rivocontrol"... Aug 17 22:09:54 tube-rivo-audio volumio[3391]: info: Adding this device properties Aug 17 22:09:54 tube-rivo-audio volumio[3391]: info: CoreCommandRouter::executeOnPlugin: system , setThisDeviceVolumioProperties Aug 17 22:09:54 tube-rivo-audio volumio[3391]: info: Setting Additional Device Volumio Properties: [object Object] Aug 17 22:09:54 tube-rivo-audio volumio[3391]: info: Loading plugin "updater_comm"... Aug 17 22:09:54 tube-rivo-audio volumio[3391]: info: Loading plugin "cec_controller"... Aug 17 22:09:55 tube-rivo-audio volumio[3391]: info: Applying required configuration parameters for plugin cec_controller Aug 17 22:09:55 tube-rivo-audio volumio[3391]: info: Plugin mpdemulation is not enabled Aug 17 22:09:55 tube-rivo-audio volumio[3391]: info: Loading plugin "rest_api"... Aug 17 22:09:55 tube-rivo-audio volumio[3391]: info: Loading plugin "websocket"... Aug 17 22:09:55 tube-rivo-audio volumio[3391]: info: Starting Socket.io Server version 2.3.0 Aug 17 22:09:55 tube-rivo-audio volumio[3391]: info: Loading plugin "fusiondsp"... Aug 17 22:09:55 tube-rivo-audio volumio[3391]: info: Applying required configuration parameters for plugin fusiondsp Aug 17 22:09:55 tube-rivo-audio volumio[3391]: info: Loading i18n strings for locale en Aug 17 22:09:55 tube-rivo-audio volumio[3391]: Updating browse sources language Aug 17 22:09:55 tube-rivo-audio volumio[3391]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 17 22:09:56 tube-rivo-audio volumio[3391]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 17 22:09:56 tube-rivo-audio volumio[3391]: info: CoreCommandRouter::initPlayerControls Aug 17 22:09:56 tube-rivo-audio volumio[3391]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 22:09:56 tube-rivo-audio volumio[3391]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 22:09:56 tube-rivo-audio volumio[3391]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 22:09:56 tube-rivo-audio volumio[3391]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 22:09:56 tube-rivo-audio volumio[3391]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 22:09:56 tube-rivo-audio volumio[3391]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 22:09:56 tube-rivo-audio volumio[3391]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 22:09:56 tube-rivo-audio volumio[3391]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 22:09:56 tube-rivo-audio volumio[3391]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 17 22:09:56 tube-rivo-audio volumio[3391]: Express server listening on port 3000 Aug 17 22:09:56 tube-rivo-audio volumio[3391]: [Metrics] WebUI: 18s 594.37ms Aug 17 22:09:56 tube-rivo-audio volumio[3391]: info: CoreStateMachine::resetVolumioState Aug 17 22:09:56 tube-rivo-audio volumio[3391]: info: CoreStateMachine::getcurrentVolume Aug 17 22:09:56 tube-rivo-audio volumio[3391]: info: CoreCommandRouter::volumioRetrievevolume Aug 17 22:09:56 tube-rivo-audio volumio[3391]: info: CoreStateMachine::pushState Aug 17 22:09:56 tube-rivo-audio volumio[3391]: info: CorePlayQueue::getTrack 0 Aug 17 22:09:56 tube-rivo-audio volumio[3391]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 17 22:09:56 tube-rivo-audio volumio[3391]: info: CoreCommandRouter::volumioPushState Aug 17 22:09:56 tube-rivo-audio volumio[3391]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 17 22:09:56 tube-rivo-audio volumio[3391]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Aug 17 22:09:56 tube-rivo-audio volumio[3391]: info: Completed loading Core Plugins Aug 17 22:09:56 tube-rivo-audio volumio[3391]: info: Preparing to generate the ALSA configuration file Aug 17 22:09:56 tube-rivo-audio volumio[3391]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Aug 17 22:09:56 tube-rivo-audio volumio[3391]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Aug 17 22:09:56 tube-rivo-audio volumio[3391]: info: Reading ALSA contributions from plugins. Aug 17 22:09:56 tube-rivo-audio volumio[3391]: info: Reloading queue from file Aug 17 22:09:56 tube-rivo-audio volumio[3391]: info: CoreStateMachine::setRepeat false single undefined Aug 17 22:09:56 tube-rivo-audio volumio[3391]: info: CoreStateMachine::pushState Aug 17 22:09:56 tube-rivo-audio volumio[3391]: info: CorePlayQueue::getTrack 0 Aug 17 22:09:56 tube-rivo-audio volumio[3391]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 17 22:09:56 tube-rivo-audio volumio[3391]: info: CoreCommandRouter::volumioPushState Aug 17 22:09:56 tube-rivo-audio volumio[3391]: info: CoreStateMachine::setRandom false Aug 17 22:09:56 tube-rivo-audio volumio[3391]: info: CoreStateMachine::pushState Aug 17 22:09:56 tube-rivo-audio volumio[3391]: info: CorePlayQueue::getTrack 0 Aug 17 22:09:56 tube-rivo-audio volumio[3391]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 17 22:09:56 tube-rivo-audio volumio[3391]: info: CoreCommandRouter::volumioPushState Aug 17 22:09:56 tube-rivo-audio volumio[3391]: info: Asound.conf file unchanged, so no further update is needed Aug 17 22:09:56 tube-rivo-audio volumio[3391]: info: Output device has changed, restarting MPD Aug 17 22:09:56 tube-rivo-audio sudo[3513]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 17 22:09:56 tube-rivo-audio sudo[3513]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 22:09:56 tube-rivo-audio volumio[3391]: info: ___________ START PLUGINS ___________ Aug 17 22:09:56 tube-rivo-audio sudo[3513]: pam_unix(sudo:session): session closed for user root Aug 17 22:09:56 tube-rivo-audio volumio[3391]: info: ControllerMpd::onStart: Initializing MPD Aug 17 22:09:56 tube-rivo-audio volumio[3391]: info: Creating MPD Configuration file Aug 17 22:09:56 tube-rivo-audio sudo[3516]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 17 22:09:56 tube-rivo-audio sudo[3516]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 22:09:56 tube-rivo-audio sudo[3519]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 17 22:09:56 tube-rivo-audio sudo[3519]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 22:09:56 tube-rivo-audio volumio[3391]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 17 22:09:56 tube-rivo-audio sudo[3519]: pam_unix(sudo:session): session closed for user root Aug 17 22:09:56 tube-rivo-audio systemd[1]: Listening on mpd.socket. Aug 17 22:09:56 tube-rivo-audio systemd[1]: Starting Music Player Daemon... Aug 17 22:09:56 tube-rivo-audio sudo[3521]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 17 22:09:56 tube-rivo-audio sudo[3521]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 22:09:56 tube-rivo-audio volumio[3391]: info: Adding METAVOLUMIO REST API Endpoints Aug 17 22:09:56 tube-rivo-audio volumio[3391]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Aug 17 22:09:56 tube-rivo-audio volumio[3391]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio Aug 17 22:09:56 tube-rivo-audio volumio[3391]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio Aug 17 22:09:56 tube-rivo-audio volumio[3391]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio Aug 17 22:09:56 tube-rivo-audio volumio[3391]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 17 22:09:56 tube-rivo-audio volumio[3391]: info: [1723907396701] CoreMusicLibrary::Adding element Last_100 Aug 17 22:09:56 tube-rivo-audio volumio[3391]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 17 22:09:56 tube-rivo-audio volumio[3391]: info: Streaming services startup Aug 17 22:09:56 tube-rivo-audio volumio[3391]: info: Starting Streaming Daemon Aug 17 22:09:56 tube-rivo-audio sudo[3533]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/hciconfig hci0 name Tube Rivo Audio Aug 17 22:09:56 tube-rivo-audio sudo[3533]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 22:09:56 tube-rivo-audio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Aug 17 22:09:56 tube-rivo-audio systemd[1]: mpd.service: Succeeded. Aug 17 22:09:56 tube-rivo-audio sudo[3533]: pam_unix(sudo:session): session closed for user root Aug 17 22:09:56 tube-rivo-audio systemd[1]: Stopped Music Player Daemon. Aug 17 22:09:56 tube-rivo-audio systemd[1]: Starting Music Player Daemon... Aug 17 22:09:56 tube-rivo-audio sudo[3536]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Aug 17 22:09:56 tube-rivo-audio sudo[3536]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 22:09:56 tube-rivo-audio sudo[3536]: pam_unix(sudo:session): session closed for user root Aug 17 22:09:56 tube-rivo-audio volumio[3391]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 17 22:09:56 tube-rivo-audio volumio[3391]: info: [1723907396823] CoreMusicLibrary::Adding element Webradio Aug 17 22:09:56 tube-rivo-audio volumio[3391]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 17 22:09:56 tube-rivo-audio volumio[3391]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 17 22:09:56 tube-rivo-audio volumio[3391]: info: Initializing BBC Radios Aug 17 22:09:56 tube-rivo-audio sudo[3545]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Aug 17 22:09:56 tube-rivo-audio sudo[3545]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 22:09:56 tube-rivo-audio sudo[3545]: pam_unix(sudo:session): session closed for user root Aug 17 22:09:56 tube-rivo-audio sudo[3537]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 17 22:09:56 tube-rivo-audio sudo[3537]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 22:09:56 tube-rivo-audio sudo[3537]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Aug 17 22:09:56 tube-rivo-audio sudo[3537]: pam_unix(sudo:session): session closed for user root Aug 17 22:09:56 tube-rivo-audio volumio[3391]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 17 22:09:56 tube-rivo-audio volumio[3391]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 17 22:09:56 tube-rivo-audio volumio[3391]: error: Hi Res Audio Failed Login: Missing Login Data Aug 17 22:09:56 tube-rivo-audio volumio[3391]: info: Adding HIGHRESAUDIO REST API Endpoints Aug 17 22:09:56 tube-rivo-audio volumio[3391]: info: Adding getStreamUrlhi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Aug 17 22:09:56 tube-rivo-audio volumio[3391]: info: Initializing Serial Communication on port /dev/ttyS3 Aug 17 22:09:56 tube-rivo-audio volumio[3391]: info: Touch Event Listener Process Starting Aug 17 22:09:56 tube-rivo-audio kernel: meson_uart ffd22000.serial: ttyS3 use xtal(24M) 24000000 change 0 to 9600 Aug 17 22:09:56 tube-rivo-audio kernel: meson_uart ffd22000.serial: ttyS3 use xtal(24M) 24000000 change 9600 to 9600 Aug 17 22:09:56 tube-rivo-audio kernel: meson_uart ffd22000.serial: ttyS3 use xtal(24M) 24000000 change 9600 to 115200 Aug 17 22:09:56 tube-rivo-audio volumio[3391]: info: Refreshing TIDAL token Aug 17 22:09:57 tube-rivo-audio sudo[3562]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/xinput --test-xi2 --root Aug 17 22:09:57 tube-rivo-audio sudo[3562]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 22:09:57 tube-rivo-audio sudo[3562]: pam_unix(sudo:session): session closed for user root Aug 17 22:09:57 tube-rivo-audio sudo[3571]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x25 0x0 Aug 17 22:09:57 tube-rivo-audio sudo[3571]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 22:09:57 tube-rivo-audio sudo[3571]: pam_unix(sudo:session): session closed for user root Aug 17 22:09:57 tube-rivo-audio sudo[3574]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x28 0x0 Aug 17 22:09:57 tube-rivo-audio sudo[3574]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 22:09:57 tube-rivo-audio sudo[3574]: pam_unix(sudo:session): session closed for user root Aug 17 22:09:57 tube-rivo-audio sudo[3577]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x29 0x1 Aug 17 22:09:57 tube-rivo-audio sudo[3577]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 22:09:57 tube-rivo-audio sudo[3577]: pam_unix(sudo:session): session closed for user root Aug 17 22:09:57 tube-rivo-audio sudo[3580]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x33 0x1 Aug 17 22:09:57 tube-rivo-audio sudo[3580]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 22:09:57 tube-rivo-audio sudo[3580]: pam_unix(sudo:session): session closed for user root Aug 17 22:09:57 tube-rivo-audio volumio[3391]: info: Apply VIM3L Onboard LEDs Settings Aug 17 22:09:57 tube-rivo-audio volumio[3391]: info: Turning On Onboard LEDs Aug 17 22:09:57 tube-rivo-audio sudo[3584]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/tee /sys/class/leds/sys_led/trigger Aug 17 22:09:57 tube-rivo-audio sudo[3584]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 22:09:57 tube-rivo-audio volumio[3391]: info: Starting CEC Event listener Aug 17 22:09:57 tube-rivo-audio sudo[3584]: pam_unix(sudo:session): session closed for user root Aug 17 22:09:57 tube-rivo-audio volumio[3391]: info: Loading i18n strings for locale en Aug 17 22:09:57 tube-rivo-audio volumio[3391]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Aug 17 22:09:57 tube-rivo-audio volumio[3391]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 22:09:57 tube-rivo-audio volumio[3391]: info: FusionDsp - mixtype--------------------- None Aug 17 22:09:57 tube-rivo-audio volumio[3391]: info: Volumio Calling Home Aug 17 22:09:57 tube-rivo-audio sudo[3588]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/tee /sys/class/leds/red_red/trigger Aug 17 22:09:57 tube-rivo-audio sudo[3588]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 22:09:57 tube-rivo-audio sudo[3588]: pam_unix(sudo:session): session closed for user root Aug 17 22:09:57 tube-rivo-audio volumio[3391]: info: Preparing to generate the ALSA configuration file Aug 17 22:09:57 tube-rivo-audio volumio[3391]: info: Stopping AccessToken refresher cron for QOBUZ Aug 17 22:09:57 tube-rivo-audio volumio[3391]: info: AccessToken refresher cron started for QOBUZ Aug 17 22:09:57 tube-rivo-audio volumio[3391]: info: Adding QOBUZ REST API Endpoints Aug 17 22:09:57 tube-rivo-audio volumio[3391]: info: Adding getStreamUrlqobuz REST Endpoint for plugin: music_service/qobuz Aug 17 22:09:57 tube-rivo-audio volumio[3391]: info: Discovery: adding 1dc99a61-aea2-484f-a46a-3e4958b3c4a9 Aug 17 22:09:57 tube-rivo-audio volumio[3391]: info: Discovery: Found device Tube Rivo Audio Aug 17 22:09:57 tube-rivo-audio volumio[3391]: info: CoreCommandRouter::volumioGetState Aug 17 22:09:57 tube-rivo-audio volumio[3391]: info: CorePlayQueue::getTrack 0 Aug 17 22:09:57 tube-rivo-audio volumio[3391]: info: Discovery: this is already registered, 1dc99a61-aea2-484f-a46a-3e4958b3c4a9 Aug 17 22:09:57 tube-rivo-audio volumio[3391]: info: Discovery: Found device Tube Rivo Audio Aug 17 22:09:57 tube-rivo-audio volumio[3391]: info: CoreCommandRouter::volumioGetState Aug 17 22:09:57 tube-rivo-audio volumio[3391]: info: CorePlayQueue::getTrack 0 Aug 17 22:09:57 tube-rivo-audio volumio[3391]: info: Serial port opened successfully Aug 17 22:09:57 tube-rivo-audio volumio[3391]: info: Sending serial start messages Aug 17 22:09:57 tube-rivo-audio volumio[3391]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 22:09:57 tube-rivo-audio volumio[3391]: info: MP1 GPIO: Signalled system ready via GPIO Aug 17 22:09:57 tube-rivo-audio volumio[3391]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Aug 17 22:09:57 tube-rivo-audio volumio[3391]: info: Reading ALSA contributions from plugins. Aug 17 22:09:57 tube-rivo-audio volumio[3391]: info: Touch Event Listener Process Closed Aug 17 22:09:57 tube-rivo-audio volumio[3391]: error: Cannot start Volumio Streaming Daemon Aug 17 22:09:57 tube-rivo-audio volumio[3391]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Aug 17 22:09:57 tube-rivo-audio volumio[3391]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Aug 17 22:09:57 tube-rivo-audio volumio[3391]: info: Bluetooth name changed to Tube Rivo Audio Aug 17 22:09:57 tube-rivo-audio volumio[3391]: info: MPD Permissions set Aug 17 22:09:57 tube-rivo-audio volumio[3391]: info: MPD Permissions set Aug 17 22:09:57 tube-rivo-audio volumio[3391]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1 Aug 17 22:09:57 tube-rivo-audio volumio[3391]: info: Volumio called home Aug 17 22:09:57 tube-rivo-audio volumio[3391]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 22:09:57 tube-rivo-audio volumio[3391]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 22:09:57 tube-rivo-audio volumio[3391]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 22:09:57 tube-rivo-audio volumio[3391]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 22:09:57 tube-rivo-audio volumio[3391]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 22:09:57 tube-rivo-audio volumio[3391]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 22:09:57 tube-rivo-audio volumio[3391]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 22:09:57 tube-rivo-audio volumio[3391]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 22:09:57 tube-rivo-audio volumio[3391]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 17 22:09:57 tube-rivo-audio volumio[3391]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Aug 17 22:09:57 tube-rivo-audio volumio[3391]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 22:09:57 tube-rivo-audio volumio[3391]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 22:09:57 tube-rivo-audio volumio[3391]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 22:09:57 tube-rivo-audio volumio[3391]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 22:09:57 tube-rivo-audio volumio[3391]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 22:09:57 tube-rivo-audio volumio[3391]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 22:09:57 tube-rivo-audio volumio[3391]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 22:09:57 tube-rivo-audio volumio[3391]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 22:09:57 tube-rivo-audio volumio[3391]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 22:09:57 tube-rivo-audio volumio[3391]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 17 22:09:57 tube-rivo-audio volumio[3391]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Aug 17 22:09:58 tube-rivo-audio volumio[3391]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 22:09:58 tube-rivo-audio volumio[3391]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Aug 17 22:09:58 tube-rivo-audio volumio[3391]: info: CoreCommandRouter::volumioGetState Aug 17 22:09:58 tube-rivo-audio volumio[3391]: info: CorePlayQueue::getTrack 0 Aug 17 22:09:58 tube-rivo-audio volumio[3391]: info: CoreCommandRouter::volumioGetState Aug 17 22:09:58 tube-rivo-audio volumio[3391]: info: CorePlayQueue::getTrack 0 Aug 17 22:09:58 tube-rivo-audio volumio[3391]: info: Asound.conf file unchanged, so no further update is needed Aug 17 22:09:58 tube-rivo-audio volumio[3391]: info: Output device has changed, restarting MPD Aug 17 22:09:58 tube-rivo-audio volumio[3391]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 22:09:58 tube-rivo-audio sudo[3610]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 17 22:09:58 tube-rivo-audio sudo[3610]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 22:09:58 tube-rivo-audio sudo[3610]: pam_unix(sudo:session): session closed for user root Aug 17 22:09:58 tube-rivo-audio sudo[3612]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 17 22:09:58 tube-rivo-audio sudo[3612]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 22:09:58 tube-rivo-audio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Aug 17 22:09:58 tube-rivo-audio systemd[1]: mpd.service: Succeeded. Aug 17 22:09:58 tube-rivo-audio systemd[1]: Stopped Music Player Daemon. Aug 17 22:09:58 tube-rivo-audio volumio[3391]: info: MPD Permissions set Aug 17 22:09:58 tube-rivo-audio systemd[1]: Starting Music Player Daemon... Aug 17 22:09:58 tube-rivo-audio volumio[3391]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 22:09:58 tube-rivo-audio volumio[3391]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 22:09:58 tube-rivo-audio volumio[3391]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 22:09:58 tube-rivo-audio volumio[3391]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 22:09:58 tube-rivo-audio volumio[3391]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 22:09:58 tube-rivo-audio volumio[3391]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 22:09:58 tube-rivo-audio volumio[3391]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 22:09:58 tube-rivo-audio volumio[3391]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 22:09:58 tube-rivo-audio volumio[3391]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 17 22:09:58 tube-rivo-audio volumio[3391]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Aug 17 22:09:58 tube-rivo-audio volumio[3391]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 22:09:58 tube-rivo-audio sudo[3615]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 17 22:09:58 tube-rivo-audio sudo[3615]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 22:09:58 tube-rivo-audio sudo[3615]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Aug 17 22:09:58 tube-rivo-audio sudo[3615]: pam_unix(sudo:session): session closed for user root Aug 17 22:09:58 tube-rivo-audio volumio[3391]: info: Access Token successfully retrieved Aug 17 22:09:59 tube-rivo-audio volumio-remote-updater[2843]: [2024-08-17 22:09:59] [connect] Successful connection Aug 17 22:09:59 tube-rivo-audio volumio-remote-updater[2843]: [2024-08-17 22:09:59] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1723907399 101 Aug 17 22:09:59 tube-rivo-audio volumio[3391]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 3 Aug 17 22:09:59 tube-rivo-audio volumio[3391]: info: Successfully retrieved User Session From TIDAL Aug 17 22:09:59 tube-rivo-audio volumio[3391]: info: camilladsp spawned new process with pid undefined, instance 1, run: true Aug 17 22:09:59 tube-rivo-audio volumio[3391]: info: camilladsp service started and running in background, instance 1 Aug 17 22:09:59 tube-rivo-audio volumio[3391]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 22:09:59 tube-rivo-audio volumio[3391]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Aug 17 22:09:59 tube-rivo-audio volumio[3391]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Aug 17 22:09:59 tube-rivo-audio volumio[3391]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Aug 17 22:09:59 tube-rivo-audio volumio[3391]: info: FusionDsp loaded Aug 17 22:09:59 tube-rivo-audio volumio[3391]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 17 22:09:59 tube-rivo-audio sudo[3635]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Aug 17 22:09:59 tube-rivo-audio sudo[3635]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 22:09:59 tube-rivo-audio volumio[3391]: info: FusionDsp - Reporting Fusion DSP Enabled Aug 17 22:09:59 tube-rivo-audio volumio[3391]: info: Adding Signal Path Element [object Object] Aug 17 22:09:59 tube-rivo-audio volumio[3391]: info: Adding fusiondspeq DSP Signal Path Element Aug 17 22:09:59 tube-rivo-audio volumio[3391]: info: FusionDsp - ---- installed callbackRead Aug 17 22:09:59 tube-rivo-audio volumio[3391]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 17 22:09:59 tube-rivo-audio sudo[3635]: pam_unix(sudo:session): session closed for user root Aug 17 22:09:59 tube-rivo-audio volumio[3391]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Aug 17 22:09:59 tube-rivo-audio volumio[3391]: at Process.ChildProcess._handle.onexit (internal/child_process.js:277:19) Aug 17 22:09:59 tube-rivo-audio volumio[3391]: at onErrorNT (internal/child_process.js:472:16) Aug 17 22:09:59 tube-rivo-audio volumio[3391]: at processTicksAndRejections (internal/process/task_queues.js:82:21) { Aug 17 22:09:59 tube-rivo-audio volumio[3391]: errno: -2, Aug 17 22:09:59 tube-rivo-audio volumio[3391]: code: 'ENOENT', Aug 17 22:09:59 tube-rivo-audio volumio[3391]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Aug 17 22:09:59 tube-rivo-audio volumio[3391]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Aug 17 22:09:59 tube-rivo-audio volumio[3391]: spawnargs: [ Aug 17 22:09:59 tube-rivo-audio volumio[3391]: '-p', Aug 17 22:09:59 tube-rivo-audio volumio[3391]: 9876, Aug 17 22:09:59 tube-rivo-audio volumio[3391]: '-o', Aug 17 22:09:59 tube-rivo-audio volumio[3391]: '/tmp/camilladsp.log', Aug 17 22:09:59 tube-rivo-audio volumio[3391]: '-l', Aug 17 22:09:59 tube-rivo-audio volumio[3391]: 'warn', Aug 17 22:09:59 tube-rivo-audio volumio[3391]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Aug 17 22:09:59 tube-rivo-audio volumio[3391]: ] Aug 17 22:09:59 tube-rivo-audio volumio[3391]: } Aug 17 22:09:59 tube-rivo-audio volumio[3391]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 17 22:10:00 tube-rivo-audio sudo[3646]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-08-17 22:09 Aug 17 22:10:00 tube-rivo-audio sudo[3646]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="5fd3886148e72a9cecd88a772d1f6079fb64d11a" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8bb23b009e91ae4c7ecd678f193e7d3b281fca0c" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="rivo" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 22 Jul 2024 05:06:46 PM CEST" VOLUMIO_VERSION="3.742" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Rivo" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Rivo" VOLUMIO_HASH="420eec03f218d056e8306370042003fc"