-- Logs begin at Sun 2024-04-21 11:40:24 UTC, end at Sun 2024-04-21 11:42:53 UTC. -- Apr 21 11:41:00 volumio kernel: failed to power up DHD generic adapter, 2 retry left Apr 21 11:41:01 volumio kernel: wifi_platform_set_power = 0 Apr 21 11:41:01 volumio kernel: ======== PULL WL_REG_ON(-1) LOW! ======== Apr 21 11:41:01 volumio kernel: wifi_platform_bus_enumerate device present 0 Apr 21 11:41:01 volumio kernel: ======== Card detection to remove SDIO card! ======== Apr 21 11:41:01 volumio kernel: aml_wifi wifi.33: [extern_wifi_set_enable] WIFI Disable! 240 Apr 21 11:41:01 volumio kernel: wifi_platform_set_power = 1 Apr 21 11:41:01 volumio kernel: ======== PULL WL_REG_ON(-1) HIGH! ======== Apr 21 11:41:01 volumio kernel: aml_wifi wifi.33: [extern_wifi_set_enable] WIFI Disable! 240 Apr 21 11:41:01 volumio kernel: aml_wifi wifi.33: [extern_wifi_set_enable] WIFI Enable! 240 Apr 21 11:41:02 volumio kernel: wifi_platform_bus_enumerate device present 1 Apr 21 11:41:02 volumio kernel: ======== Card detection to detect SDIO card! ======== Apr 21 11:41:02 volumio kernel: [aml_sd_emmc_irq] sdio: resp_timeout,vstat:0xa3ff2800,virqc:3fff Apr 21 11:41:02 volumio kernel: [aml_host_bus_fsm_show] sdio: err: wait for irq service, bus_fsm:0x8 Apr 21 11:41:02 volumio kernel: aml_sd_emmc_data_thread 2639 sdio: cmd:52 Apr 21 11:41:02 volumio kernel: [aml_sd_emmc_irq] sdio: resp_timeout,vstat:0xa3ff2800,virqc:3fff Apr 21 11:41:02 volumio kernel: [aml_host_bus_fsm_show] sdio: err: wait for irq service, bus_fsm:0x8 Apr 21 11:41:02 volumio kernel: aml_sd_emmc_data_thread 2639 sdio: cmd:52 Apr 21 11:41:02 volumio kernel: [aml_sd_emmc_irq] sdio: resp_timeout,vstat:0xa3ff2800,virqc:3fff Apr 21 11:41:02 volumio kernel: [aml_host_bus_fsm_show] sdio: err: wait for irq service, bus_fsm:0x8 Apr 21 11:41:02 volumio kernel: aml_sd_emmc_data_thread 2639 sdio: cmd:8 Apr 21 11:41:02 volumio kernel: [aml_sd_emmc_irq] sdio: resp_timeout,vstat:0xa3ff2800,virqc:3fff Apr 21 11:41:02 volumio kernel: [aml_host_bus_fsm_show] sdio: err: wait for irq service, bus_fsm:0x8 Apr 21 11:41:02 volumio kernel: aml_sd_emmc_data_thread 2639 sdio: cmd:5 Apr 21 11:41:02 volumio kernel: [aml_sd_emmc_irq] sdio: resp_timeout,vstat:0xa3ff2800,virqc:3fff Apr 21 11:41:02 volumio kernel: [aml_host_bus_fsm_show] sdio: err: wait for irq service, bus_fsm:0x8 Apr 21 11:41:02 volumio kernel: aml_sd_emmc_data_thread 2639 sdio: cmd:5 Apr 21 11:41:02 volumio kernel: [aml_sd_emmc_irq] sdio: resp_timeout,vstat:0xa3ff2800,virqc:3fff Apr 21 11:41:02 volumio kernel: [aml_host_bus_fsm_show] sdio: err: wait for irq service, bus_fsm:0x8 Apr 21 11:41:02 volumio kernel: aml_sd_emmc_data_thread 2639 sdio: cmd:5 Apr 21 11:41:02 volumio kernel: [aml_sd_emmc_irq] sdio: resp_timeout,vstat:0xa3ff2800,virqc:3fff Apr 21 11:41:02 volumio kernel: [aml_host_bus_fsm_show] sdio: err: wait for irq service, bus_fsm:0x8 Apr 21 11:41:02 volumio kernel: aml_sd_emmc_data_thread 2639 sdio: cmd:5 Apr 21 11:41:02 volumio kernel: [aml_sd_emmc_irq] sdio: resp_timeout,vstat:0xa3ff2800,virqc:3fff Apr 21 11:41:02 volumio kernel: [aml_host_bus_fsm_show] sdio: err: wait for irq service, bus_fsm:0x8 Apr 21 11:41:02 volumio kernel: aml_sd_emmc_data_thread 2639 sdio: cmd:55 Apr 21 11:41:02 volumio kernel: [aml_sd_emmc_irq] sdio: resp_timeout,vstat:0xa3ff2800,virqc:3fff Apr 21 11:41:02 volumio kernel: [aml_host_bus_fsm_show] sdio: err: wait for irq service, bus_fsm:0x8 Apr 21 11:41:02 volumio kernel: aml_sd_emmc_data_thread 2639 sdio: cmd:55 Apr 21 11:41:02 volumio kernel: [aml_sd_emmc_irq] sdio: resp_timeout,vstat:0xa3ff2800,virqc:3fff Apr 21 11:41:02 volumio kernel: [aml_host_bus_fsm_show] sdio: err: wait for irq service, bus_fsm:0x8 Apr 21 11:41:02 volumio kernel: aml_sd_emmc_data_thread 2639 sdio: cmd:55 Apr 21 11:41:02 volumio kernel: [aml_sd_emmc_irq] sdio: resp_timeout,vstat:0xa3ff2800,virqc:3fff Apr 21 11:41:02 volumio kernel: [aml_host_bus_fsm_show] sdio: err: wait for irq service, bus_fsm:0x8 Apr 21 11:41:02 volumio kernel: aml_sd_emmc_data_thread 2639 sdio: cmd:55 Apr 21 11:41:02 volumio kernel: [aml_sd_emmc_irq] sdio: resp_timeout,vstat:0xa3ff2800,virqc:3fff Apr 21 11:41:02 volumio kernel: [aml_host_bus_fsm_show] sdio: err: wait for irq service, bus_fsm:0x8 Apr 21 11:41:02 volumio kernel: aml_sd_emmc_data_thread 2639 sdio: cmd:1 Apr 21 11:41:02 volumio kernel: sdio: error -110 whilst initialising MMC card Apr 21 11:41:02 volumio kernel: [sdio_reinit] finish Apr 21 11:41:04 volumio kernel: failed to power up DHD generic adapter, 1 retry left Apr 21 11:41:04 volumio kernel: wifi_platform_set_power = 0 Apr 21 11:41:04 volumio kernel: ======== PULL WL_REG_ON(-1) LOW! ======== Apr 21 11:41:04 volumio kernel: wifi_platform_bus_enumerate device present 0 Apr 21 11:41:04 volumio kernel: ======== Card detection to remove SDIO card! ======== Apr 21 11:41:04 volumio kernel: aml_wifi wifi.33: [extern_wifi_set_enable] WIFI Disable! 240 Apr 21 11:41:05 volumio kernel: wifi_platform_set_power = 1 Apr 21 11:41:05 volumio kernel: ======== PULL WL_REG_ON(-1) HIGH! ======== Apr 21 11:41:05 volumio kernel: aml_wifi wifi.33: [extern_wifi_set_enable] WIFI Disable! 240 Apr 21 11:41:05 volumio kernel: aml_wifi wifi.33: [extern_wifi_set_enable] WIFI Enable! 240 Apr 21 11:41:05 volumio kernel: wifi_platform_bus_enumerate device present 1 Apr 21 11:41:05 volumio kernel: ======== Card detection to detect SDIO card! ======== Apr 21 11:41:05 volumio kernel: [aml_sd_emmc_irq] sdio: resp_timeout,vstat:0xa3ff2800,virqc:3fff Apr 21 11:41:05 volumio kernel: [aml_host_bus_fsm_show] sdio: err: wait for irq service, bus_fsm:0x8 Apr 21 11:41:05 volumio kernel: aml_sd_emmc_data_thread 2639 sdio: cmd:52 Apr 21 11:41:05 volumio kernel: [aml_sd_emmc_irq] sdio: resp_timeout,vstat:0xa3ff2800,virqc:3fff Apr 21 11:41:05 volumio kernel: [aml_host_bus_fsm_show] sdio: err: wait for irq service, bus_fsm:0x8 Apr 21 11:41:05 volumio kernel: aml_sd_emmc_data_thread 2639 sdio: cmd:52 Apr 21 11:41:05 volumio kernel: [aml_sd_emmc_irq] sdio: resp_timeout,vstat:0xa3ff2800,virqc:3fff Apr 21 11:41:05 volumio kernel: [aml_host_bus_fsm_show] sdio: err: wait for irq service, bus_fsm:0x8 Apr 21 11:41:05 volumio kernel: aml_sd_emmc_data_thread 2639 sdio: cmd:8 Apr 21 11:41:06 volumio kernel: [aml_sd_emmc_irq] sdio: resp_timeout,vstat:0xa3ff2800,virqc:3fff Apr 21 11:41:06 volumio kernel: [aml_host_bus_fsm_show] sdio: err: wait for irq service, bus_fsm:0x8 Apr 21 11:41:06 volumio kernel: aml_sd_emmc_data_thread 2639 sdio: cmd:5 Apr 21 11:41:06 volumio kernel: [aml_sd_emmc_irq] sdio: resp_timeout,vstat:0xa3ff2800,virqc:3fff Apr 21 11:41:06 volumio kernel: [aml_host_bus_fsm_show] sdio: err: wait for irq service, bus_fsm:0x8 Apr 21 11:41:06 volumio kernel: aml_sd_emmc_data_thread 2639 sdio: cmd:5 Apr 21 11:41:06 volumio kernel: [aml_sd_emmc_irq] sdio: resp_timeout,vstat:0xa3ff2800,virqc:3fff Apr 21 11:41:06 volumio kernel: [aml_host_bus_fsm_show] sdio: err: wait for irq service, bus_fsm:0x8 Apr 21 11:41:06 volumio kernel: aml_sd_emmc_data_thread 2639 sdio: cmd:5 Apr 21 11:41:06 volumio kernel: [aml_sd_emmc_irq] sdio: resp_timeout,vstat:0xa3ff2800,virqc:3fff Apr 21 11:41:06 volumio kernel: [aml_host_bus_fsm_show] sdio: err: wait for irq service, bus_fsm:0x8 Apr 21 11:41:06 volumio kernel: aml_sd_emmc_data_thread 2639 sdio: cmd:5 Apr 21 11:41:06 volumio kernel: [aml_sd_emmc_irq] sdio: resp_timeout,vstat:0xa3ff2800,virqc:3fff Apr 21 11:41:06 volumio kernel: [aml_host_bus_fsm_show] sdio: err: wait for irq service, bus_fsm:0x8 Apr 21 11:41:06 volumio kernel: aml_sd_emmc_data_thread 2639 sdio: cmd:55 Apr 21 11:41:06 volumio kernel: [aml_sd_emmc_irq] sdio: resp_timeout,vstat:0xa3ff2800,virqc:3fff Apr 21 11:41:06 volumio kernel: [aml_host_bus_fsm_show] sdio: err: wait for irq service, bus_fsm:0x8 Apr 21 11:41:06 volumio kernel: aml_sd_emmc_data_thread 2639 sdio: cmd:55 Apr 21 11:41:06 volumio kernel: [aml_sd_emmc_irq] sdio: resp_timeout,vstat:0xa3ff2800,virqc:3fff Apr 21 11:41:06 volumio kernel: [aml_host_bus_fsm_show] sdio: err: wait for irq service, bus_fsm:0x8 Apr 21 11:41:06 volumio kernel: aml_sd_emmc_data_thread 2639 sdio: cmd:55 Apr 21 11:41:06 volumio kernel: [aml_sd_emmc_irq] sdio: resp_timeout,vstat:0xa3ff2800,virqc:3fff Apr 21 11:41:06 volumio kernel: [aml_host_bus_fsm_show] sdio: err: wait for irq service, bus_fsm:0x8 Apr 21 11:41:06 volumio kernel: aml_sd_emmc_data_thread 2639 sdio: cmd:55 Apr 21 11:41:06 volumio kernel: [aml_sd_emmc_irq] sdio: resp_timeout,vstat:0xa3ff2800,virqc:3fff Apr 21 11:41:06 volumio kernel: [aml_host_bus_fsm_show] sdio: err: wait for irq service, bus_fsm:0x8 Apr 21 11:41:06 volumio kernel: aml_sd_emmc_data_thread 2639 sdio: cmd:1 Apr 21 11:41:06 volumio kernel: sdio: error -110 whilst initialising MMC card Apr 21 11:41:06 volumio kernel: [sdio_reinit] finish Apr 21 11:41:08 volumio kernel: failed to power up DHD generic adapter, 0 retry left Apr 21 11:41:08 volumio kernel: wifi_platform_set_power = 0 Apr 21 11:41:08 volumio kernel: ======== PULL WL_REG_ON(-1) LOW! ======== Apr 21 11:41:08 volumio kernel: wifi_platform_bus_enumerate device present 0 Apr 21 11:41:08 volumio kernel: ======== Card detection to remove SDIO card! ======== Apr 21 11:41:08 volumio kernel: aml_wifi wifi.33: [extern_wifi_set_enable] WIFI Disable! 240 Apr 21 11:41:08 volumio kernel: failed to power up DHD generic adapter, max retry reached** Apr 21 11:41:08 volumio kernel: unregister wifi platform drivers Apr 21 11:41:08 volumio kernel: wifi_platform_bus_enumerate device present 0 Apr 21 11:41:08 volumio kernel: ======== Card detection to remove SDIO card! ======== Apr 21 11:41:08 volumio kernel: aml_wifi wifi.33: [extern_wifi_set_enable] WIFI Disable! 240 Apr 21 11:41:08 volumio kernel: ======== dhd_wlan_deinit_plat_data ======== Apr 21 11:41:08 volumio kernel: dhd_module_init: Failed to load the driver, try cnt 1 Apr 21 11:41:08 volumio kernel: ======== dhd_wlan_init_plat_data ======== Apr 21 11:41:08 volumio kernel: dhd_wlan_init_gpio: GPIO(WL_REG_ON) = -1 Apr 21 11:41:08 volumio kernel: dhd_wlan_init_gpio: GPIO(WL_HOST_WAKE) = -1 Apr 21 11:41:08 volumio kernel: dhd_wlan_init_gpio: host_oob_irq: 100 Apr 21 11:41:08 volumio kernel: dhd_wlan_init_gpio: host_oob_irq_flags=0x414 Apr 21 11:41:08 volumio kernel: dhd_wifi_platform_load: Enter Apr 21 11:41:08 volumio kernel: Power-up adapter 'DHD generic adapter' Apr 21 11:41:08 volumio kernel: wifi_platform_set_power = 1 Apr 21 11:41:08 volumio kernel: ======== PULL WL_REG_ON(-1) HIGH! ======== Apr 21 11:41:08 volumio kernel: aml_wifi wifi.33: [extern_wifi_set_enable] WIFI Disable! 240 Apr 21 11:41:09 volumio kernel: aml_wifi wifi.33: [extern_wifi_set_enable] WIFI Enable! 240 Apr 21 11:41:09 volumio kernel: wifi_platform_bus_enumerate device present 1 Apr 21 11:41:09 volumio kernel: ======== Card detection to detect SDIO card! ======== Apr 21 11:41:09 volumio kernel: [aml_sd_emmc_irq] sdio: resp_timeout,vstat:0xa3ff2800,virqc:3fff Apr 21 11:41:09 volumio kernel: [aml_host_bus_fsm_show] sdio: err: wait for irq service, bus_fsm:0x8 Apr 21 11:41:09 volumio kernel: aml_sd_emmc_data_thread 2639 sdio: cmd:52 Apr 21 11:41:09 volumio kernel: [aml_sd_emmc_irq] sdio: resp_timeout,vstat:0xa3ff2800,virqc:3fff Apr 21 11:41:09 volumio kernel: [aml_host_bus_fsm_show] sdio: err: wait for irq service, bus_fsm:0x8 Apr 21 11:41:09 volumio kernel: aml_sd_emmc_data_thread 2639 sdio: cmd:52 Apr 21 11:41:09 volumio kernel: [aml_sd_emmc_irq] sdio: resp_timeout,vstat:0xa3ff2800,virqc:3fff Apr 21 11:41:09 volumio kernel: [aml_host_bus_fsm_show] sdio: err: wait for irq service, bus_fsm:0x8 Apr 21 11:41:09 volumio kernel: aml_sd_emmc_data_thread 2639 sdio: cmd:8 Apr 21 11:41:09 volumio kernel: [aml_sd_emmc_irq] sdio: resp_timeout,vstat:0xa3ff2800,virqc:3fff Apr 21 11:41:09 volumio kernel: [aml_host_bus_fsm_show] sdio: err: wait for irq service, bus_fsm:0x8 Apr 21 11:41:09 volumio kernel: aml_sd_emmc_data_thread 2639 sdio: cmd:5 Apr 21 11:41:10 volumio kernel: [aml_sd_emmc_irq] sdio: resp_timeout,vstat:0xa3ff2800,virqc:3fff Apr 21 11:41:10 volumio kernel: [aml_host_bus_fsm_show] sdio: err: wait for irq service, bus_fsm:0x8 Apr 21 11:41:10 volumio kernel: aml_sd_emmc_data_thread 2639 sdio: cmd:5 Apr 21 11:41:10 volumio kernel: [aml_sd_emmc_irq] sdio: resp_timeout,vstat:0xa3ff2800,virqc:3fff Apr 21 11:41:10 volumio kernel: [aml_host_bus_fsm_show] sdio: err: wait for irq service, bus_fsm:0x8 Apr 21 11:41:10 volumio kernel: aml_sd_emmc_data_thread 2639 sdio: cmd:5 Apr 21 11:41:10 volumio kernel: [aml_sd_emmc_irq] sdio: resp_timeout,vstat:0xa3ff2800,virqc:3fff Apr 21 11:41:10 volumio kernel: [aml_host_bus_fsm_show] sdio: err: wait for irq service, bus_fsm:0x8 Apr 21 11:41:10 volumio kernel: aml_sd_emmc_data_thread 2639 sdio: cmd:5 Apr 21 11:41:10 volumio kernel: [aml_sd_emmc_irq] sdio: resp_timeout,vstat:0xa3ff2800,virqc:3fff Apr 21 11:41:10 volumio kernel: [aml_host_bus_fsm_show] sdio: err: wait for irq service, bus_fsm:0x8 Apr 21 11:41:10 volumio kernel: aml_sd_emmc_data_thread 2639 sdio: cmd:55 Apr 21 11:41:10 volumio kernel: [aml_sd_emmc_irq] sdio: resp_timeout,vstat:0xa3ff2800,virqc:3fff Apr 21 11:41:10 volumio kernel: [aml_host_bus_fsm_show] sdio: err: wait for irq service, bus_fsm:0x8 Apr 21 11:41:10 volumio kernel: aml_sd_emmc_data_thread 2639 sdio: cmd:55 Apr 21 11:41:10 volumio kernel: [aml_sd_emmc_irq] sdio: resp_timeout,vstat:0xa3ff2800,virqc:3fff Apr 21 11:41:10 volumio kernel: [aml_host_bus_fsm_show] sdio: err: wait for irq service, bus_fsm:0x8 Apr 21 11:41:10 volumio kernel: aml_sd_emmc_data_thread 2639 sdio: cmd:55 Apr 21 11:41:10 volumio kernel: [aml_sd_emmc_irq] sdio: resp_timeout,vstat:0xa3ff2800,virqc:3fff Apr 21 11:41:10 volumio kernel: [aml_host_bus_fsm_show] sdio: err: wait for irq service, bus_fsm:0x8 Apr 21 11:41:10 volumio kernel: aml_sd_emmc_data_thread 2639 sdio: cmd:55 Apr 21 11:41:10 volumio kernel: [aml_sd_emmc_irq] sdio: resp_timeout,vstat:0xa3ff2800,virqc:3fff Apr 21 11:41:10 volumio kernel: [aml_host_bus_fsm_show] sdio: err: wait for irq service, bus_fsm:0x8 Apr 21 11:41:10 volumio kernel: aml_sd_emmc_data_thread 2639 sdio: cmd:1 Apr 21 11:41:10 volumio kernel: sdio: error -110 whilst initialising MMC card Apr 21 11:41:10 volumio kernel: [sdio_reinit] finish Apr 21 11:41:11 volumio kernel: failed to power up DHD generic adapter, 3 retry left Apr 21 11:41:12 volumio kernel: wifi_platform_set_power = 0 Apr 21 11:41:12 volumio kernel: ======== PULL WL_REG_ON(-1) LOW! ======== Apr 21 11:41:12 volumio kernel: wifi_platform_bus_enumerate device present 0 Apr 21 11:41:12 volumio kernel: ======== Card detection to remove SDIO card! ======== Apr 21 11:41:12 volumio kernel: aml_wifi wifi.33: [extern_wifi_set_enable] WIFI Disable! 240 Apr 21 11:41:12 volumio kernel: wifi_platform_set_power = 1 Apr 21 11:41:12 volumio kernel: ======== PULL WL_REG_ON(-1) HIGH! ======== Apr 21 11:41:12 volumio kernel: aml_wifi wifi.33: [extern_wifi_set_enable] WIFI Disable! 240 Apr 21 11:41:12 volumio kernel: aml_wifi wifi.33: [extern_wifi_set_enable] WIFI Enable! 240 Apr 21 11:41:13 volumio kernel: wifi_platform_bus_enumerate device present 1 Apr 21 11:41:13 volumio kernel: ======== Card detection to detect SDIO card! ======== Apr 21 11:41:13 volumio kernel: [aml_sd_emmc_irq] sdio: resp_timeout,vstat:0xa3ff2800,virqc:3fff Apr 21 11:41:13 volumio kernel: [aml_host_bus_fsm_show] sdio: err: wait for irq service, bus_fsm:0x8 Apr 21 11:41:13 volumio kernel: aml_sd_emmc_data_thread 2639 sdio: cmd:52 Apr 21 11:41:13 volumio kernel: [aml_sd_emmc_irq] sdio: resp_timeout,vstat:0xa3ff2800,virqc:3fff Apr 21 11:41:13 volumio kernel: [aml_host_bus_fsm_show] sdio: err: wait for irq service, bus_fsm:0x8 Apr 21 11:41:13 volumio kernel: aml_sd_emmc_data_thread 2639 sdio: cmd:52 Apr 21 11:41:13 volumio kernel: [aml_sd_emmc_irq] sdio: resp_timeout,vstat:0xa3ff2800,virqc:3fff Apr 21 11:41:13 volumio kernel: [aml_host_bus_fsm_show] sdio: err: wait for irq service, bus_fsm:0x8 Apr 21 11:41:13 volumio kernel: aml_sd_emmc_data_thread 2639 sdio: cmd:8 Apr 21 11:41:13 volumio kernel: [aml_sd_emmc_irq] sdio: resp_timeout,vstat:0xa3ff2800,virqc:3fff Apr 21 11:41:13 volumio kernel: [aml_host_bus_fsm_show] sdio: err: wait for irq service, bus_fsm:0x8 Apr 21 11:41:13 volumio kernel: aml_sd_emmc_data_thread 2639 sdio: cmd:5 Apr 21 11:41:13 volumio kernel: [aml_sd_emmc_irq] sdio: resp_timeout,vstat:0xa3ff2800,virqc:3fff Apr 21 11:41:13 volumio kernel: [aml_host_bus_fsm_show] sdio: err: wait for irq service, bus_fsm:0x8 Apr 21 11:41:13 volumio kernel: aml_sd_emmc_data_thread 2639 sdio: cmd:5 Apr 21 11:41:13 volumio kernel: [aml_sd_emmc_irq] sdio: resp_timeout,vstat:0xa3ff2800,virqc:3fff Apr 21 11:41:13 volumio kernel: [aml_host_bus_fsm_show] sdio: err: wait for irq service, bus_fsm:0x8 Apr 21 11:41:13 volumio kernel: aml_sd_emmc_data_thread 2639 sdio: cmd:5 Apr 21 11:41:13 volumio kernel: [aml_sd_emmc_irq] sdio: resp_timeout,vstat:0xa3ff2800,virqc:3fff Apr 21 11:41:13 volumio kernel: [aml_host_bus_fsm_show] sdio: err: wait for irq service, bus_fsm:0x8 Apr 21 11:41:13 volumio kernel: aml_sd_emmc_data_thread 2639 sdio: cmd:5 Apr 21 11:41:13 volumio kernel: [aml_sd_emmc_irq] sdio: resp_timeout,vstat:0xa3ff2800,virqc:3fff Apr 21 11:41:13 volumio kernel: [aml_host_bus_fsm_show] sdio: err: wait for irq service, bus_fsm:0x8 Apr 21 11:41:13 volumio kernel: aml_sd_emmc_data_thread 2639 sdio: cmd:55 Apr 21 11:41:13 volumio kernel: [aml_sd_emmc_irq] sdio: resp_timeout,vstat:0xa3ff2800,virqc:3fff Apr 21 11:41:13 volumio kernel: [aml_host_bus_fsm_show] sdio: err: wait for irq service, bus_fsm:0x8 Apr 21 11:41:13 volumio kernel: aml_sd_emmc_data_thread 2639 sdio: cmd:55 Apr 21 11:41:13 volumio kernel: [aml_sd_emmc_irq] sdio: resp_timeout,vstat:0xa3ff2800,virqc:3fff Apr 21 11:41:13 volumio kernel: [aml_host_bus_fsm_show] sdio: err: wait for irq service, bus_fsm:0x8 Apr 21 11:41:13 volumio kernel: aml_sd_emmc_data_thread 2639 sdio: cmd:55 Apr 21 11:41:13 volumio kernel: [aml_sd_emmc_irq] sdio: resp_timeout,vstat:0xa3ff2800,virqc:3fff Apr 21 11:41:13 volumio kernel: [aml_host_bus_fsm_show] sdio: err: wait for irq service, bus_fsm:0x8 Apr 21 11:41:13 volumio kernel: aml_sd_emmc_data_thread 2639 sdio: cmd:55 Apr 21 11:41:13 volumio kernel: [aml_sd_emmc_irq] sdio: resp_timeout,vstat:0xa3ff2800,virqc:3fff Apr 21 11:41:13 volumio kernel: [aml_host_bus_fsm_show] sdio: err: wait for irq service, bus_fsm:0x8 Apr 21 11:41:13 volumio kernel: aml_sd_emmc_data_thread 2639 sdio: cmd:1 Apr 21 11:41:13 volumio kernel: sdio: error -110 whilst initialising MMC card Apr 21 11:41:13 volumio kernel: [sdio_reinit] finish Apr 21 11:41:15 volumio kernel: failed to power up DHD generic adapter, 2 retry left Apr 21 11:41:15 volumio kernel: wifi_platform_set_power = 0 Apr 21 11:41:15 volumio kernel: ======== PULL WL_REG_ON(-1) LOW! ======== Apr 21 11:41:15 volumio kernel: wifi_platform_bus_enumerate device present 0 Apr 21 11:41:15 volumio kernel: ======== Card detection to remove SDIO card! ======== Apr 21 11:41:15 volumio kernel: aml_wifi wifi.33: [extern_wifi_set_enable] WIFI Disable! 240 Apr 21 11:41:16 volumio kernel: wifi_platform_set_power = 1 Apr 21 11:41:16 volumio kernel: ======== PULL WL_REG_ON(-1) HIGH! ======== Apr 21 11:41:16 volumio kernel: aml_wifi wifi.33: [extern_wifi_set_enable] WIFI Disable! 240 Apr 21 11:41:16 volumio kernel: aml_wifi wifi.33: [extern_wifi_set_enable] WIFI Enable! 240 Apr 21 11:41:16 volumio kernel: wifi_platform_bus_enumerate device present 1 Apr 21 11:41:16 volumio kernel: ======== Card detection to detect SDIO card! ======== Apr 21 11:41:16 volumio kernel: [aml_sd_emmc_irq] sdio: resp_timeout,vstat:0xa3ff2800,virqc:3fff Apr 21 11:41:16 volumio kernel: [aml_host_bus_fsm_show] sdio: err: wait for irq service, bus_fsm:0x8 Apr 21 11:41:16 volumio kernel: aml_sd_emmc_data_thread 2639 sdio: cmd:52 Apr 21 11:41:16 volumio kernel: [aml_sd_emmc_irq] sdio: resp_timeout,vstat:0xa3ff2800,virqc:3fff Apr 21 11:41:16 volumio kernel: [aml_host_bus_fsm_show] sdio: err: wait for irq service, bus_fsm:0x8 Apr 21 11:41:16 volumio kernel: aml_sd_emmc_data_thread 2639 sdio: cmd:52 Apr 21 11:41:16 volumio kernel: [aml_sd_emmc_irq] sdio: resp_timeout,vstat:0xa3ff2800,virqc:3fff Apr 21 11:41:16 volumio kernel: [aml_host_bus_fsm_show] sdio: err: wait for irq service, bus_fsm:0x8 Apr 21 11:41:16 volumio kernel: aml_sd_emmc_data_thread 2639 sdio: cmd:8 Apr 21 11:41:17 volumio kernel: [aml_sd_emmc_irq] sdio: resp_timeout,vstat:0xa3ff2800,virqc:3fff Apr 21 11:41:17 volumio kernel: [aml_host_bus_fsm_show] sdio: err: wait for irq service, bus_fsm:0x8 Apr 21 11:41:17 volumio kernel: aml_sd_emmc_data_thread 2639 sdio: cmd:5 Apr 21 11:41:17 volumio kernel: [aml_sd_emmc_irq] sdio: resp_timeout,vstat:0xa3ff2800,virqc:3fff Apr 21 11:41:17 volumio kernel: [aml_host_bus_fsm_show] sdio: err: wait for irq service, bus_fsm:0x8 Apr 21 11:41:17 volumio kernel: aml_sd_emmc_data_thread 2639 sdio: cmd:5 Apr 21 11:41:17 volumio kernel: [aml_sd_emmc_irq] sdio: resp_timeout,vstat:0xa3ff2800,virqc:3fff Apr 21 11:41:17 volumio kernel: [aml_host_bus_fsm_show] sdio: err: wait for irq service, bus_fsm:0x8 Apr 21 11:41:17 volumio kernel: aml_sd_emmc_data_thread 2639 sdio: cmd:5 Apr 21 11:41:17 volumio kernel: [aml_sd_emmc_irq] sdio: resp_timeout,vstat:0xa3ff2800,virqc:3fff Apr 21 11:41:17 volumio kernel: [aml_host_bus_fsm_show] sdio: err: wait for irq service, bus_fsm:0x8 Apr 21 11:41:17 volumio kernel: aml_sd_emmc_data_thread 2639 sdio: cmd:5 Apr 21 11:41:17 volumio kernel: [aml_sd_emmc_irq] sdio: resp_timeout,vstat:0xa3ff2800,virqc:3fff Apr 21 11:41:17 volumio kernel: [aml_host_bus_fsm_show] sdio: err: wait for irq service, bus_fsm:0x8 Apr 21 11:41:17 volumio kernel: aml_sd_emmc_data_thread 2639 sdio: cmd:55 Apr 21 11:41:17 volumio kernel: [aml_sd_emmc_irq] sdio: resp_timeout,vstat:0xa3ff2800,virqc:3fff Apr 21 11:41:17 volumio kernel: [aml_host_bus_fsm_show] sdio: err: wait for irq service, bus_fsm:0x8 Apr 21 11:41:17 volumio kernel: aml_sd_emmc_data_thread 2639 sdio: cmd:55 Apr 21 11:41:17 volumio kernel: [aml_sd_emmc_irq] sdio: resp_timeout,vstat:0xa3ff2800,virqc:3fff Apr 21 11:41:17 volumio kernel: [aml_host_bus_fsm_show] sdio: err: wait for irq service, bus_fsm:0x8 Apr 21 11:41:17 volumio kernel: aml_sd_emmc_data_thread 2639 sdio: cmd:55 Apr 21 11:41:17 volumio kernel: [aml_sd_emmc_irq] sdio: resp_timeout,vstat:0xa3ff2800,virqc:3fff Apr 21 11:41:17 volumio kernel: [aml_host_bus_fsm_show] sdio: err: wait for irq service, bus_fsm:0x8 Apr 21 11:41:17 volumio kernel: aml_sd_emmc_data_thread 2639 sdio: cmd:55 Apr 21 11:41:17 volumio kernel: [aml_sd_emmc_irq] sdio: resp_timeout,vstat:0xa3ff2800,virqc:3fff Apr 21 11:41:17 volumio kernel: [aml_host_bus_fsm_show] sdio: err: wait for irq service, bus_fsm:0x8 Apr 21 11:41:17 volumio kernel: aml_sd_emmc_data_thread 2639 sdio: cmd:1 Apr 21 11:41:17 volumio kernel: sdio: error -110 whilst initialising MMC card Apr 21 11:41:17 volumio kernel: [sdio_reinit] finish Apr 21 11:41:19 volumio kernel: failed to power up DHD generic adapter, 1 retry left Apr 21 11:41:19 volumio kernel: wifi_platform_set_power = 0 Apr 21 11:41:19 volumio kernel: ======== PULL WL_REG_ON(-1) LOW! ======== Apr 21 11:41:19 volumio kernel: wifi_platform_bus_enumerate device present 0 Apr 21 11:41:19 volumio kernel: ======== Card detection to remove SDIO card! ======== Apr 21 11:41:19 volumio kernel: aml_wifi wifi.33: [extern_wifi_set_enable] WIFI Disable! 240 Apr 21 11:41:19 volumio kernel: wifi_platform_set_power = 1 Apr 21 11:41:19 volumio kernel: ======== PULL WL_REG_ON(-1) HIGH! ======== Apr 21 11:41:19 volumio kernel: aml_wifi wifi.33: [extern_wifi_set_enable] WIFI Disable! 240 Apr 21 11:41:20 volumio kernel: aml_wifi wifi.33: [extern_wifi_set_enable] WIFI Enable! 240 Apr 21 11:41:20 volumio kernel: wifi_platform_bus_enumerate device present 1 Apr 21 11:41:20 volumio kernel: ======== Card detection to detect SDIO card! ======== Apr 21 11:41:20 volumio kernel: [aml_sd_emmc_irq] sdio: resp_timeout,vstat:0xa3ff2800,virqc:3fff Apr 21 11:41:20 volumio kernel: [aml_host_bus_fsm_show] sdio: err: wait for irq service, bus_fsm:0x8 Apr 21 11:41:20 volumio kernel: aml_sd_emmc_data_thread 2639 sdio: cmd:52 Apr 21 11:41:20 volumio kernel: [aml_sd_emmc_irq] sdio: resp_timeout,vstat:0xa3ff2800,virqc:3fff Apr 21 11:41:20 volumio kernel: [aml_host_bus_fsm_show] sdio: err: wait for irq service, bus_fsm:0x8 Apr 21 11:41:20 volumio kernel: aml_sd_emmc_data_thread 2639 sdio: cmd:52 Apr 21 11:41:20 volumio kernel: [aml_sd_emmc_irq] sdio: resp_timeout,vstat:0xa3ff2800,virqc:3fff Apr 21 11:41:20 volumio kernel: [aml_host_bus_fsm_show] sdio: err: wait for irq service, bus_fsm:0x8 Apr 21 11:41:20 volumio kernel: aml_sd_emmc_data_thread 2639 sdio: cmd:8 Apr 21 11:41:20 volumio kernel: [aml_sd_emmc_irq] sdio: resp_timeout,vstat:0xa3ff2800,virqc:3fff Apr 21 11:41:20 volumio kernel: [aml_host_bus_fsm_show] sdio: err: wait for irq service, bus_fsm:0x8 Apr 21 11:41:20 volumio kernel: aml_sd_emmc_data_thread 2639 sdio: cmd:5 Apr 21 11:41:20 volumio kernel: [aml_sd_emmc_irq] sdio: resp_timeout,vstat:0xa3ff2800,virqc:3fff Apr 21 11:41:20 volumio kernel: [aml_host_bus_fsm_show] sdio: err: wait for irq service, bus_fsm:0x8 Apr 21 11:41:20 volumio kernel: aml_sd_emmc_data_thread 2639 sdio: cmd:5 Apr 21 11:41:20 volumio kernel: [aml_sd_emmc_irq] sdio: resp_timeout,vstat:0xa3ff2800,virqc:3fff Apr 21 11:41:20 volumio kernel: [aml_host_bus_fsm_show] sdio: err: wait for irq service, bus_fsm:0x8 Apr 21 11:41:20 volumio kernel: aml_sd_emmc_data_thread 2639 sdio: cmd:5 Apr 21 11:41:20 volumio kernel: [aml_sd_emmc_irq] sdio: resp_timeout,vstat:0xa3ff2800,virqc:3fff Apr 21 11:41:20 volumio kernel: [aml_host_bus_fsm_show] sdio: err: wait for irq service, bus_fsm:0x8 Apr 21 11:41:20 volumio kernel: aml_sd_emmc_data_thread 2639 sdio: cmd:5 Apr 21 11:41:20 volumio kernel: [aml_sd_emmc_irq] sdio: resp_timeout,vstat:0xa3ff2800,virqc:3fff Apr 21 11:41:20 volumio kernel: [aml_host_bus_fsm_show] sdio: err: wait for irq service, bus_fsm:0x8 Apr 21 11:41:20 volumio kernel: aml_sd_emmc_data_thread 2639 sdio: cmd:55 Apr 21 11:41:21 volumio kernel: [aml_sd_emmc_irq] sdio: resp_timeout,vstat:0xa3ff2800,virqc:3fff Apr 21 11:41:21 volumio kernel: [aml_host_bus_fsm_show] sdio: err: wait for irq service, bus_fsm:0x8 Apr 21 11:41:21 volumio kernel: aml_sd_emmc_data_thread 2639 sdio: cmd:55 Apr 21 11:41:21 volumio kernel: [aml_sd_emmc_irq] sdio: resp_timeout,vstat:0xa3ff2800,virqc:3fff Apr 21 11:41:21 volumio kernel: [aml_host_bus_fsm_show] sdio: err: wait for irq service, bus_fsm:0x8 Apr 21 11:41:21 volumio kernel: aml_sd_emmc_data_thread 2639 sdio: cmd:55 Apr 21 11:41:21 volumio kernel: [aml_sd_emmc_irq] sdio: resp_timeout,vstat:0xa3ff2800,virqc:3fff Apr 21 11:41:21 volumio kernel: [aml_host_bus_fsm_show] sdio: err: wait for irq service, bus_fsm:0x8 Apr 21 11:41:21 volumio kernel: aml_sd_emmc_data_thread 2639 sdio: cmd:55 Apr 21 11:41:21 volumio kernel: [aml_sd_emmc_irq] sdio: resp_timeout,vstat:0xa3ff2800,virqc:3fff Apr 21 11:41:21 volumio kernel: [aml_host_bus_fsm_show] sdio: err: wait for irq service, bus_fsm:0x8 Apr 21 11:41:21 volumio kernel: aml_sd_emmc_data_thread 2639 sdio: cmd:1 Apr 21 11:41:21 volumio kernel: sdio: error -110 whilst initialising MMC card Apr 21 11:41:21 volumio kernel: [sdio_reinit] finish Apr 21 11:41:23 volumio kernel: failed to power up DHD generic adapter, 0 retry left Apr 21 11:41:23 volumio kernel: wifi_platform_set_power = 0 Apr 21 11:41:23 volumio kernel: ======== PULL WL_REG_ON(-1) LOW! ======== Apr 21 11:41:23 volumio kernel: wifi_platform_bus_enumerate device present 0 Apr 21 11:41:23 volumio kernel: ======== Card detection to remove SDIO card! ======== Apr 21 11:41:23 volumio kernel: aml_wifi wifi.33: [extern_wifi_set_enable] WIFI Disable! 240 Apr 21 11:41:23 volumio kernel: failed to power up DHD generic adapter, max retry reached** Apr 21 11:41:23 volumio kernel: unregister wifi platform drivers Apr 21 11:41:23 volumio kernel: wifi_platform_bus_enumerate device present 0 Apr 21 11:41:23 volumio kernel: ======== Card detection to remove SDIO card! ======== Apr 21 11:41:23 volumio kernel: aml_wifi wifi.33: [extern_wifi_set_enable] WIFI Disable! 240 Apr 21 11:41:23 volumio kernel: ======== dhd_wlan_deinit_plat_data ======== Apr 21 11:41:23 volumio kernel: dhd_module_init: Failed to load the driver, try cnt 0 Apr 21 11:41:23 volumio kernel: dhd_module_init: Failed to load driver max retry reached** Apr 21 11:41:23 volumio kernel: dhd_module_init: Exit err=-19 Apr 21 11:41:23 volumio systemd-modules-load[2893]: Failed to insert 'dhd': No such device Apr 21 11:41:23 volumio systemd-modules-load[2893]: Failed to find module 'snd_soc_pcm5102' Apr 21 11:41:23 volumio systemd-modules-load[2893]: Failed to find module 'snd_soc_odroid_dac' Apr 21 11:41:23 volumio systemd[1]: systemd-modules-load.service: main process exited, code=exited, status=1/FAILURE Apr 21 11:41:23 volumio systemd[1]: Failed to start Load Kernel Modules. Apr 21 11:41:23 volumio systemd[1]: Unit systemd-modules-load.service entered failed state. Apr 21 11:41:23 volumio systemd[1]: Mounting Configuration File System... Apr 21 11:41:23 volumio systemd[1]: Starting Apply Kernel Variables... Apr 21 11:41:23 volumio systemd[1]: Mounted Configuration File System. Apr 21 11:41:23 volumio systemd[1]: Started Apply Kernel Variables. Apr 21 11:41:23 volumio systemd[1]: Starting LSB: Raise network interfaces.... Apr 21 11:41:24 volumio kernel: libphy: set driving length c Apr 21 11:41:24 volumio kernel: libphy: set PLL minimum jitter Apr 21 11:41:24 volumio kernel: libphy: set driving length c Apr 21 11:41:24 volumio kernel: libphy: set PLL minimum jitter Apr 21 11:41:25 volumio kernel: libphy: stmmac-0:08 - Link is Up - 100/Full Apr 21 11:41:25 volumio kernel: IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready Apr 21 11:41:25 volumio networking[4398]: Configuring network interfaces...done. Apr 21 11:41:25 volumio systemd[1]: Started LSB: Raise network interfaces.. Apr 21 11:41:26 volumio systemd[1]: Starting ifup for wlan0... Apr 21 11:41:26 volumio systemd[1]: Started ifup for wlan0. Apr 21 11:41:26 volumio systemd[1]: Starting ifup for eth0... Apr 21 11:41:26 volumio systemd[1]: Started ifup for eth0. Apr 21 11:41:26 volumio systemd[1]: Starting Network. Apr 21 11:41:26 volumio systemd[1]: Reached target Network. Apr 21 11:41:26 volumio systemd[1]: Starting Network is Online. Apr 21 11:41:26 volumio systemd[1]: Reached target Network is Online. Apr 21 11:41:26 volumio systemd[1]: Starting LSB: RPC portmapper replacement... Apr 21 11:41:26 volumio ifup[4483]: dhcpcd[4508]: version 6.0.5 starting Apr 21 11:41:26 volumio dhcpcd[4508]: version 6.0.5 starting Apr 21 11:41:26 volumio ifup[4483]: dhcpcd[4508]: eth0: soliciting a DHCP lease Apr 21 11:41:26 volumio dhcpcd[4508]: eth0: soliciting a DHCP lease Apr 21 11:41:26 volumio rpcbind[4500]: Starting rpcbind daemon.... Apr 21 11:41:26 volumio systemd[1]: Started LSB: RPC portmapper replacement. Apr 21 11:41:26 volumio systemd[1]: Starting RPC Port Mapper. Apr 21 11:41:26 volumio systemd[1]: Reached target RPC Port Mapper. Apr 21 11:41:26 volumio systemd[1]: Starting LSB: NFS support files common to client and server... Apr 21 11:41:26 volumio rpc.statd[4584]: Version 1.2.8 starting Apr 21 11:41:26 volumio sm-notify[4585]: Version 1.2.8 starting Apr 21 11:41:26 volumio kernel: Installing knfsd (copyright (C) 1996 okir@monad.swb.de). Apr 21 11:41:26 volumio nfs-common[4578]: Starting NFS common utilities: statd idmapd. Apr 21 11:41:26 volumio systemd[1]: Started LSB: NFS support files common to client and server. Apr 21 11:41:26 volumio systemd[1]: Starting System Initialization. Apr 21 11:41:26 volumio systemd[1]: Reached target System Initialization. Apr 21 11:41:26 volumio systemd[1]: Starting Avahi mDNS/DNS-SD Stack Activation Socket. Apr 21 11:41:26 volumio systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket. Apr 21 11:41:26 volumio systemd[1]: Starting mpd.socket. Apr 21 11:41:26 volumio systemd[1]: Listening on mpd.socket. Apr 21 11:41:26 volumio systemd[1]: Starting D-Bus System Message Bus Socket. Apr 21 11:41:26 volumio systemd[1]: Listening on D-Bus System Message Bus Socket. Apr 21 11:41:26 volumio systemd[1]: Starting Sockets. Apr 21 11:41:26 volumio systemd[1]: Reached target Sockets. Apr 21 11:41:26 volumio systemd[1]: Starting Daily Cleanup of Temporary Directories. Apr 21 11:41:26 volumio systemd[1]: Started Daily Cleanup of Temporary Directories. Apr 21 11:41:26 volumio systemd[1]: Starting Timers. Apr 21 11:41:26 volumio systemd[1]: Reached target Timers. Apr 21 11:41:26 volumio systemd[1]: Started Manage Sound Card State (restore and store). Apr 21 11:41:26 volumio systemd[1]: Starting Restore Sound Card State... Apr 21 11:41:26 volumio systemd[1]: Starting Basic System. Apr 21 11:41:26 volumio systemd[1]: Reached target Basic System. Apr 21 11:41:26 volumio systemd[1]: Starting Entropy daemon using the HAVEGE algorithm... Apr 21 11:41:26 volumio systemd[1]: Started Entropy daemon using the HAVEGE algorithm. Apr 21 11:41:26 volumio systemd[1]: Starting cd.service... Apr 21 11:41:26 volumio alsactl[4601]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:DAC Digital Playback Volume:0' : No such file or directory Apr 21 11:41:26 volumio kernel: aml_audio_i2s_mute_flag: flag=0 Apr 21 11:41:26 volumio kernel: aml_audio_set_spdif_mute: flag=0 Apr 21 11:41:26 volumio kernel: aml_snd_card: aml_m8_set_spk: aml_m8_spk_enabled=0 Apr 21 11:41:26 volumio systemd[1]: Started cd.service. Apr 21 11:41:26 volumio systemd[1]: Starting Volumio Iptables Module... Apr 21 11:41:26 volumio volumio[4604]: /bin/bash: /volumio/app/plugins/music_service/cd_controller/cd.sh: No such file or directory Apr 21 11:41:26 volumio systemd[1]: Started Volumio Iptables Module. Apr 21 11:41:26 volumio systemd[1]: Starting mount disks automatically with standby... Apr 21 11:41:26 volumio systemd[1]: Started mount disks automatically with standby. Apr 21 11:41:26 volumio systemd[1]: Starting UPnP Renderer front-end to MPD... Apr 21 11:41:26 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Apr 21 11:41:26 volumio systemd[1]: Starting volumio-remote-updater.service... Apr 21 11:41:27 volumio systemd[1]: Started volumio-remote-updater.service. Apr 21 11:41:27 volumio systemd[1]: Starting Volumio Log Rotation Service... Apr 21 11:41:27 volumio systemd[1]: Started Volumio Log Rotation Service. Apr 21 11:41:27 volumio systemd[1]: Starting Volumio SSH enabler... Apr 21 11:41:27 volumio systemd[1]: Started Volumio SSH enabler. Apr 21 11:41:27 volumio systemd[1]: Starting Wireless Services... Apr 21 11:41:27 volumio systemd[1]: Starting /etc/rc.local Compatibility... Apr 21 11:41:27 volumio systemd[1]: Started getty on tty2-tty6 if dbus and logind are not available. Apr 21 11:41:27 volumio systemd[1]: Starting Login Service... Apr 21 11:41:27 volumio systemd[1]: Starting LSB: start Winbind daemon... Apr 21 11:41:27 volumio systemd[1]: Starting LSB: triggerhappy hotkey daemon... Apr 21 11:41:27 volumio rc.local[4620]: kernel 3.14.29 Apr 21 11:41:27 volumio systemd[1]: Starting LSB: start Samba daemons for the AD DC... Apr 21 11:41:27 volumio systemd[1]: Starting LSB: Start NTP daemon... Apr 21 11:41:27 volumio systemd[1]: Starting LSB: start Samba NetBIOS nameserver (nmbd)... Apr 21 11:41:27 volumio triggerhappy[4636]: Unable to parse trigger line: Apr 21 11:41:27 volumio triggerhappy[4636]: Unable to parse trigger line: Apr 21 11:41:27 volumio triggerhappy[4636]: Unable to parse trigger line: Apr 21 11:41:27 volumio triggerhappy[4636]: Unable to parse trigger line: Apr 21 11:41:27 volumio triggerhappy[4636]: Unable to parse trigger line: Apr 21 11:41:27 volumio triggerhappy[4636]: Unable to parse trigger line: Apr 21 11:41:27 volumio triggerhappy[4636]: Unable to parse trigger line: Apr 21 11:41:27 volumio systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling... Apr 21 11:41:27 volumio kernel: fb: osd[0] canvas.idx =0x40 Apr 21 11:41:27 volumio kernel: fb: osd[0] canvas.addr=0x7d100000 Apr 21 11:41:27 volumio kernel: fb: osd[0] canvas.width=3840 Apr 21 11:41:27 volumio kernel: fb: osd[0] canvas.height=1440 Apr 21 11:41:27 volumio kernel: fb: osd[0] frame.width=1280 Apr 21 11:41:27 volumio kernel: fb: osd[0] frame.height=720 Apr 21 11:41:27 volumio kernel: fb: Frame buffer memory assigned at Apr 21 11:41:27 volumio kernel: fb: 1, phy: 0x000000007e900000, vir:0xffffff8003800000, size=1024K Apr 21 11:41:27 volumio kernel: fb: fb1 open, logo index:1 Apr 21 11:41:27 volumio kernel: fb: osd[1] canvas.idx =0x43 Apr 21 11:41:27 volumio kernel: fb: osd[1] canvas.addr=0x7e900000 Apr 21 11:41:27 volumio kernel: fb: osd[1] canvas.width=128 Apr 21 11:41:27 volumio kernel: fb: osd[1] canvas.height=32 Apr 21 11:41:27 volumio kernel: fb: osd[1] frame.width=32 Apr 21 11:41:27 volumio kernel: fb: osd[1] frame.height=32 Apr 21 11:41:27 volumio systemd[1]: Starting LSB: Starts LIRC daemon.... Apr 21 11:41:27 volumio kernel: vout_serve: vmode set to 720p60hz Apr 21 11:41:27 volumio loadcpufreq[4671]: Loading cpufreq kernel modules...done (none). Apr 21 11:41:27 volumio kernel: fb: current vmode=1080p60hz, cmd: 0x50000 Apr 21 11:41:27 volumio kernel: tv_vout: tv_set_current_vmode[919]fps_target_mode=10 Apr 21 11:41:27 volumio kernel: tv_vout: mode is 10,sync_duration_den=1,sync_duration_num=60 Apr 21 11:41:27 volumio kernel: tv_vout: TV mode 720p60hz selected. Apr 21 11:41:27 volumio kernel: vdac_enable: on:0,module_sel:8 Apr 21 11:41:27 volumio kernel: vdac_enable: on:0,module_sel:8 Apr 21 11:41:27 volumio kernel: tv_vout: new mode =720p60hz set ok Apr 21 11:41:27 volumio kernel: vout_serve: vinfo mode is: 720p60hz Apr 21 11:41:27 volumio kernel: vout_serve: new mode 720p60hz set ok Apr 21 11:41:27 volumio kernel: hdmitx: video: get current mode: 720p60hz Apr 21 11:41:27 volumio kernel: hdmitx: update rx hdr info 4 Apr 21 11:41:27 volumio kernel: hdmitx: update physcial size: 1440 810 Apr 21 11:41:27 volumio kernel: hdmitx: system: already init VIC = 0 Now VIC = 4 Apr 21 11:41:27 volumio kernel: hdmitx: rx has SCDC present indicator Apr 21 11:41:27 volumio kernel: hdmirx version is 2.0 Apr 21 11:41:27 volumio kernel: hdmitx div40: 0 Apr 21 11:41:27 volumio kernel: hdmitx: system: set mode VIC 4 (cd0,cs0,pm1,vd0,1) Apr 21 11:41:27 volumio kernel: hdmitx: system: set pll Apr 21 11:41:27 volumio kernel: hdmitx: system: param->VIC:4 Apr 21 11:41:27 volumio kernel: hdmitx: set clk: VIC = 4 cd = 4 frac_rate = 0 Apr 21 11:41:27 volumio kernel: config HPLL = 2970000 Apr 21 11:41:27 volumio kernel: HPLL: 0xc000027b Apr 21 11:41:27 volumio kernel: config HPLL done Apr 21 11:41:27 volumio kernel: set_hpll_od3_clk_div[437] div = 6 Apr 21 11:41:27 volumio kernel: j = 2 vid_clk_div = 1 Apr 21 11:41:27 volumio kernel: hdmitx: set enc for VIC: 4 Apr 21 11:41:27 volumio kernel: hdmitx_set_hw[4947] set VIC = 4 Apr 21 11:41:27 volumio kernel: hdmitx: system: irq 80000001 Apr 21 11:41:27 volumio kernel: Start = 0x10000100 End = 0x100001ff Apr 21 11:41:27 volumio kernel: [0x10000104]: 0x00000001 Apr 21 11:41:27 volumio kernel: [0x10000180]: 0x000000ff Apr 21 11:41:27 volumio kernel: [0x10000181]: 0x000000ff Apr 21 11:41:27 volumio kernel: [0x10000182]: 0x00000003 Apr 21 11:41:27 volumio kernel: [0x10000183]: 0x00000007 Apr 21 11:41:27 volumio kernel: [0x10000184]: 0x0000003f Apr 21 11:41:27 volumio kernel: [0x10000185]: 0x00000002 Apr 21 11:41:27 volumio kernel: [0x10000187]: 0x000000ff Apr 21 11:41:27 volumio kernel: [0x10000188]: 0x00000003 Apr 21 11:41:27 volumio kernel: hdmitx: system: irq 80000001 Apr 21 11:41:27 volumio kernel: Start = 0x10000100 End = 0x100001ff Apr 21 11:41:27 volumio kernel: [0x10000104]: 0x00000001 Apr 21 11:41:27 volumio kernel: [0x10000180]: 0x000000ff Apr 21 11:41:27 volumio kernel: [0x10000181]: 0x000000ff Apr 21 11:41:27 volumio kernel: [0x10000182]: 0x00000003 Apr 21 11:41:27 volumio kernel: [0x10000183]: 0x00000007 Apr 21 11:41:27 volumio kernel: [0x10000184]: 0x0000003f Apr 21 11:41:27 volumio kernel: [0x10000185]: 0x00000002 Apr 21 11:41:27 volumio kernel: [0x10000187]: 0x000000ff Apr 21 11:41:27 volumio kernel: [0x10000188]: 0x00000003 Apr 21 11:41:27 volumio kernel: hdmitx: system: PHY Setting Done Apr 21 11:41:27 volumio kernel: Sink is HDMI device Apr 21 11:41:27 volumio kernel: hdmitx: system: packet: can't get vendor data Apr 21 11:41:27 volumio kernel: 720p60hz 60 1 Apr 21 11:41:27 volumio kernel: 720p60hz 60 1 Apr 21 11:41:27 volumio kernel: hdmtix: set audio Apr 21 11:41:27 volumio kernel: hdmitx tx_aud_src = 0 Apr 21 11:41:27 volumio kernel: hdmitx: fs = 3, cd = 4, tmds_clk = 74250 Apr 21 11:41:27 volumio kernel: hdmitx aud_n_para = 6144 Apr 21 11:41:27 volumio kernel: hdmitx set channel status Apr 21 11:41:27 volumio kernel: hdmitx: audio: Audio Type: PCM Apr 21 11:41:27 volumio kernel: fb: current vmode=720p60hz, cmd: 0x10000 Apr 21 11:41:27 volumio systemd[1]: Starting LSB: Brings up/down network automatically... Apr 21 11:41:27 volumio systemd[1]: Starting LSB: Advanced IEEE 802.11 management daemon... Apr 21 11:41:27 volumio systemd[1]: Starting LSB: IPv4 DHCP client with IPv4LL support... Apr 21 11:41:27 volumio ntpd[4670]: ntpd 4.2.6p5@1.2349-o Fri Jul 22 17:59:22 UTC 2016 (1) Apr 21 11:41:27 volumio ntpd[4704]: proto: precision = 0.459 usec Apr 21 11:41:27 volumio ntpd[4704]: Listen and drop on 0 v4wildcard 0.0.0.0 UDP 123 Apr 21 11:41:27 volumio ntp[4644]: Starting NTP server: ntpd. Apr 21 11:41:27 volumio ntpd[4704]: Listen and drop on 1 v6wildcard :: UDP 123 Apr 21 11:41:27 volumio ntpd[4704]: Listen normally on 2 lo 127.0.0.1 UDP 123 Apr 21 11:41:27 volumio ntpd[4704]: peers refreshed Apr 21 11:41:27 volumio ntpd[4704]: Listening on routing socket on fd #19 for interface updates Apr 21 11:41:27 volumio kernel: fb: osd[0] enable: 1 (hdmi.sh) Apr 21 11:41:27 volumio kernel: fb: osd[1] enable: 0 (hdmi.sh) Apr 21 11:41:27 volumio systemd[1]: Starting Avahi mDNS/DNS-SD Stack... Apr 21 11:41:27 volumio systemd[1]: Starting Music Player Daemon... Apr 21 11:41:27 volumio systemd[1]: Starting D-Bus System Message Bus... Apr 21 11:41:27 volumio lirc[4699]: No valid /etc/lirc/lircd.conf has been found.. Apr 21 11:41:27 volumio lirc[4699]: Remote control support has been disabled.. Apr 21 11:41:27 volumio lirc[4699]: Reconfigure LIRC or manually replace /etc/lirc/lircd.conf to enable.. Apr 21 11:41:27 volumio systemd[1]: Started D-Bus System Message Bus. Apr 21 11:41:27 volumio dhcpcd[4709]: Not running dhcpcd because there is aleady an interface specific instance ... failed! Apr 21 11:41:27 volumio dhcpcd[4709]: /var/run/dhcpcd-eth0.pid ... failed! Apr 21 11:41:27 volumio ifplugd(eth0)[4730]: ifplugd 0.28 initializing. Apr 21 11:41:27 volumio ifplugd(eth0)[4730]: Using interface eth0/00:AC:2F:78:C0:FF with driver (version: March_2013) Apr 21 11:41:27 volumio ifplugd(eth0)[4730]: Using detection mode: SIOCETHTOOL Apr 21 11:41:27 volumio ifplugd(eth0)[4730]: Initialization complete, link beat detected. Apr 21 11:41:27 volumio avahi-daemon[4711]: Found user 'avahi' (UID 104) and group 'avahi' (GID 106). Apr 21 11:41:27 volumio avahi-daemon[4711]: Successfully dropped root privileges. Apr 21 11:41:27 volumio avahi-daemon[4711]: avahi-daemon 0.6.31 starting up. Apr 21 11:41:27 volumio ifplugd(eth0)[4730]: Executing '/etc/ifplugd/ifplugd.action eth0 up'. Apr 21 11:41:27 volumio ifplugd(eth0)[4730]: client: /sbin/ifup: interface eth0 already configured Apr 21 11:41:27 volumio sudo[4619]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 set power_save off Apr 21 11:41:27 volumio sudo[4619]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 11:41:27 volumio sudo[4619]: pam_unix(sudo:session): session closed for user root Apr 21 11:41:27 volumio avahi-daemon[4711]: Successfully called chroot(). Apr 21 11:41:27 volumio avahi-daemon[4711]: Successfully dropped remaining capabilities. Apr 21 11:41:27 volumio avahi-daemon[4711]: No service file found in /etc/avahi/services. Apr 21 11:41:27 volumio systemd[1]: Started Avahi mDNS/DNS-SD Stack. Apr 21 11:41:27 volumio avahi-daemon[4711]: Network interface enumeration completed. Apr 21 11:41:27 volumio avahi-daemon[4711]: Registering HINFO record with values 'AARCH64'/'LINUX'. Apr 21 11:41:27 volumio avahi-daemon[4711]: Server startup complete. Host name is volumio.local. Local service cookie is 3138477480. Apr 21 11:41:27 volumio systemd[1]: Starting Permit User Sessions... Apr 21 11:41:27 volumio ifplugd(eth0)[4730]: Program executed successfully. Apr 21 11:41:27 volumio systemd[1]: Started Restore Sound Card State. Apr 21 11:41:27 volumio ifplugd[4700]: Network Interface Plugging Daemon...start eth0...done. Apr 21 11:41:27 volumio systemd[1]: cd.service: main process exited, code=exited, status=127/n/a Apr 21 11:41:27 volumio systemd[1]: Unit cd.service entered failed state. Apr 21 11:41:27 volumio systemd[1]: Started /etc/rc.local Compatibility. Apr 21 11:41:27 volumio kernel: RTL871X: nolinked power save enter Apr 21 11:41:27 volumio systemd[1]: Started LSB: triggerhappy hotkey daemon. Apr 21 11:41:27 volumio systemd[1]: Started LSB: Start NTP daemon. Apr 21 11:41:28 volumio systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling. Apr 21 11:41:28 volumio systemd[1]: Started LSB: Starts LIRC daemon.. Apr 21 11:41:28 volumio systemd[1]: Started LSB: Brings up/down network automatically. Apr 21 11:41:28 volumio systemd[1]: Started LSB: Advanced IEEE 802.11 management daemon. Apr 21 11:41:28 volumio systemd[1]: dhcpcd.service: control process exited, code=exited status=6 Apr 21 11:41:28 volumio systemd[1]: Failed to start LSB: IPv4 DHCP client with IPv4LL support. Apr 21 11:41:28 volumio systemd[1]: Unit dhcpcd.service entered failed state. Apr 21 11:41:28 volumio systemd[1]: Started Permit User Sessions. Apr 21 11:41:28 volumio systemd[1]: cd.service holdoff time over, scheduling restart. Apr 21 11:41:28 volumio systemd-logind[4623]: New seat seat0. Apr 21 11:41:28 volumio systemd[1]: Started Login Service. Apr 21 11:41:28 volumio systemd[1]: Stopping cd.service... Apr 21 11:41:28 volumio systemd[1]: Starting cd.service... Apr 21 11:41:28 volumio systemd[1]: Started cd.service. Apr 21 11:41:28 volumio haveged[4602]: haveged: ver: 1.9.1; arch: generic; vend: ; build: (gcc 4.8.2 CTV); collect: 128K Apr 21 11:41:28 volumio haveged[4602]: haveged: cpu: (VC); data: 16K (D); inst: 16K (D); idx: 9/40; sz: 15780/68380 Apr 21 11:41:28 volumio haveged[4602]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 8.00157 Apr 21 11:41:28 volumio haveged[4602]: haveged: fills: 0, generated: 0 Apr 21 11:41:28 volumio systemd[1]: Starting LSB: set CPUFreq kernel parameters... Apr 21 11:41:28 volumio systemd[1]: Starting Wait for Plymouth Boot Screen to Quit... Apr 21 11:41:28 volumio volumio[4753]: /bin/bash: /volumio/app/plugins/music_service/cd_controller/cd.sh: No such file or directory Apr 21 11:41:28 volumio systemd[1]: Starting Terminate Plymouth Boot Screen... Apr 21 11:41:28 volumio systemd[1]: cd.service: main process exited, code=exited, status=127/n/a Apr 21 11:41:28 volumio systemd[1]: Unit cd.service entered failed state. Apr 21 11:41:28 volumio systemd[1]: Started Wait for Plymouth Boot Screen to Quit. Apr 21 11:41:28 volumio systemd[1]: Started Terminate Plymouth Boot Screen. Apr 21 11:41:28 volumio dbus[4716]: [system] Activating via systemd: service name='org.freedesktop.UDisks' unit='udisks.service' Apr 21 11:41:28 volumio systemd[1]: Starting Disk Manager (legacy version)... Apr 21 11:41:28 volumio systemd[1]: Starting Getty on tty1... Apr 21 11:41:28 volumio cpufrequtils[4754]: CPUFreq Utilities: Setting performance CPUFreq governor...CPU0...CPU1...CPU2...CPU3...done. Apr 21 11:41:28 volumio systemd[1]: Started Getty on tty1. Apr 21 11:41:28 volumio systemd[1]: Starting Serial Getty on ttyS0... Apr 21 11:41:28 volumio systemd[1]: Started Serial Getty on ttyS0. Apr 21 11:41:28 volumio systemd[1]: Starting Login Prompts. Apr 21 11:41:28 volumio systemd[1]: Reached target Login Prompts. Apr 21 11:41:28 volumio systemd[1]: Started LSB: set CPUFreq kernel parameters. Apr 21 11:41:28 volumio systemd[1]: cd.service holdoff time over, scheduling restart. Apr 21 11:41:28 volumio systemd[1]: Stopping cd.service... Apr 21 11:41:28 volumio systemd[1]: Starting cd.service... Apr 21 11:41:28 volumio systemd[1]: Started cd.service. Apr 21 11:41:28 volumio volumio[4774]: /bin/bash: /volumio/app/plugins/music_service/cd_controller/cd.sh: No such file or directory Apr 21 11:41:28 volumio systemd[1]: cd.service: main process exited, code=exited, status=127/n/a Apr 21 11:41:28 volumio systemd[1]: Unit cd.service entered failed state. Apr 21 11:41:28 volumio systemd[1]: cd.service holdoff time over, scheduling restart. Apr 21 11:41:28 volumio systemd[1]: Stopping cd.service... Apr 21 11:41:28 volumio dbus[4716]: [system] Successfully activated service 'org.freedesktop.UDisks' Apr 21 11:41:28 volumio systemd[1]: Starting cd.service... Apr 21 11:41:28 volumio systemd[1]: Started cd.service. Apr 21 11:41:28 volumio volumio[4777]: /bin/bash: /volumio/app/plugins/music_service/cd_controller/cd.sh: No such file or directory Apr 21 11:41:28 volumio systemd[1]: Started Disk Manager (legacy version). Apr 21 11:41:28 volumio systemd[1]: cd.service: main process exited, code=exited, status=127/n/a Apr 21 11:41:28 volumio systemd[1]: Unit cd.service entered failed state. Apr 21 11:41:28 volumio systemd[1]: cd.service holdoff time over, scheduling restart. Apr 21 11:41:28 volumio systemd[1]: Stopping cd.service... Apr 21 11:41:28 volumio dbus[4716]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkitd.service' Apr 21 11:41:28 volumio systemd[1]: Starting cd.service... Apr 21 11:41:28 volumio systemd[1]: Started cd.service. Apr 21 11:41:28 volumio volumio[4780]: /bin/bash: /volumio/app/plugins/music_service/cd_controller/cd.sh: No such file or directory Apr 21 11:41:28 volumio systemd[1]: cd.service: main process exited, code=exited, status=127/n/a Apr 21 11:41:28 volumio systemd[1]: Unit cd.service entered failed state. Apr 21 11:41:28 volumio systemd[1]: Starting Authenticate and Authorize Users to Run Privileged Tasks... Apr 21 11:41:28 volumio systemd[1]: cd.service holdoff time over, scheduling restart. Apr 21 11:41:28 volumio systemd[1]: Stopping cd.service... Apr 21 11:41:29 volumio systemd[1]: Starting cd.service... Apr 21 11:41:29 volumio systemd[1]: cd.service start request repeated too quickly, refusing to start. Apr 21 11:41:29 volumio systemd[1]: Failed to start cd.service. Apr 21 11:41:29 volumio systemd[1]: Unit cd.service entered failed state. Apr 21 11:41:29 volumio volumio-remote-updater[4609]: Error: No active session Apr 21 11:41:29 volumio volumio-remote-updater[4609]: [2024-04-21 11:41:29] [info] asio async_connect error: system:111 (Connection refused) Apr 21 11:41:29 volumio volumio-remote-updater[4609]: [2024-04-21 11:41:29] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Apr 21 11:41:29 volumio volumio-remote-updater[4609]: [2024-04-21 11:41:29] [error] handle_connect error: Underlying Transport Error Apr 21 11:41:29 volumio polkitd[4782]: started daemon version 0.105 using authority implementation `local' version `0.105' Apr 21 11:41:29 volumio dbus[4716]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Apr 21 11:41:29 volumio systemd[1]: Started Authenticate and Authorize Users to Run Privileged Tasks. Apr 21 11:41:29 volumio volumio[4608]: Could not open config: /tmp/upmpdcli.conf Apr 21 11:41:29 volumio udisks-glue[4607]: Device file /dev/sda3 inserted Apr 21 11:41:29 volumio systemd[1]: upmpdcli.service: main process exited, code=exited, status=1/FAILURE Apr 21 11:41:29 volumio systemd[1]: Unit upmpdcli.service entered failed state. Apr 21 11:41:29 volumio udisks-glue[4607]: Device file /dev/sda inserted Apr 21 11:41:29 volumio udisks-glue[4607]: Device file /dev/misc inserted Apr 21 11:41:29 volumio udisks-glue[4607]: Device file /dev/mmcblk0rpmb inserted Apr 21 11:41:29 volumio udisks-glue[4607]: Device file /dev/bootloader inserted Apr 21 11:41:29 volumio udisks-glue[4607]: Device file /dev/tee inserted Apr 21 11:41:29 volumio udisks-glue[4607]: Trying to automount /dev/tee... Apr 21 11:41:29 volumio kernel: EXT4-fs (mmcblk0p8): mounted filesystem with ordered data mode. Opts: (null) Apr 21 11:41:29 volumio udisks-glue[4607]: Successfully automounted /dev/tee at /media/57f8f4bc-abf4-655f-bf67-946fc0f9f25b Apr 21 11:41:29 volumio udisks-glue[4607]: Device file /dev/logo inserted Apr 21 11:41:29 volumio udisks-glue[4607]: Device file /dev/env inserted Apr 21 11:41:29 volumio udisks-glue[4607]: Device file /dev/boot inserted Apr 21 11:41:29 volumio udisks-glue[4607]: Device file /dev/mmcblk0boot0 inserted Apr 21 11:41:29 volumio udisks-glue[4607]: Device file /dev/mmcblk0boot1 inserted Apr 21 11:41:29 volumio udisks-glue[4607]: Device file /dev/recovery inserted Apr 21 11:41:29 volumio udisks-glue[4607]: Device file /dev/system inserted Apr 21 11:41:29 volumio udisks-glue[4607]: Trying to automount /dev/system... Apr 21 11:41:29 volumio kernel: EXT4-fs (mmcblk0p12): mounted filesystem with ordered data mode. Opts: (null) Apr 21 11:41:29 volumio udisks-glue[4607]: Successfully automounted /dev/system at /media/system Apr 21 11:41:29 volumio udisks-glue[4607]: Device file /dev/rsv inserted Apr 21 11:41:29 volumio udisks-glue[4607]: Device file /dev/cache inserted Apr 21 11:41:29 volumio udisks-glue[4607]: Trying to automount /dev/cache... Apr 21 11:41:29 volumio dhcpcd[4508]: eth0: offered 192.168.31.193 from 192.168.31.1 Apr 21 11:41:29 volumio ifup[4483]: dhcpcd[4508]: eth0: offered 192.168.31.193 from 192.168.31.1 Apr 21 11:41:29 volumio dhcpcd[4508]: eth0: ignoring offer of 192.168.31.193 from 192.168.31.1 Apr 21 11:41:29 volumio ifup[4483]: dhcpcd[4508]: eth0: ignoring offer of 192.168.31.193 from 192.168.31.1 Apr 21 11:41:29 volumio kernel: EXT4-fs (mmcblk0p3): mounted filesystem with ordered data mode. Opts: (null) Apr 21 11:41:29 volumio udisks-glue[4607]: Successfully automounted /dev/cache at /media/57f8f4bc-abf4-655f-bf67-946fc0f9f25b_ Apr 21 11:41:29 volumio dhcpcd[4508]: eth0: leased 192.168.31.193 for 43200 seconds Apr 21 11:41:29 volumio dhcpcd[4508]: eth0: adding host route to 192.168.31.193 via 127.0.0.1 Apr 21 11:41:29 volumio dhcpcd[4508]: eth0: adding route to 192.168.31.0/24 Apr 21 11:41:29 volumio dhcpcd[4508]: eth0: adding default route via 192.168.31.1 Apr 21 11:41:29 volumio avahi-daemon[4711]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.31.193. Apr 21 11:41:29 volumio avahi-daemon[4711]: New relevant interface eth0.IPv4 for mDNS. Apr 21 11:41:29 volumio avahi-daemon[4711]: Registering new address record for 192.168.31.193 on eth0.IPv4. Apr 21 11:41:29 volumio ifup[4483]: dhcpcd[4508]: eth0: leased 192.168.31.193 for 43200 seconds Apr 21 11:41:29 volumio ifup[4483]: dhcpcd[4508]: eth0: adding host route to 192.168.31.193 via 127.0.0.1 Apr 21 11:41:29 volumio ifup[4483]: dhcpcd[4508]: eth0: adding route to 192.168.31.0/24 Apr 21 11:41:29 volumio ifup[4483]: dhcpcd[4508]: eth0: adding default route via 192.168.31.1 Apr 21 11:41:29 volumio udisks-glue[4607]: Device file /dev/reserved inserted Apr 21 11:41:29 volumio udisks-glue[4607]: Device file /dev/crypt inserted Apr 21 11:41:29 volumio udisks-glue[4607]: Device file /dev/mmcblk0 inserted Apr 21 11:41:29 volumio udisks-glue[4607]: Device file /dev/data inserted Apr 21 11:41:29 volumio udisks-glue[4607]: Trying to automount /dev/data... Apr 21 11:41:29 volumio kernel: EXT4-fs (mmcblk0p13): mounted filesystem with ordered data mode. Opts: (null) Apr 21 11:41:29 volumio dhcpcd[4508]: forked to background, child pid 4824 Apr 21 11:41:29 volumio ifup[4483]: dhcpcd[4508]: forked to background, child pid 4824 Apr 21 11:41:29 volumio udisks-glue[4607]: Successfully automounted /dev/data at /media/57f8f4bc-abf4-655f-bf67-946fc0f9f25b__ Apr 21 11:41:29 volumio kernel: nf_conntrack: automatic helper assignment is deprecated and it will be removed soon. Use the iptables CT target to attach helpers instead. Apr 21 11:41:29 volumio udisks-glue[4607]: Device file /dev/tee mounted at /media/57f8f4bc-abf4-655f-bf67-946fc0f9f25b Apr 21 11:41:30 volumio udisks-glue[4607]: Device file /dev/system mounted at /media/system Apr 21 11:41:30 volumio udisks-glue[4607]: Device file /dev/cache mounted at /media/57f8f4bc-abf4-655f-bf67-946fc0f9f25b_ Apr 21 11:41:30 volumio udisks-glue[4607]: Device file /dev/data mounted at /media/57f8f4bc-abf4-655f-bf67-946fc0f9f25b__ Apr 21 11:41:30 volumio ntpd[4704]: Deferring DNS for 0.debian.pool.ntp.org 1 Apr 21 11:41:30 volumio ntpd[4852]: signal_no_reset: signal 17 had flags 4000000 Apr 21 11:41:31 volumio ntpd[4704]: Listen normally on 3 eth0 192.168.31.193 UDP 123 Apr 21 11:41:31 volumio ntpd[4704]: peers refreshed Apr 21 11:41:32 volumio ntpd_intres[4852]: DNS 0.debian.pool.ntp.org -> 209.58.185.100 Apr 21 11:41:32 volumio systemd[1]: Started LSB: start Samba daemons for the AD DC. Apr 21 11:41:32 volumio wireless.js[4741]: Cleaning previous... Apr 21 11:41:32 volumio systemd[1]: Stopped hotspot.service. Apr 21 11:41:32 volumio sudo[4912]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Apr 21 11:41:32 volumio sudo[4912]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 11:41:32 volumio sudo[4912]: pam_unix(sudo:session): session closed for user root Apr 21 11:41:32 volumio sudo[4916]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Apr 21 11:41:32 volumio sudo[4916]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 11:41:32 volumio sudo[4916]: pam_unix(sudo:session): session closed for user root Apr 21 11:41:32 volumio nmbd[4663]: Starting NetBIOS name server: nmbdmkdir failed on directory /var/log/samba/cores: No such file or directory Apr 21 11:41:32 volumio nmbd[4663]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Apr 21 11:41:32 volumio nmbd[4663]: Unable to setup corepath for nmbd: No such file or directory Apr 21 11:41:32 volumio nmbd[4914]: [2024/04/21 11:41:32.854345, 0] ../lib/util/debug.c:603(reopen_logs_internal) Apr 21 11:41:32 volumio nmbd[4914]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Apr 21 11:41:32 volumio nmbd[4663]: [2024/04/21 11:41:32, 0] ../lib/util/debug.c:603(reopen_logs_internal) Apr 21 11:41:32 volumio nmbd[4663]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Apr 21 11:41:32 volumio nmbd[4663]: [2024/04/21 11:41:32, 0] ../lib/util/debug.c:603(reopen_logs_internal) Apr 21 11:41:32 volumio nmbd[4663]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Apr 21 11:41:32 volumio nmbd[4663]: [2024/04/21 11:41:32, 0] ../source3/nmbd/nmbd.c:908(main) Apr 21 11:41:32 volumio nmbd[4663]: nmbd version 4.2.14-Debian started. Apr 21 11:41:32 volumio nmbd[4663]: Copyright Andrew Tridgell and the Samba Team 1992-2014 Apr 21 11:41:32 volumio nmbd[4663]: [2024/04/21 11:41:32.854345, 0] ../lib/util/debug.c:603(reopen_logs_internal) Apr 21 11:41:32 volumio nmbd[4663]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Apr 21 11:41:32 volumio winbind[4626]: Starting the Winbind daemon: winbindmkdir failed on directory /var/log/samba/cores: No such file or directory Apr 21 11:41:32 volumio winbind[4626]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Apr 21 11:41:32 volumio winbind[4626]: Unable to setup corepath for winbindd: No such file or directory Apr 21 11:41:32 volumio winbind[4626]: mkdir failed on directory /var/log/samba/cores: No such file or directory Apr 21 11:41:32 volumio winbind[4626]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Apr 21 11:41:32 volumio winbind[4626]: Unable to setup corepath for winbindd: No such file or directory Apr 21 11:41:32 volumio winbind[4626]: [2024/04/21 11:41:32, 0] ../lib/util/debug.c:603(reopen_logs_internal) Apr 21 11:41:32 volumio winbind[4626]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Apr 21 11:41:32 volumio winbind[4626]: [2024/04/21 11:41:32, 0] ../lib/util/debug.c:603(reopen_logs_internal) Apr 21 11:41:32 volumio winbind[4626]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Apr 21 11:41:32 volumio winbind[4626]: [2024/04/21 11:41:32, 0] ../source3/winbindd/winbindd.c:1549(main) Apr 21 11:41:32 volumio winbind[4626]: winbindd version 4.2.14-Debian started. Apr 21 11:41:32 volumio winbind[4626]: Copyright Andrew Tridgell and the Samba Team 1992-2014 Apr 21 11:41:32 volumio winbind[4626]: [2024/04/21 11:41:32, 0] ../lib/util/util.c:220(directory_create_or_exist) Apr 21 11:41:32 volumio winbind[4626]: mkdir failed on directory /var/log/samba/cores: No such file or directory Apr 21 11:41:32 volumio winbind[4626]: [2024/04/21 11:41:32, 0] ../source3/lib/dumpcore.c:59(get_default_corepath) Apr 21 11:41:32 volumio winbind[4626]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Apr 21 11:41:32 volumio winbind[4626]: [2024/04/21 11:41:32, 0] ../source3/lib/dumpcore.c:250(dump_core_setup) Apr 21 11:41:32 volumio winbind[4626]: Unable to setup corepath for winbindd: No such file or directory Apr 21 11:41:32 volumio systemd[1]: nmbd.service: control process exited, code=exited status=1 Apr 21 11:41:32 volumio systemd[1]: Failed to start LSB: start Samba NetBIOS nameserver (nmbd). Apr 21 11:41:32 volumio systemd[1]: Unit nmbd.service entered failed state. Apr 21 11:41:32 volumio systemd[1]: Starting LSB: start Samba SMB/CIFS daemon (smbd)... Apr 21 11:41:32 volumio wireless.js[4741]: Stopped aP Apr 21 11:41:32 volumio nmbd[4663]: failed! Apr 21 11:41:32 volumio winbind[4626]: [2024/04/21 11:41:32, 0] ../source3/lib/util.c:788(smb_panic_s3) Apr 21 11:41:32 volumio winbind[4626]: PANIC (pid 4908): Could not init winbindd's messaging context. Apr 21 11:41:32 volumio winbind[4626]: [2024/04/21 11:41:32, 0] ../source3/lib/util.c:899(log_stack_trace) Apr 21 11:41:32 volumio winbind[4626]: BACKTRACE: 0 stack frames: Apr 21 11:41:32 volumio winbind[4626]: [2024/04/21 11:41:32, 0] ../source3/lib/dumpcore.c:304(dump_core) Apr 21 11:41:32 volumio winbind[4626]: Can not dump core: corepath not set up Apr 21 11:41:32 volumio winbind[4626]: failed! Apr 21 11:41:32 volumio systemd[1]: winbind.service: control process exited, code=exited status=1 Apr 21 11:41:32 volumio systemd[1]: Failed to start LSB: start Winbind daemon. Apr 21 11:41:32 volumio systemd[1]: Unit winbind.service entered failed state. Apr 21 11:41:32 volumio systemd[1]: Stopped hotspot.service. Apr 21 11:41:33 volumio sudo[4935]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Apr 21 11:41:33 volumio sudo[4935]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 11:41:33 volumio sudo[4935]: pam_unix(sudo:session): session closed for user root Apr 21 11:41:33 volumio sudo[4937]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Apr 21 11:41:33 volumio sudo[4937]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 11:41:33 volumio sudo[4937]: pam_unix(sudo:session): session closed for user root Apr 21 11:41:33 volumio avahi-daemon[4711]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.211.1. Apr 21 11:41:33 volumio avahi-daemon[4711]: New relevant interface wlan0.IPv4 for mDNS. Apr 21 11:41:33 volumio avahi-daemon[4711]: Registering new address record for 192.168.211.1 on wlan0.IPv4. Apr 21 11:41:33 volumio kernel: IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready Apr 21 11:41:33 volumio systemd[1]: Starting hotspot.service... Apr 21 11:41:33 volumio systemd[1]: Started hotspot.service. Apr 21 11:41:33 volumio systemd[1]: Starting dhcpd.service... Apr 21 11:41:33 volumio systemd[1]: Starting dnsmasq.service... Apr 21 11:41:33 volumio systemd[1]: Started Wireless Services. Apr 21 11:41:33 volumio systemd[1]: Starting Volumio Backend Module... Apr 21 11:41:33 volumio systemd[1]: Started Volumio Backend Module. Apr 21 11:41:33 volumio systemd[1]: Starting Volumio Streaming Daemon... Apr 21 11:41:33 volumio systemd[1]: Started Volumio Streaming Daemon. Apr 21 11:41:33 volumio dnsmasq[4955]: started, version 2.72 cachesize 150 Apr 21 11:41:33 volumio dnsmasq[4955]: compile time options: IPv6 GNU-getopt DBus i18n IDN DHCP DHCPv6 no-Lua TFTP conntrack ipset auth DNSSEC loop-detect Apr 21 11:41:33 volumio dnsmasq[4955]: reading /etc/resolv.conf Apr 21 11:41:33 volumio dnsmasq[4955]: using nameserver 192.168.31.1#53 Apr 21 11:41:33 volumio systemd[1]: Started dnsmasq.service. Apr 21 11:41:33 volumio dnsmasq[4955]: using nameserver 208.67.222.222#53 Apr 21 11:41:33 volumio dnsmasq[4955]: using nameserver 208.67.220.220#53 Apr 21 11:41:33 volumio dnsmasq[4955]: read /etc/hosts - 4 addresses Apr 21 11:41:33 volumio systemd[1]: Starting Host and Network Name Lookups. Apr 21 11:41:33 volumio systemd[1]: Reached target Host and Network Name Lookups. Apr 21 11:41:33 volumio kernel: meson_uart c81004c0.serial: ttyS0 use xtal(8M) 24000000 change 115200 to 115200 Apr 21 11:41:33 volumio dhcpd[4944]: Internet Systems Consortium DHCP Server 4.3.1 Apr 21 11:41:33 volumio dhcpd[4944]: Copyright 2004-2014 Internet Systems Consortium. Apr 21 11:41:33 volumio dhcpd[4944]: All rights reserved. Apr 21 11:41:33 volumio dhcpd[4944]: For info, please visit https://www.isc.org/software/dhcp/ Apr 21 11:41:33 volumio dhcpd[4944]: Config file: /etc/dhcp/dhcpd.conf Apr 21 11:41:33 volumio dhcpd[4944]: Database file: /var/lib/dhcp/dhcpd.leases Apr 21 11:41:33 volumio dhcpd[4944]: PID file: /var/run/dhcpd.pid Apr 21 11:41:33 volumio hotspot[4944]: Internet Systems Consortium DHCP Server 4.3.1 Apr 21 11:41:33 volumio hotspot[4944]: Copyright 2004-2014 Internet Systems Consortium. Apr 21 11:41:33 volumio hotspot[4944]: All rights reserved. Apr 21 11:41:33 volumio hotspot[4944]: For info, please visit https://www.isc.org/software/dhcp/ Apr 21 11:41:33 volumio hotspot[4944]: Config file: /etc/dhcp/dhcpd.conf Apr 21 11:41:33 volumio hotspot[4944]: Database file: /var/lib/dhcp/dhcpd.leases Apr 21 11:41:33 volumio hotspot[4944]: PID file: /var/run/dhcpd.pid Apr 21 11:41:33 volumio kernel: meson_uart c81004c0.serial: ttyS0 use xtal(8M) 24000000 change 115200 to 115200 Apr 21 11:41:33 volumio kernel: meson_uart c81004c0.serial: ttyS0 use xtal(8M) 24000000 change 115200 to 115200 Apr 21 11:41:33 volumio kernel: meson_uart c81004c0.serial: ttyS0 use xtal(8M) 24000000 change 115200 to 115200 Apr 21 11:41:33 volumio dhcpd[4944]: Internet Systems Consortium DHCP Server 4.3.1 Apr 21 11:41:33 volumio dhcpd[4944]: Copyright 2004-2014 Internet Systems Consortium. Apr 21 11:41:33 volumio dhcpd[4944]: All rights reserved. Apr 21 11:41:33 volumio dhcpd[4944]: For info, please visit https://www.isc.org/software/dhcp/ Apr 21 11:41:33 volumio dhcpd[4944]: Wrote 0 leases to leases file. Apr 21 11:41:33 volumio hotspot[4944]: Wrote 0 leases to leases file. Apr 21 11:41:33 volumio hotspot[4943]: Launching Ordinary Hostapd Apr 21 11:41:33 volumio dhcpd[4944]: Listening on LPF/wlan0/00:2d:f4:5b:0e:77/192.168.211.0/24 Apr 21 11:41:33 volumio dhcpd[4944]: Sending on LPF/wlan0/00:2d:f4:5b:0e:77/192.168.211.0/24 Apr 21 11:41:33 volumio dhcpd[4944]: Apr 21 11:41:33 volumio dhcpd[4944]: No subnet declaration for eth0 (192.168.31.193). Apr 21 11:41:33 volumio dhcpd[4944]: ** Ignoring requests on eth0. If this is not what Apr 21 11:41:33 volumio dhcpd[4944]: you want, please write a subnet declaration Apr 21 11:41:33 volumio dhcpd[4944]: in your dhcpd.conf file for the network segment Apr 21 11:41:33 volumio dhcpd[4944]: to which interface eth0 is attached. ** Apr 21 11:41:33 volumio dhcpd[4944]: Apr 21 11:41:33 volumio dhcpd[4944]: Sending on Socket/fallback/fallback-net Apr 21 11:41:33 volumio systemd[1]: Started dhcpd.service. Apr 21 11:41:33 volumio hotspot[4944]: Listening on LPF/wlan0/00:2d:f4:5b:0e:77/192.168.211.0/24 Apr 21 11:41:33 volumio hotspot[4944]: Sending on LPF/wlan0/00:2d:f4:5b:0e:77/192.168.211.0/24 Apr 21 11:41:33 volumio hotspot[4944]: No subnet declaration for eth0 (192.168.31.193). Apr 21 11:41:33 volumio hotspot[4944]: ** Ignoring requests on eth0. If this is not what Apr 21 11:41:33 volumio hotspot[4944]: you want, please write a subnet declaration Apr 21 11:41:33 volumio hotspot[4944]: in your dhcpd.conf file for the network segment Apr 21 11:41:33 volumio hotspot[4944]: to which interface eth0 is attached. ** Apr 21 11:41:33 volumio hotspot[4944]: Sending on Socket/fallback/fallback-net Apr 21 11:41:33 volumio dhcpd[4981]: Server starting service. Apr 21 11:41:33 volumio hotspot[4943]: Configuration file: /etc/hostapd/hostapd.conf Apr 21 11:41:33 volumio hotspot[4943]: Interface name not specified in /etc/hostapd/hostapd.conf Apr 21 11:41:33 volumio hotspot[4943]: hostapd_free_hapd_data: Interface wasn't started Apr 21 11:41:33 volumio hotspot[4943]: Failed to initialize interface Apr 21 11:41:33 volumio systemd[1]: hotspot.service: main process exited, code=exited, status=1/FAILURE Apr 21 11:41:33 volumio systemd[1]: Stopping dhcpd.service... Apr 21 11:41:33 volumio systemd[1]: Stopping Host and Network Name Lookups. Apr 21 11:41:33 volumio systemd[1]: Stopped target Host and Network Name Lookups. Apr 21 11:41:33 volumio systemd[1]: Stopping dnsmasq.service... Apr 21 11:41:33 volumio dnsmasq[4955]: exiting on receipt of SIGTERM Apr 21 11:41:33 volumio systemd[1]: Stopped dnsmasq.service. Apr 21 11:41:33 volumio volumio-streaming-daemon[4953]: ############################ Apr 21 11:41:33 volumio volumio-streaming-daemon[4953]: # Volumio Streaming Daemon # Apr 21 11:41:33 volumio systemd[1]: Stopped dhcpd.service. Apr 21 11:41:33 volumio volumio-streaming-daemon[4953]: # Running on port 7777 # Apr 21 11:41:33 volumio volumio-streaming-daemon[4953]: ############################ Apr 21 11:41:33 volumio hotspot[4983]: Killing Hostapd Apr 21 11:41:33 volumio volumio-streaming-daemon[4953]: Environment: production Apr 21 11:41:33 volumio sudo[4993]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall hostapd Apr 21 11:41:33 volumio sudo[4993]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 11:41:33 volumio hotspot[4983]: hostapd: no process found Apr 21 11:41:33 volumio sudo[4993]: pam_unix(sudo:session): session closed for user root Apr 21 11:41:33 volumio hotspot[4983]: Killing Dhcpd Apr 21 11:41:33 volumio sudo[4995]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall dhcpd Apr 21 11:41:33 volumio sudo[4995]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 11:41:33 volumio hotspot[4983]: dhcpd: no process found Apr 21 11:41:33 volumio sudo[4995]: pam_unix(sudo:session): session closed for user root Apr 21 11:41:33 volumio systemd[1]: hotspot.service: control process exited, code=exited status=1 Apr 21 11:41:33 volumio systemd[1]: Unit hotspot.service entered failed state. Apr 21 11:41:33 volumio systemd[1]: Started Music Player Daemon. Apr 21 11:41:34 volumio udisks-glue[4607]: Updating DB (#1) ... Apr 21 11:41:34 volumio udisks-glue[4607]: volume: n/a repeat: off random: off single: off consume: off Apr 21 11:41:34 volumio udisks-glue[4607]: Updating DB (#1) ... Apr 21 11:41:34 volumio udisks-glue[4607]: volume: n/a repeat: off random: off single: off consume: off Apr 21 11:41:34 volumio udisks-glue[4607]: Updating DB (#1) ... Apr 21 11:41:34 volumio udisks-glue[4607]: volume: n/a repeat: off random: off single: off consume: off Apr 21 11:41:34 volumio udisks-glue[4607]: Updating DB (#1) ... Apr 21 11:41:34 volumio udisks-glue[4607]: volume: n/a repeat: off random: off single: off consume: off Apr 21 11:41:34 volumio volumio-remote-updater[4609]: [2024-04-21 11:41:34] [info] asio async_connect error: system:111 (Connection refused) Apr 21 11:41:34 volumio volumio-remote-updater[4609]: [2024-04-21 11:41:34] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Apr 21 11:41:34 volumio volumio-remote-updater[4609]: [2024-04-21 11:41:34] [error] handle_connect error: Underlying Transport Error Apr 21 11:41:34 volumio smbd[4924]: Starting SMB/CIFS daemon: smbd[2024/04/21 11:41:34, 0] ../lib/util/debug.c:603(reopen_logs_internal) Apr 21 11:41:34 volumio smbd[4924]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Apr 21 11:41:34 volumio smbd[4924]: [2024/04/21 11:41:34, 0] ../lib/util/util.c:220(directory_create_or_exist) Apr 21 11:41:34 volumio smbd[4924]: mkdir failed on directory /var/log/samba/cores: No such file or directory Apr 21 11:41:34 volumio smbd[4924]: [2024/04/21 11:41:34, 0] ../source3/lib/dumpcore.c:59(get_default_corepath) Apr 21 11:41:34 volumio smbd[4924]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Apr 21 11:41:34 volumio smbd[4924]: [2024/04/21 11:41:34, 0] ../source3/lib/dumpcore.c:250(dump_core_setup) Apr 21 11:41:34 volumio smbd[4924]: Unable to setup corepath for smbd: No such file or directory Apr 21 11:41:34 volumio smbd[4924]: [2024/04/21 11:41:34, 0] ../lib/util/debug.c:603(reopen_logs_internal) Apr 21 11:41:34 volumio smbd[4924]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Apr 21 11:41:34 volumio smbd[4924]: [2024/04/21 11:41:34, 0] ../source3/smbd/server.c:1241(main) Apr 21 11:41:34 volumio smbd[4924]: smbd version 4.2.14-Debian started. Apr 21 11:41:34 volumio smbd[4924]: Copyright Andrew Tridgell and the Samba Team 1992-2014 Apr 21 11:41:34 volumio smbd[4924]: failed! Apr 21 11:41:34 volumio systemd[1]: smbd.service: control process exited, code=exited status=1 Apr 21 11:41:34 volumio systemd[1]: Failed to start LSB: start Samba SMB/CIFS daemon (smbd). Apr 21 11:41:34 volumio systemd[1]: Unit smbd.service entered failed state. Apr 21 11:41:34 volumio systemd[1]: Starting Multi-User System. Apr 21 11:41:34 volumio systemd[1]: Reached target Multi-User System. Apr 21 11:41:34 volumio systemd[1]: Starting Graphical Interface. Apr 21 11:41:34 volumio systemd[1]: Reached target Graphical Interface. Apr 21 11:41:34 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... Apr 21 11:41:34 volumio systemd[1]: Started Update UTMP about System Runlevel Changes. Apr 21 11:41:34 volumio systemd[1]: Startup finished in 16.245s (kernel) + 1min 11.052s (userspace) = 1min 27.297s. Apr 21 11:41:34 volumio ntpd[4704]: Listen normally on 4 wlan0 192.168.211.1 UDP 123 Apr 21 11:41:34 volumio ntpd[4704]: peers refreshed Apr 21 11:41:36 volumio volumio[4948]: info: ------------------------------------------- Apr 21 11:41:36 volumio volumio[4948]: info: ----- Volumio2 ---- Apr 21 11:41:36 volumio volumio[4948]: info: ------------------------------------------- Apr 21 11:41:36 volumio volumio[4948]: info: ----- System startup ---- Apr 21 11:41:36 volumio volumio[4948]: info: ------------------------------------------- Apr 21 11:41:38 volumio volumio[4948]: info: MYVOLUMIO Environment detected Apr 21 11:41:38 volumio volumio[4948]: info: Plugin folders cleanup Apr 21 11:41:38 volumio volumio[4948]: info: Scanning into folder /volumio/app/plugins/ Apr 21 11:41:38 volumio volumio[4948]: info: Scanning category audio_interface Apr 21 11:41:38 volumio volumio[4948]: info: Scanning category miscellanea Apr 21 11:41:38 volumio volumio[4948]: info: Scanning category music_service Apr 21 11:41:38 volumio volumio[4948]: info: Scanning category plugins.json Apr 21 11:41:38 volumio volumio[4948]: info: Scanning category system_controller Apr 21 11:41:38 volumio volumio[4948]: info: Scanning category user_interface Apr 21 11:41:38 volumio volumio[4948]: info: Scanning into folder /data/plugins/ Apr 21 11:41:38 volumio volumio[4948]: info: Scanning category miscellanea Apr 21 11:41:38 volumio volumio[4948]: info: Plugin folders cleanup completed Apr 21 11:41:38 volumio volumio[4948]: info: ------------------------------------------- Apr 21 11:41:38 volumio volumio[4948]: info: ----- Core plugins startup ---- Apr 21 11:41:38 volumio volumio[4948]: info: ------------------------------------------- Apr 21 11:41:38 volumio volumio[4948]: info: Loading plugins from folder /volumio/app/plugins/ Apr 21 11:41:38 volumio volumio[4948]: info: Adding plugin upnp to MyMusic Plugins Apr 21 11:41:38 volumio volumio[4948]: info: Adding plugin airplay_emulation to MyMusic Plugins Apr 21 11:41:38 volumio volumio[4948]: info: Adding plugin upnp_browser to MyMusic Plugins Apr 21 11:41:38 volumio volumio[4948]: info: Loading plugins from folder /data/plugins/ Apr 21 11:41:38 volumio volumio[4948]: info: Loading plugin "system"... Apr 21 11:41:38 volumio volumio[4948]: info: Loading plugin "appearance"... Apr 21 11:41:52 volumio systemd[1]: Time has been changed Apr 21 11:41:52 volumio volumio[4948]: info: Loading plugin "network"... Apr 21 11:41:52 volumio volumio[4948]: info: Refreshing Cached IP Addresses Apr 21 11:41:52 volumio sudo[5028]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 21 11:41:52 volumio sudo[5028]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 11:41:52 volumio volumio[4948]: info: Loading plugin "touch_display"... Apr 21 11:41:52 volumio sudo[5028]: pam_unix(sudo:session): session closed for user root Apr 21 11:41:52 volumio sudo[5031]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 21 11:41:52 volumio sudo[5031]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 11:41:52 volumio sudo[5031]: pam_unix(sudo:session): session closed for user root Apr 21 11:41:53 volumio volumio[4948]: info: Applying required configuration parameters for plugin touch_display Apr 21 11:41:54 volumio volumio-remote-updater[4609]: [2024-04-21 11:41:54] [connect] Successful connection Apr 21 11:41:54 volumio volumio[4948]: info: Loading plugin "services"... Apr 21 11:41:54 volumio volumio[4948]: info: Loading plugin "alsa_controller"... Apr 21 11:41:54 volumio volumio[4948]: Invalid card number. Apr 21 11:41:54 volumio volumio[4948]: info: Hardware Mixer selected but no Hardware mixer available, detecting default mixer Apr 21 11:41:54 volumio volumio[4948]: Home directory not accessible: Permission denied Apr 21 11:41:54 volumio volumio[4948]: W: [pulseaudio] core-util.c: Failed to open configuration file '/home/volumio/.config/pulse//daemon.conf': Permission denied Apr 21 11:41:54 volumio volumio[4948]: W: [pulseaudio] daemon-conf.c: Failed to open configuration file: Permission denied Apr 21 11:41:54 volumio volumio[4948]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 21 11:41:54 volumio volumio[4948]: Invalid card number. Apr 21 11:41:54 volumio volumio[4948]: Home directory not accessible: Permission denied Apr 21 11:41:54 volumio volumio[4948]: W: [pulseaudio] core-util.c: Failed to open configuration file '/home/volumio/.config/pulse//daemon.conf': Permission denied Apr 21 11:41:54 volumio volumio[4948]: W: [pulseaudio] daemon-conf.c: Failed to open configuration file: Permission denied Apr 21 11:41:54 volumio volumio[4948]: info: CoreCommandRouter::volumioUpdateVolumeSettings Apr 21 11:41:54 volumio volumio[4948]: info: Loading plugin "wizard"... Apr 21 11:41:54 volumio volumio[4948]: info: Loading plugin "volumio_command_line_client"... Apr 21 11:41:54 volumio volumio[4948]: info: Loading plugin "upnp"... Apr 21 11:41:54 volumio volumio[4948]: info: [1713699714569] Starting Upmpd Daemon Apr 21 11:41:54 volumio volumio[4948]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 21 11:41:54 volumio volumio[4948]: info: Loading plugin "my_music"... Apr 21 11:41:54 volumio volumio[4948]: info: Loading plugin "mpd"... Apr 21 11:41:55 volumio volumio[4948]: info: Loading plugin "upnp_browser"... Apr 21 11:41:56 volumio volumio[4948]: info: Loading plugin "networkfs"... Apr 21 11:41:56 volumio volumio[4948]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 21 11:41:56 volumio volumio[4948]: info: Loading plugin "alarm-clock"... Apr 21 11:41:56 volumio sudo[5053]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=BG4BWN,password=ZHANGjun19790130,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.31.210/音乐 /mnt/NAS/BG4BWN-OMV-NAS Apr 21 11:41:56 volumio sudo[5053]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 11:41:56 volumio volumio[4948]: info: Loading plugin "airplay_emulation"... Apr 21 11:41:56 volumio volumio[4948]: info: Starting Shairport Sync Apr 21 11:41:56 volumio volumio[4948]: info: Loading plugin "last_100"... Apr 21 11:41:56 volumio volumio[4948]: info: Loading plugin "webradio"... Apr 21 11:41:56 volumio volumio[4948]: info: Loading plugin "i2s_dacs"... Apr 21 11:41:56 volumio volumio[4948]: info: I2S DAC not set, start Auto-detection Apr 21 11:41:56 volumio volumio[4948]: info: Loading plugin "volumiodiscovery"... Apr 21 11:41:56 volumio volumio[4948]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 21 11:41:56 volumio node[4948]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 21 11:41:56 volumio node[4948]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 21 11:41:56 volumio node[4948]: *** WARNING *** For more information see Apr 21 11:41:56 volumio node[4948]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 21 11:41:56 volumio node[4948]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 21 11:41:56 volumio node[4948]: *** WARNING *** For more information see Apr 21 11:41:56 volumio volumio[4948]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 21 11:41:56 volumio volumio[4948]: *** WARNING *** For more information see Apr 21 11:41:56 volumio volumio[4948]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 21 11:41:56 volumio volumio[4948]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 21 11:41:56 volumio volumio[4948]: *** WARNING *** For more information see Apr 21 11:41:56 volumio volumio[4948]: info: Applying required configuration parameters for plugin volumiodiscovery Apr 21 11:41:56 volumio volumio[4948]: Configuration write error: Error: EACCES: permission denied, open '/data/configuration/system_controller/volumiodiscovery/config.json' Apr 21 11:41:56 volumio volumio[4948]: Discovery: StartAdv! undefined Apr 21 11:41:56 volumio volumio[4948]: Discovery: Started advertising... Volumio - undefined Apr 21 11:41:56 volumio volumio[4948]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 21 11:41:56 volumio volumio[4948]: info: Loading plugin "outputs"... Apr 21 11:41:56 volumio volumio[4948]: info: Loading plugin "albumart"... Apr 21 11:41:57 volumio volumio[4948]: info: Plugin example_plugin is not enabled Apr 21 11:41:57 volumio volumio[4948]: info: Loading plugin "inputs"... Apr 21 11:41:57 volumio volumio[4948]: info: Loading plugin "updater_comm"... Apr 21 11:41:57 volumio volumio[4948]: info: Plugin mpdemulation is not enabled Apr 21 11:41:57 volumio volumio[4948]: info: Loading plugin "rest_api"... Apr 21 11:41:57 volumio volumio[4948]: info: Loading plugin "websocket"... Apr 21 11:41:57 volumio volumio[4948]: info: Loading plugin "minidlna"... Apr 21 11:41:57 volumio volumio[4948]: Forking 3 albumart workers Apr 21 11:41:57 volumio volumio[4948]: info: Applying required configuration parameters for plugin minidlna Apr 21 11:41:58 volumio volumio[4948]: info: ___________ START PLUGINS ___________ Apr 21 11:41:58 volumio volumio[4948]: info: Loading i18n strings for locale zh Apr 21 11:41:58 volumio volumio[4948]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 21 11:41:58 volumio volumio[4948]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 21 11:41:58 volumio volumio[4948]: info: [1713699718340] CoreMusicLibrary::Adding element Media Servers Apr 21 11:41:58 volumio volumio[4948]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 21 11:41:58 volumio sudo[5090]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Apr 21 11:41:58 volumio sudo[5090]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 11:41:58 volumio systemd[1]: Reloading. Apr 21 11:41:58 volumio volumio[4948]: Home directory not accessible: Permission denied Apr 21 11:41:58 volumio volumio[4948]: W: [pulseaudio] core-util.c: Failed to open configuration file '/home/volumio/.config/pulse//daemon.conf': Permission denied Apr 21 11:41:58 volumio volumio[4948]: W: [pulseaudio] daemon-conf.c: Failed to open configuration file: Permission denied Apr 21 11:41:58 volumio volumio[4948]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 21 11:41:58 volumio volumio[4948]: Home directory not accessible: Permission denied Apr 21 11:41:58 volumio volumio[4948]: W: [pulseaudio] core-util.c: Failed to open configuration file '/home/volumio/.config/pulse//daemon.conf': Permission denied Apr 21 11:41:58 volumio volumio[4948]: W: [pulseaudio] daemon-conf.c: Failed to open configuration file: Permission denied Apr 21 11:41:58 volumio systemd[1]: [/lib/systemd/system/mpd.service:18] Unknown lvalue 'ProtectKernelTunables' in section 'Service' Apr 21 11:41:58 volumio systemd[1]: [/lib/systemd/system/mpd.service:19] Unknown lvalue 'ProtectControlGroups' in section 'Service' Apr 21 11:41:58 volumio systemd[1]: [/lib/systemd/system/mpd.service:20] Unknown lvalue 'ProtectKernelModules' in section 'Service' Apr 21 11:41:58 volumio systemd[1]: [/lib/systemd/system/mpd.service:23] Unknown lvalue 'RestrictNamespaces' in section 'Service' Apr 21 11:41:58 volumio volumio[4948]: Starting albumart workers Apr 21 11:41:58 volumio volumio[4948]: Starting albumart workers Apr 21 11:41:58 volumio volumio[4948]: Starting albumart workers Apr 21 11:41:58 volumio volumio[4948]: Home directory not accessible: Permission denied Apr 21 11:41:58 volumio volumio[4948]: W: [pulseaudio] core-util.c: Failed to open configuration file '/home/volumio/.config/pulse//daemon.conf': Permission denied Apr 21 11:41:58 volumio volumio[4948]: W: [pulseaudio] daemon-conf.c: Failed to open configuration file: Permission denied Apr 21 11:41:58 volumio volumio[4948]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 21 11:41:58 volumio volumio[4948]: Home directory not accessible: Permission denied Apr 21 11:41:58 volumio volumio[4948]: W: [pulseaudio] core-util.c: Failed to open configuration file '/home/volumio/.config/pulse//daemon.conf': Permission denied Apr 21 11:41:58 volumio volumio[4948]: W: [pulseaudio] daemon-conf.c: Failed to open configuration file: Permission denied Apr 21 11:41:58 volumio volumio[4948]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 21 11:41:58 volumio volumio[4948]: info: [1713699718967] CoreMusicLibrary::Adding element Last_100 Apr 21 11:41:58 volumio volumio[4948]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 21 11:41:58 volumio volumio[4948]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 21 11:41:58 volumio volumio[4948]: info: [1713699718985] CoreMusicLibrary::Adding element Webradio Apr 21 11:41:58 volumio volumio[4948]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 21 11:41:59 volumio volumio[4948]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 21 11:41:59 volumio volumio[4948]: info: Loading i18n strings for locale zh Apr 21 11:41:59 volumio volumio[4948]: info: ------------------------------------------- Apr 21 11:41:59 volumio volumio[4948]: info: ----- MyVolumio plugins startup ---- Apr 21 11:41:59 volumio volumio[4948]: info: ------------------------------------------- Apr 21 11:41:59 volumio volumio[4948]: info: [MyVolumio PluginManager] Fetching plans data.... Apr 21 11:41:59 volumio volumio[4948]: info: Loading i18n strings for locale zh Apr 21 11:41:59 volumio volumio[4948]: Updating browse sources language Apr 21 11:41:59 volumio volumio[4948]: Cannot find translation for sourceMedia Servers Apr 21 11:41:59 volumio volumio[4948]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 21 11:41:59 volumio volumio[4948]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 21 11:41:59 volumio volumio[4948]: info: CoreCommandRouter::initPlayerControls Apr 21 11:41:59 volumio volumio[4948]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 11:41:59 volumio volumio[4948]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Apr 21 11:41:59 volumio volumio[4948]: Home directory not accessible: Permission denied Apr 21 11:41:59 volumio volumio[4948]: W: [pulseaudio] core-util.c: Failed to open configuration file '/home/volumio/.config/pulse//daemon.conf': Permission denied Apr 21 11:41:59 volumio volumio[4948]: W: [pulseaudio] daemon-conf.c: Failed to open configuration file: Permission denied Apr 21 11:41:59 volumio volumio[4948]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 11:41:59 volumio volumio[4948]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 11:41:59 volumio volumio[4948]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 11:41:59 volumio volumio[4948]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 11:41:59 volumio volumio[4948]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 21 11:41:59 volumio volumio[4948]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 21 11:41:59 volumio volumio[4948]: info: BOOT COMPLETED Apr 21 11:41:59 volumio volumio[4948]: [Metrics] CommandRouter: 10s 128.75ms Apr 21 11:41:59 volumio volumio[4948]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 21 11:41:59 volumio sudo[5090]: pam_unix(sudo:session): session closed for user root Apr 21 11:41:59 volumio volumio[4948]: Home directory not accessible: Permission denied Apr 21 11:41:59 volumio volumio[4948]: W: [pulseaudio] core-util.c: Failed to open configuration file '/home/volumio/.config/pulse//daemon.conf': Permission denied Apr 21 11:41:59 volumio volumio[4948]: W: [pulseaudio] daemon-conf.c: Failed to open configuration file: Permission denied Apr 21 11:41:59 volumio volumio[4948]: ALSA lib pcm_hw.c:1713:(_snd_pcm_hw_open) Invalid value for card Apr 21 11:41:59 volumio volumio[4948]: aplay: main:722: audio open error: No such file or directory Apr 21 11:41:59 volumio volumio[4948]: Cannot play startup sound Apr 21 11:41:59 volumio volumio[4948]: info: CoreCommandRouter::Close All Modals sent Apr 21 11:41:59 volumio volumio[4948]: info: CoreCommandRouter::Close All Modals sent Apr 21 11:41:59 volumio volumio[4948]: Express server listening on port 3000 Apr 21 11:41:59 volumio volumio[4948]: [Metrics] WebUI: 11s 312.74ms Apr 21 11:41:59 volumio volumio[4948]: Volumio Calling Home Apr 21 11:41:59 volumio volumio[4948]: info: CoreStateMachine::resetVolumioState Apr 21 11:41:59 volumio volumio[4948]: info: CoreStateMachine::getcurrentVolume Apr 21 11:41:59 volumio volumio[4948]: info: CoreCommandRouter::volumioRetrievevolume Apr 21 11:42:00 volumio volumio[4948]: Configuration write error: Error: EACCES: permission denied, open '/data/configuration/audio_interface/alsa_controller/config.json' Apr 21 11:42:00 volumio volumio[4948]: Configuration write error: Error: EACCES: permission denied, open '/data/configuration/plugins.json' Apr 21 11:42:00 volumio volumio[4948]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Apr 21 11:42:00 volumio volumio[4948]: info: CoreStateMachine::getcurrentVolume Apr 21 11:42:00 volumio volumio[4948]: info: CoreCommandRouter::volumioRetrievevolume Apr 21 11:42:00 volumio volumio[4948]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Apr 21 11:42:00 volumio volumio[4948]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Apr 21 11:42:00 volumio volumio[4948]: info: Setting Device type: Amlogic Apr 21 11:42:00 volumio volumio[4948]: error: minidlna: Failed to query miniDLNA version: Error: Command failed: /usr/bin/minidlnad -V Apr 21 11:42:00 volumio volumio[4948]: /bin/sh: 1: /usr/bin/minidlnad: not found Apr 21 11:42:00 volumio volumio[4948]: info: touch_display: systemctl daemon-reload succeeded. Apr 21 11:42:00 volumio sudo[5154]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service Apr 21 11:42:00 volumio volumio[4948]: info: MPD running with PID4712 Apr 21 11:42:00 volumio volumio[4948]: ,establishing connection Apr 21 11:42:00 volumio sudo[5154]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 11:42:00 volumio sudo[5156]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cdetect -y 1 Apr 21 11:42:00 volumio sudo[5154]: pam_unix(sudo:session): session closed for user root Apr 21 11:42:00 volumio sudo[5156]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 11:42:00 volumio sudo[5156]: pam_unix(sudo:session): session closed for user root Apr 21 11:42:00 volumio volumio[4948]: info: VolumeController:: Volume=undefined Mute =false Apr 21 11:42:00 volumio volumio[4948]: info: CoreStateMachine::pushState Apr 21 11:42:00 volumio volumio[4948]: info: CorePlayQueue::getTrack 0 Apr 21 11:42:00 volumio volumio[4948]: info: CoreCommandRouter::volumioPushState Apr 21 11:42:00 volumio volumio[4948]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 21 11:42:00 volumio volumio[4948]: info: CoreStateMachine::updateTrackBlock Apr 21 11:42:00 volumio volumio[4948]: info: CorePlayQueue::getTrackBlock Apr 21 11:42:00 volumio volumio[4948]: info: CoreCommandRouter::volumioRetrievevolume Apr 21 11:42:00 volumio volumio[4948]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Apr 21 11:42:00 volumio volumio[4948]: info: VolumeController:: Volume=undefined Mute =false Apr 21 11:42:00 volumio volumio[4948]: info: CoreStateMachine::pushState Apr 21 11:42:00 volumio volumio[4948]: info: CorePlayQueue::getTrack 0 Apr 21 11:42:00 volumio volumio[4948]: info: CoreCommandRouter::volumioPushState Apr 21 11:42:00 volumio volumio[4948]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 21 11:42:00 volumio volumio[4948]: info: CoreStateMachine::updateTrackBlock Apr 21 11:42:00 volumio volumio[4948]: info: CorePlayQueue::getTrackBlock Apr 21 11:42:00 volumio volumio[4948]: info: CoreCommandRouter::volumioRetrievevolume Apr 21 11:42:00 volumio volumio[4948]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Apr 21 11:42:00 volumio volumio[4948]: info: Cannot read I2C interface or I2C interface not presentError: Command failed: /usr/bin/sudo /usr/sbin/i2cdetect -y 1 Apr 21 11:42:00 volumio volumio[4948]: Error: Could not open file `/dev/i2c-1' or `/dev/i2c/1': No such file or directory Apr 21 11:42:00 volumio volumio[4948]: error: touch_display: Failed to start volumio-kiosk.service: Error: Command failed: /usr/bin/sudo /bin/systemctl start volumio-kiosk.service Apr 21 11:42:00 volumio volumio[4948]: Failed to start volumio-kiosk.service: Unit volumio-kiosk.service failed to load: No such file or directory. Apr 21 11:42:00 volumio volumio[4948]: info: Reloading queue from file Apr 21 11:42:00 volumio volumio[4948]: error: updateQueue error: null Apr 21 11:42:00 volumio volumio[4948]: info: VolumeController:: Volume=undefined Mute =false Apr 21 11:42:00 volumio volumio[4948]: info: CoreStateMachine::pushState Apr 21 11:42:00 volumio volumio[4948]: info: CorePlayQueue::getTrack 0 Apr 21 11:42:00 volumio volumio[4948]: info: CoreCommandRouter::volumioPushState Apr 21 11:42:00 volumio volumio[4948]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 21 11:42:00 volumio volumio[4948]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Apr 21 11:42:00 volumio volumio[4948]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Apr 21 11:42:00 volumio volumio[4948]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 21 11:42:00 volumio volumio[4948]: Home directory not accessible: Permission denied Apr 21 11:42:00 volumio volumio[4948]: W: [pulseaudio] core-util.c: Failed to open configuration file '/home/volumio/.config/pulse//daemon.conf': Permission denied Apr 21 11:42:00 volumio volumio[4948]: W: [pulseaudio] daemon-conf.c: Failed to open configuration file: Permission denied Apr 21 11:42:00 volumio volumio[4948]: info: CoreCommandRouter::executeOnPlugin: raat , onStop Apr 21 11:42:00 volumio volumio[4948]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Apr 21 11:42:00 volumio volumio[4948]: info: CoreStateMachine::setRepeat null single undefined Apr 21 11:42:00 volumio volumio[4948]: info: CoreStateMachine::pushState Apr 21 11:42:00 volumio volumio[4948]: info: CorePlayQueue::getTrack 0 Apr 21 11:42:00 volumio volumio[4948]: info: CoreCommandRouter::volumioPushState Apr 21 11:42:00 volumio volumio[4948]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 21 11:42:00 volumio volumio[4948]: info: CoreStateMachine::setRandom null Apr 21 11:42:00 volumio volumio[4948]: info: CoreStateMachine::pushState Apr 21 11:42:00 volumio volumio[4948]: info: CorePlayQueue::getTrack 0 Apr 21 11:42:00 volumio volumio[4948]: info: CoreCommandRouter::volumioPushState Apr 21 11:42:00 volumio volumio[4948]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 21 11:42:01 volumio volumio[4948]: info: VolumeController:: Volume=undefined Mute =false Apr 21 11:42:01 volumio volumio[4948]: info: CoreStateMachine::pushState Apr 21 11:42:01 volumio volumio[4948]: info: CorePlayQueue::getTrack 0 Apr 21 11:42:01 volumio volumio[4948]: info: CoreCommandRouter::volumioPushState Apr 21 11:42:01 volumio volumio[4948]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 21 11:42:01 volumio volumio[4948]: Configuration write error: Error: EACCES: permission denied, open '/data/configuration/system_controller/system/config.json' Apr 21 11:42:01 volumio volumio[4948]: error: minidlna: Error writing /data/minidlna.conf: Error: EACCES: permission denied, open '/data/minidlna.conf' Apr 21 11:42:01 volumio volumio[4948]: info: Starting Shairport Sync Apr 21 11:42:01 volumio volumio[4948]: info: Starting Shairport Sync Apr 21 11:42:01 volumio sudo[5171]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 21 11:42:01 volumio sudo[5171]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 11:42:01 volumio volumio[4948]: Discovery: adding e647343a-d4ec-4305-8c08-c18e038c2138 Apr 21 11:42:01 volumio volumio[4948]: info: mDNS: Found device Volumio Apr 21 11:42:01 volumio systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Apr 21 11:42:01 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 21 11:42:01 volumio sudo[5176]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 21 11:42:01 volumio sudo[5176]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 11:42:01 volumio volumio[4948]: info: CoreCommandRouter::volumioGetState Apr 21 11:42:01 volumio volumio[4948]: info: CorePlayQueue::getTrack 0 Apr 21 11:42:01 volumio sudo[5171]: pam_unix(sudo:session): session closed for user root Apr 21 11:42:01 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 21 11:42:01 volumio systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Apr 21 11:42:01 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 21 11:42:01 volumio sudo[5176]: pam_unix(sudo:session): session closed for user root Apr 21 11:42:02 volumio volumio[4948]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 21 11:42:02 volumio volumio[4948]: { Error: EACCES: permission denied, unlink '/data/backgrounds/aurora.jpg' Apr 21 11:42:02 volumio volumio[4948]: errno: -13, Apr 21 11:42:02 volumio volumio[4948]: code: 'EACCES', Apr 21 11:42:02 volumio volumio[4948]: syscall: 'unlink', Apr 21 11:42:02 volumio volumio[4948]: path: '/data/backgrounds/aurora.jpg' } Apr 21 11:42:02 volumio volumio[4948]: Discovery: this is already registered, e647343a-d4ec-4305-8c08-c18e038c2138 Apr 21 11:42:02 volumio volumio[4948]: info: mDNS: Found device Volumio Apr 21 11:42:02 volumio volumio[4948]: info: CoreCommandRouter::volumioGetState Apr 21 11:42:02 volumio volumio[4948]: info: CorePlayQueue::getTrack 0 Apr 21 11:42:02 volumio sudo[5053]: pam_unix(sudo:session): session closed for user root Apr 21 11:42:02 volumio volumio[4948]: info: Shairport-Sync Started Apr 21 11:42:02 volumio volumio[4948]: Error adding Membership: Error: addMembership EINVAL Apr 21 11:42:02 volumio volumio[4948]: info: Shairport-Sync Started Apr 21 11:42:03 volumio volumio[4948]: info: Cannot mount NAS BG4BWN-OMV-NAS at system boot, trial number 1 ,retrying in 5 seconds Apr 21 11:42:05 volumio sudo[5204]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 21 11:42:05 volumio sudo[5204]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 11:42:05 volumio sudo[5204]: pam_unix(sudo:session): session closed for user root Apr 21 11:42:05 volumio sudo[5206]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 21 11:42:05 volumio sudo[5206]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 11:42:05 volumio sudo[5206]: pam_unix(sudo:session): session closed for user root Apr 21 11:42:05 volumio sudo[5210]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Apr 21 11:42:05 volumio sudo[5210]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 11:42:05 volumio volumio[4948]: info: CoreCommandRouter::volumioGetState Apr 21 11:42:05 volumio volumio[4948]: info: CorePlayQueue::getTrack 0 Apr 21 11:42:05 volumio systemd[1]: Starting UPnP Renderer front-end to MPD... Apr 21 11:42:05 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Apr 21 11:42:05 volumio sudo[5210]: pam_unix(sudo:session): session closed for user root Apr 21 11:42:05 volumio volumio[4948]: info: Upmpdcli Daemon Started Apr 21 11:42:06 volumio sudo[5231]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 21 11:42:06 volumio sudo[5231]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 11:42:06 volumio sudo[5231]: pam_unix(sudo:session): session closed for user root Apr 21 11:42:06 volumio sudo[5233]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 21 11:42:06 volumio sudo[5233]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 11:42:06 volumio sudo[5233]: pam_unix(sudo:session): session closed for user root Apr 21 11:42:07 volumio volumio[4948]: info: CoreCommandRouter::volumioGetState Apr 21 11:42:07 volumio volumio[4948]: info: CorePlayQueue::getTrack 0 Apr 21 11:42:07 volumio volumio[4948]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 21 11:42:07 volumio volumio[4948]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Apr 21 11:42:07 volumio volumio[4948]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 21 11:42:07 volumio volumio[4948]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 21 11:42:07 volumio volumio[4948]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 21 11:42:07 volumio volumio[4948]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 21 11:42:07 volumio volumio[4948]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 21 11:42:07 volumio volumio[4948]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Apr 21 11:42:07 volumio sudo[5246]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Apr 21 11:42:07 volumio sudo[5246]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 11:42:07 volumio sudo[5251]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Apr 21 11:42:07 volumio sudo[5251]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 11:42:07 volumio sudo[5246]: pam_unix(sudo:session): session closed for user root Apr 21 11:42:07 volumio sudo[5251]: pam_unix(sudo:session): session closed for user root Apr 21 11:42:07 volumio sudo[5259]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Apr 21 11:42:07 volumio sudo[5259]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 11:42:07 volumio sudo[5259]: pam_unix(sudo:session): session closed for user root Apr 21 11:42:07 volumio sudo[5267]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Apr 21 11:42:07 volumio sudo[5267]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 11:42:07 volumio sudo[5267]: pam_unix(sudo:session): session closed for user root Apr 21 11:42:07 volumio sudo[5272]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 21 11:42:07 volumio sudo[5272]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 11:42:07 volumio sudo[5272]: pam_unix(sudo:session): session closed for user root Apr 21 11:42:07 volumio sudo[5275]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 21 11:42:07 volumio sudo[5275]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 11:42:07 volumio volumio[4948]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Apr 21 11:42:07 volumio volumio[4948]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Apr 21 11:42:07 volumio sudo[5275]: pam_unix(sudo:session): session closed for user root Apr 21 11:42:08 volumio sudo[5280]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Apr 21 11:42:08 volumio sudo[5280]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 11:42:08 volumio volumio[4948]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Apr 21 11:42:08 volumio volumio[4948]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Apr 21 11:42:08 volumio volumio[4948]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Apr 21 11:42:08 volumio volumio[4948]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Apr 21 11:42:08 volumio volumio[4948]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Apr 21 11:42:08 volumio volumio[4948]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Apr 21 11:42:08 volumio volumio[4948]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Apr 21 11:42:08 volumio volumio[4948]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Apr 21 11:42:08 volumio volumio[4948]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Apr 21 11:42:08 volumio volumio[4948]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Apr 21 11:42:08 volumio volumio[4948]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Apr 21 11:42:08 volumio volumio[4948]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Apr 21 11:42:08 volumio volumio[4948]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Apr 21 11:42:08 volumio volumio[4948]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Apr 21 11:42:08 volumio volumio[4948]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Apr 21 11:42:08 volumio volumio[4948]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Apr 21 11:42:08 volumio volumio[4948]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Apr 21 11:42:08 volumio volumio[4948]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Apr 21 11:42:08 volumio volumio[4948]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Apr 21 11:42:08 volumio volumio[4948]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Apr 21 11:42:08 volumio volumio[4948]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Apr 21 11:42:08 volumio volumio[4948]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Apr 21 11:42:08 volumio volumio[4948]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Apr 21 11:42:08 volumio volumio[4948]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Apr 21 11:42:08 volumio volumio[4948]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Apr 21 11:42:08 volumio volumio[4948]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Apr 21 11:42:08 volumio volumio[4948]: info: Adding plugin bluetooth to MyMusic Plugins Apr 21 11:42:08 volumio volumio[4948]: info: Adding plugin cd_controller to MyMusic Plugins Apr 21 11:42:08 volumio volumio[4948]: info: Adding plugin smart_inputs to MyMusic Plugins Apr 21 11:42:08 volumio volumio[4948]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Apr 21 11:42:09 volumio kernel: RTL871X: nolinked power save leave Apr 21 11:42:09 volumio volumio-remote-updater[4609]: [2024-04-21 11:42:09] [connect] Successful connection Apr 21 11:42:10 volumio kernel: RTL871X: nolinked power save enter Apr 21 11:42:11 volumio volumio[4948]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Apr 21 11:42:11 volumio sudo[5280]: pam_unix(sudo:session): session closed for user root Apr 21 11:42:12 volumio volumio[4948]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Apr 21 11:42:12 volumio volumio[4948]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Apr 21 11:42:12 volumio volumio[4948]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 21 11:42:12 volumio volumio[4948]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 21 11:42:12 volumio volumio[4948]: info: Starting MyVolumio Remote Streaming Endpoints Apr 21 11:42:12 volumio volumio[4948]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Apr 21 11:42:12 volumio volumio[4948]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Apr 21 11:42:12 volumio volumio[4948]: info: Streaming services startup Apr 21 11:42:12 volumio volumio[4948]: info: Starting Streaming Daemon Apr 21 11:42:12 volumio sudo[5287]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Apr 21 11:42:12 volumio sudo[5287]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 11:42:12 volumio systemd[1]: Stopping Volumio Streaming Daemon... Apr 21 11:42:12 volumio systemd[1]: Starting Volumio Streaming Daemon... Apr 21 11:42:12 volumio systemd[1]: Started Volumio Streaming Daemon. Apr 21 11:42:12 volumio sudo[5287]: pam_unix(sudo:session): session closed for user root Apr 21 11:42:12 volumio volumio[4948]: info: MyVolumio not started Apr 21 11:42:12 volumio volumio[4948]: info: Initializing device activation check Apr 21 11:42:12 volumio volumio-streaming-daemon[5294]: ############################ Apr 21 11:42:12 volumio volumio-streaming-daemon[5294]: # Volumio Streaming Daemon # Apr 21 11:42:12 volumio volumio-streaming-daemon[5294]: # Running on port 7777 # Apr 21 11:42:12 volumio volumio-streaming-daemon[5294]: ############################ Apr 21 11:42:12 volumio volumio-streaming-daemon[5294]: Environment: production Apr 21 11:42:12 volumio volumio[4948]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Apr 21 11:42:13 volumio volumio[4948]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=aml9xxxarmv7&variante=volumio&version=2.857&uuid=1ac0973e8a28ba1398b2ce116654ae7c" http://updates.volumio.org:7070/downloader-v1/track-device Apr 21 11:42:13 volumio volumio[4948]: % Total % Received % Xferd Average Speed Time Time Time Current Apr 21 11:42:13 volumio volumio[4948]: Dload Upload Total Spent Left Speed Apr 21 11:42:13 volumio volumio[4948]: 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0curl: (7) Failed to connect to updates.volumio.org port 7070: Connection refused Apr 21 11:42:13 volumio volumio[4948]: retrying in 5 seconds, trial 0 Apr 21 11:42:13 volumio sudo[5302]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=BG4BWN,password=ZHANGjun19790130,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.31.210/音乐 /mnt/NAS/BG4BWN-OMV-NAS Apr 21 11:42:13 volumio sudo[5302]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 11:42:13 volumio volumio[4948]: Volumio Calling Home Apr 21 11:42:13 volumio volumio-remote-updater[4609]: [2024-04-21 11:42:13] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1713699729 101 Apr 21 11:42:13 volumio volumio[4948]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 21 11:42:13 volumio volumio[4948]: Configuration write error: Error: EACCES: permission denied, open '/data/configuration/plugins.json' Apr 21 11:42:15 volumio volumio[4948]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 21 11:42:15 volumio volumio[4948]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 21 11:42:15 volumio volumio[4948]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Apr 21 11:42:15 volumio sudo[5322]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Apr 21 11:42:15 volumio sudo[5322]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 11:42:15 volumio sudo[5322]: pam_unix(sudo:session): session closed for user root Apr 21 11:42:15 volumio sudo[5327]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Apr 21 11:42:15 volumio sudo[5327]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 11:42:15 volumio sudo[5327]: pam_unix(sudo:session): session closed for user root Apr 21 11:42:15 volumio sudo[5335]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Apr 21 11:42:15 volumio sudo[5335]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 11:42:15 volumio sudo[5335]: pam_unix(sudo:session): session closed for user root Apr 21 11:42:15 volumio sudo[5342]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Apr 21 11:42:15 volumio sudo[5342]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 11:42:15 volumio sudo[5342]: pam_unix(sudo:session): session closed for user root Apr 21 11:42:15 volumio sudo[5347]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 21 11:42:15 volumio sudo[5347]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 11:42:15 volumio sudo[5347]: pam_unix(sudo:session): session closed for user root Apr 21 11:42:15 volumio sudo[5351]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 21 11:42:15 volumio sudo[5351]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 11:42:15 volumio sudo[5351]: pam_unix(sudo:session): session closed for user root Apr 21 11:42:15 volumio volumio[4948]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Apr 21 11:42:15 volumio volumio-streaming-daemon[5294]: Environment: production Apr 21 11:42:15 volumio volumio[4948]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Apr 21 11:42:15 volumio sudo[5355]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Apr 21 11:42:15 volumio sudo[5355]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 11:42:15 volumio volumio[4948]: error: Failed initialization of streaming services: Error: An error occurred while configuring services daemon. Apr 21 11:42:17 volumio kernel: RTL871X: nolinked power save leave Apr 21 11:42:18 volumio kernel: RTL871X: nolinked power save enter Apr 21 11:42:18 volumio sudo[5355]: pam_unix(sudo:session): session closed for user root Apr 21 11:42:19 volumio sudo[5302]: pam_unix(sudo:session): session closed for user root Apr 21 11:42:19 volumio volumio[4948]: info: Cannot mount NAS BG4BWN-OMV-NAS at system boot, trial number 2 ,retrying in 5 seconds Apr 21 11:42:23 volumio volumio[4948]: info: CALLMETHOD: system_controller network saveHotspotSettings [object Object] Apr 21 11:42:23 volumio volumio[4948]: info: CoreCommandRouter::executeOnPlugin: network , saveHotspotSettings Apr 21 11:42:24 volumio volumio[4948]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=aml9xxxarmv7&variante=volumio&version=2.857&uuid=1ac0973e8a28ba1398b2ce116654ae7c" http://updates.volumio.org:7070/downloader-v1/track-device Apr 21 11:42:24 volumio volumio[4948]: % Total % Received % Xferd Average Speed Time Time Time Current Apr 21 11:42:24 volumio volumio[4948]: Dload Upload Total Spent Left Speed Apr 21 11:42:24 volumio volumio[4948]: 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0curl: (7) Failed to connect to updates.volumio.org port 7070: Connection refused Apr 21 11:42:24 volumio volumio[4948]: retrying in 5 seconds, trial 1 Apr 21 11:42:24 volumio volumio[4948]: Volumio Calling Home Apr 21 11:42:24 volumio volumio[4948]: Configuration write error: Error: EACCES: permission denied, open '/data/configuration/system_controller/network/config.json' Apr 21 11:42:24 volumio sudo[5386]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=BG4BWN,password=ZHANGjun19790130,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.31.210/音乐 /mnt/NAS/BG4BWN-OMV-NAS Apr 21 11:42:24 volumio sudo[5386]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 11:42:24 volumio sudo[5390]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/hostapd/hostapd-edimax.conf Apr 21 11:42:24 volumio sudo[5390]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 11:42:24 volumio sudo[5390]: pam_unix(sudo:session): session closed for user root Apr 21 11:42:24 volumio volumio[4948]: info: Permissions for /etc/hostapd/hostapd-edimax.conf Apr 21 11:42:24 volumio sudo[5396]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/hostapd/hostapd.conf Apr 21 11:42:24 volumio sudo[5396]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 11:42:24 volumio sudo[5396]: pam_unix(sudo:session): session closed for user root Apr 21 11:42:24 volumio volumio[4948]: info: Permissions for /etc/hostapd/hostapd.conf Apr 21 11:42:24 volumio sudo[5400]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart wireless.service Apr 21 11:42:24 volumio sudo[5400]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 11:42:24 volumio systemd[1]: Starting Wireless Services... Apr 21 11:42:24 volumio sudo[5403]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 set power_save off Apr 21 11:42:24 volumio sudo[5403]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 11:42:24 volumio sudo[5403]: pam_unix(sudo:session): session closed for user root Apr 21 11:42:24 volumio wireless.js[5406]: Cleaning previous... Apr 21 11:42:24 volumio systemd[1]: Stopped hotspot.service. Apr 21 11:42:24 volumio sudo[5422]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Apr 21 11:42:24 volumio sudo[5422]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 11:42:24 volumio avahi-daemon[4711]: Withdrawing address record for 192.168.211.1 on wlan0. Apr 21 11:42:24 volumio avahi-daemon[4711]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.211.1. Apr 21 11:42:24 volumio avahi-daemon[4711]: Interface wlan0.IPv4 no longer relevant for mDNS. Apr 21 11:42:24 volumio sudo[5422]: pam_unix(sudo:session): session closed for user root Apr 21 11:42:24 volumio volumio[4948]: info: mDNS: A device disapperared from network Apr 21 11:42:24 volumio volumio[4948]: info: mDNS: Device volumio disapperared from network Apr 21 11:42:24 volumio sudo[5424]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Apr 21 11:42:24 volumio sudo[5424]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 11:42:24 volumio sudo[5424]: pam_unix(sudo:session): session closed for user root Apr 21 11:42:24 volumio sudo[5386]: pam_unix(sudo:session): session closed for user root Apr 21 11:42:25 volumio wireless.js[5406]: Stopped aP Apr 21 11:42:25 volumio systemd[1]: Stopped hotspot.service. Apr 21 11:42:25 volumio sudo[5433]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Apr 21 11:42:25 volumio sudo[5433]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 11:42:25 volumio sudo[5433]: pam_unix(sudo:session): session closed for user root Apr 21 11:42:25 volumio sudo[5435]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Apr 21 11:42:25 volumio sudo[5435]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 11:42:25 volumio sudo[5435]: pam_unix(sudo:session): session closed for user root Apr 21 11:42:25 volumio avahi-daemon[4711]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.211.1. Apr 21 11:42:25 volumio avahi-daemon[4711]: New relevant interface wlan0.IPv4 for mDNS. Apr 21 11:42:25 volumio avahi-daemon[4711]: Registering new address record for 192.168.211.1 on wlan0.IPv4. Apr 21 11:42:25 volumio kernel: IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready Apr 21 11:42:25 volumio systemd[1]: Starting hotspot.service... Apr 21 11:42:25 volumio systemd[1]: Started hotspot.service. Apr 21 11:42:25 volumio systemd[1]: Starting dhcpd.service... Apr 21 11:42:25 volumio systemd[1]: Starting dnsmasq.service... Apr 21 11:42:25 volumio dhcpd[5442]: Internet Systems Consortium DHCP Server 4.3.1 Apr 21 11:42:25 volumio dhcpd[5442]: Copyright 2004-2014 Internet Systems Consortium. Apr 21 11:42:25 volumio dhcpd[5442]: All rights reserved. Apr 21 11:42:25 volumio dhcpd[5442]: For info, please visit https://www.isc.org/software/dhcp/ Apr 21 11:42:25 volumio dhcpd[5442]: Config file: /etc/dhcp/dhcpd.conf Apr 21 11:42:25 volumio dhcpd[5442]: Database file: /var/lib/dhcp/dhcpd.leases Apr 21 11:42:25 volumio dhcpd[5442]: PID file: /var/run/dhcpd.pid Apr 21 11:42:25 volumio dnsmasq[5445]: started, version 2.72 cachesize 150 Apr 21 11:42:25 volumio dnsmasq[5445]: compile time options: IPv6 GNU-getopt DBus i18n IDN DHCP DHCPv6 no-Lua TFTP conntrack ipset auth DNSSEC loop-detect Apr 21 11:42:25 volumio dnsmasq[5445]: reading /etc/resolv.conf Apr 21 11:42:25 volumio dnsmasq[5445]: using nameserver 192.168.31.1#53 Apr 21 11:42:25 volumio dnsmasq[5445]: using nameserver 208.67.222.222#53 Apr 21 11:42:25 volumio dnsmasq[5445]: using nameserver 208.67.220.220#53 Apr 21 11:42:25 volumio dnsmasq[5445]: read /etc/hosts - 4 addresses Apr 21 11:42:25 volumio systemd[1]: Started dnsmasq.service. Apr 21 11:42:25 volumio systemd[1]: Started Wireless Services. Apr 21 11:42:25 volumio sudo[5400]: pam_unix(sudo:session): session closed for user root Apr 21 11:42:25 volumio dhcpd[5442]: Internet Systems Consortium DHCP Server 4.3.1 Apr 21 11:42:25 volumio dhcpd[5442]: Copyright 2004-2014 Internet Systems Consortium. Apr 21 11:42:25 volumio dhcpd[5442]: All rights reserved. Apr 21 11:42:25 volumio dhcpd[5442]: For info, please visit https://www.isc.org/software/dhcp/ Apr 21 11:42:25 volumio dhcpd[5442]: Wrote 0 leases to leases file. Apr 21 11:42:25 volumio hotspot[5442]: Internet Systems Consortium DHCP Server 4.3.1 Apr 21 11:42:25 volumio hotspot[5442]: Copyright 2004-2014 Internet Systems Consortium. Apr 21 11:42:25 volumio hotspot[5442]: All rights reserved. Apr 21 11:42:25 volumio hotspot[5442]: For info, please visit https://www.isc.org/software/dhcp/ Apr 21 11:42:25 volumio hotspot[5442]: Config file: /etc/dhcp/dhcpd.conf Apr 21 11:42:25 volumio hotspot[5442]: Database file: /var/lib/dhcp/dhcpd.leases Apr 21 11:42:25 volumio hotspot[5442]: PID file: /var/run/dhcpd.pid Apr 21 11:42:25 volumio hotspot[5442]: Wrote 0 leases to leases file. Apr 21 11:42:25 volumio systemd[1]: Starting Host and Network Name Lookups. Apr 21 11:42:25 volumio systemd[1]: Reached target Host and Network Name Lookups. Apr 21 11:42:25 volumio dhcpd[5442]: Listening on LPF/wlan0/00:2d:f4:5b:0e:77/192.168.211.0/24 Apr 21 11:42:25 volumio dhcpd[5442]: Sending on LPF/wlan0/00:2d:f4:5b:0e:77/192.168.211.0/24 Apr 21 11:42:25 volumio dhcpd[5442]: Apr 21 11:42:25 volumio dhcpd[5442]: No subnet declaration for eth0 (192.168.31.193). Apr 21 11:42:25 volumio dhcpd[5442]: ** Ignoring requests on eth0. If this is not what Apr 21 11:42:25 volumio dhcpd[5442]: you want, please write a subnet declaration Apr 21 11:42:25 volumio dhcpd[5442]: in your dhcpd.conf file for the network segment Apr 21 11:42:25 volumio dhcpd[5442]: to which interface eth0 is attached. ** Apr 21 11:42:25 volumio dhcpd[5442]: Apr 21 11:42:25 volumio dhcpd[5442]: Sending on Socket/fallback/fallback-net Apr 21 11:42:25 volumio dhcpd[5447]: Server starting service. Apr 21 11:42:25 volumio systemd[1]: Started dhcpd.service. Apr 21 11:42:25 volumio hotspot[5442]: Listening on LPF/wlan0/00:2d:f4:5b:0e:77/192.168.211.0/24 Apr 21 11:42:25 volumio hotspot[5442]: Sending on LPF/wlan0/00:2d:f4:5b:0e:77/192.168.211.0/24 Apr 21 11:42:25 volumio hotspot[5442]: No subnet declaration for eth0 (192.168.31.193). Apr 21 11:42:25 volumio hotspot[5442]: ** Ignoring requests on eth0. If this is not what Apr 21 11:42:25 volumio hotspot[5442]: you want, please write a subnet declaration Apr 21 11:42:25 volumio hotspot[5442]: in your dhcpd.conf file for the network segment Apr 21 11:42:25 volumio hotspot[5442]: to which interface eth0 is attached. ** Apr 21 11:42:25 volumio hotspot[5442]: Sending on Socket/fallback/fallback-net Apr 21 11:42:25 volumio hotspot[5441]: Launching Ordinary Hostapd Apr 21 11:42:25 volumio hotspot[5441]: Configuration file: /etc/hostapd/hostapd.conf Apr 21 11:42:25 volumio hotspot[5441]: Interface name not specified in /etc/hostapd/hostapd.conf Apr 21 11:42:25 volumio hotspot[5441]: hostapd_free_hapd_data: Interface wasn't started Apr 21 11:42:25 volumio hotspot[5441]: Failed to initialize interface Apr 21 11:42:25 volumio systemd[1]: hotspot.service: main process exited, code=exited, status=1/FAILURE Apr 21 11:42:25 volumio systemd[1]: Stopping dhcpd.service... Apr 21 11:42:25 volumio systemd[1]: Stopping Host and Network Name Lookups. Apr 21 11:42:25 volumio systemd[1]: Stopped target Host and Network Name Lookups. Apr 21 11:42:25 volumio systemd[1]: Stopping dnsmasq.service... Apr 21 11:42:25 volumio systemd[1]: Stopped dnsmasq.service. Apr 21 11:42:25 volumio dnsmasq[5445]: exiting on receipt of SIGTERM Apr 21 11:42:25 volumio hotspot[5464]: Killing Hostapd Apr 21 11:42:25 volumio sudo[5473]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall hostapd Apr 21 11:42:25 volumio sudo[5473]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 11:42:25 volumio hotspot[5464]: hostapd: no process found Apr 21 11:42:25 volumio sudo[5473]: pam_unix(sudo:session): session closed for user root Apr 21 11:42:25 volumio hotspot[5464]: Killing Dhcpd Apr 21 11:42:25 volumio systemd[1]: Stopped dhcpd.service. Apr 21 11:42:25 volumio sudo[5475]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall dhcpd Apr 21 11:42:25 volumio sudo[5475]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 11:42:25 volumio hotspot[5464]: dhcpd: no process found Apr 21 11:42:25 volumio sudo[5475]: pam_unix(sudo:session): session closed for user root Apr 21 11:42:25 volumio systemd[1]: hotspot.service: control process exited, code=exited status=1 Apr 21 11:42:25 volumio systemd[1]: Unit hotspot.service entered failed state. Apr 21 11:42:25 volumio volumio[4948]: Discovery: adding e647343a-d4ec-4305-8c08-c18e038c2138 Apr 21 11:42:25 volumio volumio[4948]: info: mDNS: Found device Volumio Apr 21 11:42:25 volumio volumio[4948]: info: CoreCommandRouter::volumioGetState Apr 21 11:42:25 volumio volumio[4948]: info: CorePlayQueue::getTrack 0 Apr 21 11:42:29 volumio volumio[4948]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 21 11:42:29 volumio volumio[4948]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 21 11:42:30 volumio volumio[4948]: info: Cannot mount NAS BG4BWN-OMV-NAS at system boot, trial number 3 ,retrying in 5 seconds Apr 21 11:42:30 volumio volumio[4948]: info: CoreCommandRouter::executeOnPlugin: wizard , reportWirelessConnection Apr 21 11:42:30 volumio volumio[4948]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessInfo Apr 21 11:42:30 volumio sudo[5497]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 21 11:42:30 volumio sudo[5497]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 11:42:30 volumio sudo[5497]: pam_unix(sudo:session): session closed for user root Apr 21 11:42:35 volumio sudo[5513]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=BG4BWN,password=ZHANGjun19790130,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.31.210/音乐 /mnt/NAS/BG4BWN-OMV-NAS Apr 21 11:42:35 volumio sudo[5513]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 11:42:35 volumio volumio[4948]: info: CoreCommandRouter::executeOnPlugin: upnp , onRestart Apr 21 11:42:35 volumio volumio[4948]: info: CoreCommandRouter::executeOnPlugin: network , onNetworkingRestart Apr 21 11:42:35 volumio volumio[4948]: info: Refreshing Cached IP Addresses Apr 21 11:42:35 volumio sudo[5520]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall upmpdcli Apr 21 11:42:35 volumio sudo[5520]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 11:42:35 volumio sudo[5520]: pam_unix(sudo:session): session closed for user root Apr 21 11:42:35 volumio sudo[5522]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 21 11:42:35 volumio sudo[5522]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 11:42:35 volumio sudo[5522]: pam_unix(sudo:session): session closed for user root Apr 21 11:42:35 volumio sudo[5525]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 21 11:42:35 volumio sudo[5525]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 11:42:35 volumio sudo[5525]: pam_unix(sudo:session): session closed for user root Apr 21 11:42:35 volumio volumio[4948]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=aml9xxxarmv7&variante=volumio&version=2.857&uuid=1ac0973e8a28ba1398b2ce116654ae7c" http://updates.volumio.org:7070/downloader-v1/track-device Apr 21 11:42:35 volumio volumio[4948]: % Total % Received % Xferd Average Speed Time Time Time Current Apr 21 11:42:35 volumio volumio[4948]: Dload Upload Total Spent Left Speed Apr 21 11:42:35 volumio volumio[4948]: [235B blob data] Apr 21 11:42:35 volumio volumio[4948]: retrying in 5 seconds, trial 2 Apr 21 11:42:35 volumio volumio[4948]: Volumio Calling Home Apr 21 11:42:35 volumio sudo[5535]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 21 11:42:35 volumio sudo[5535]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 11:42:35 volumio sudo[5535]: pam_unix(sudo:session): session closed for user root Apr 21 11:42:36 volumio sudo[5538]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 21 11:42:36 volumio sudo[5538]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 11:42:36 volumio sudo[5538]: pam_unix(sudo:session): session closed for user root Apr 21 11:42:36 volumio volumio[4948]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 21 11:42:36 volumio volumio[4948]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 21 11:42:36 volumio volumio[4948]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 21 11:42:36 volumio volumio[4948]: info: CoreCommandRouter::volumioGetState Apr 21 11:42:36 volumio volumio[4948]: info: CorePlayQueue::getTrack 0 Apr 21 11:42:36 volumio volumio[4948]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Apr 21 11:42:36 volumio volumio[4948]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 21 11:42:36 volumio volumio[4948]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 21 11:42:36 volumio volumio[4948]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 21 11:42:36 volumio volumio[4948]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Apr 21 11:42:36 volumio sudo[5547]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Apr 21 11:42:36 volumio sudo[5547]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 11:42:36 volumio sudo[5547]: pam_unix(sudo:session): session closed for user root Apr 21 11:42:36 volumio sudo[5552]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Apr 21 11:42:36 volumio sudo[5552]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 11:42:36 volumio sudo[5552]: pam_unix(sudo:session): session closed for user root Apr 21 11:42:36 volumio sudo[5561]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Apr 21 11:42:36 volumio sudo[5561]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 11:42:36 volumio sudo[5561]: pam_unix(sudo:session): session closed for user root Apr 21 11:42:36 volumio sudo[5566]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Apr 21 11:42:36 volumio sudo[5566]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 11:42:36 volumio sudo[5566]: pam_unix(sudo:session): session closed for user root Apr 21 11:42:36 volumio sudo[5573]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 21 11:42:36 volumio sudo[5573]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 11:42:36 volumio sudo[5573]: pam_unix(sudo:session): session closed for user root Apr 21 11:42:36 volumio volumio[4948]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Apr 21 11:42:36 volumio volumio[4948]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Apr 21 11:42:36 volumio sudo[5577]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 21 11:42:36 volumio sudo[5577]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 11:42:36 volumio sudo[5577]: pam_unix(sudo:session): session closed for user root Apr 21 11:42:36 volumio sudo[5580]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Apr 21 11:42:36 volumio sudo[5580]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 11:42:38 volumio kernel: RTL871X: nolinked power save leave Apr 21 11:42:39 volumio kernel: RTL871X: nolinked power save enter Apr 21 11:42:39 volumio sudo[5580]: pam_unix(sudo:session): session closed for user root Apr 21 11:42:41 volumio sudo[5513]: pam_unix(sudo:session): session closed for user root Apr 21 11:42:41 volumio volumio[4948]: info: Cannot mount NAS BG4BWN-OMV-NAS at system boot, trial number 4 ,retrying in 5 seconds Apr 21 11:42:45 volumio sudo[5605]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 21 11:42:45 volumio sudo[5605]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 11:42:45 volumio sudo[5605]: pam_unix(sudo:session): session closed for user root Apr 21 11:42:45 volumio sudo[5607]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 21 11:42:45 volumio sudo[5607]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 11:42:45 volumio sudo[5607]: pam_unix(sudo:session): session closed for user root Apr 21 11:42:45 volumio sudo[5611]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Apr 21 11:42:45 volumio sudo[5611]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 11:42:45 volumio systemd[1]: Starting UPnP Renderer front-end to MPD... Apr 21 11:42:45 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Apr 21 11:42:45 volumio sudo[5611]: pam_unix(sudo:session): session closed for user root Apr 21 11:42:45 volumio volumio[4948]: info: Upmpdcli Daemon Started Apr 21 11:42:46 volumio sudo[5630]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=BG4BWN,password=ZHANGjun19790130,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.31.210/音乐 /mnt/NAS/BG4BWN-OMV-NAS Apr 21 11:42:46 volumio sudo[5630]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 21 11:42:52 volumio sudo[5630]: pam_unix(sudo:session): session closed for user root Apr 21 11:42:52 volumio volumio[4948]: info: Cannot mount NAS at system boot, trial number 4 ,stopping Apr 21 11:42:52 volumio volumio[4948]: info: CoreCommandRouter::executeOnPlugin: network , saveWirelessNetworkSettings Apr 21 11:42:52 volumio volumio[4948]: info: Saving new wireless network Apr 21 11:42:52 volumio volumio[4948]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 21 11:42:52 volumio volumio[4948]: ReferenceError: error is not defined Apr 21 11:42:52 volumio volumio[4948]: at /volumio/app/plugins/system_controller/network/index.js:513:57 Apr 21 11:42:52 volumio volumio[4948]: at /volumio/node_modules/graceful-fs/graceful-fs.js:144:16 Apr 21 11:42:52 volumio volumio[4948]: at fs.js:1279:7 Apr 21 11:42:52 volumio volumio[4948]: at FSReqWrap.oncomplete (fs.js:135:15) Apr 21 11:42:52 volumio volumio[4948]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 21 11:42:53 volumio sudo[5664]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-21 11:41 Apr 21 11:42:53 volumio sudo[5664]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 8 (jessie)" NAME="Debian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=debian HOME_URL="http://www.debian.org/" SUPPORT_URL="http://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="168ba7444df98cd868db72f24faec0b6346489cc" VOLUMIO_FE_VERSION="847a48ecf32d35cc502a0053d585d1a69236e391" VOLUMIO_BE_VERSION="99dfb342fe07851f1e26bd1d8046d0234eda91dd" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Dec 11 15:53:56 CET 2020" VOLUMIO_VERSION="2.857" VOLUMIO_HARDWARE="aml9xxxarmv7" VOLUMIO_HASH="5e595833ee6075a27fef1ba35f928abb"