-- Logs begin at Tue 2023-03-28 01:54:07 CST, end at Tue 2024-07-16 12:02:02 CST. -- Jul 16 12:01:00 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:01 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:01 1901-1 systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 398. Jul 16 12:01:01 1901-1 systemd[1]: Stopped Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Jul 16 12:01:01 1901-1 systemd[1]: Starting Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator... Jul 16 12:01:01 1901-1 hostapd[10158]: Configuration file: /etc/hostapd/hostapd.conf Jul 16 12:01:01 1901-1 hostapd[10158]: Could not read interface wlan0 flags: No such device Jul 16 12:01:01 1901-1 hostapd[10158]: nl80211: Driver does not support authentication/association or connect commands Jul 16 12:01:01 1901-1 hostapd[10158]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Jul 16 12:01:01 1901-1 hostapd[10158]: Could not read interface wlan0 flags: No such device Jul 16 12:01:01 1901-1 hostapd[10158]: nl80211 driver initialization failed. Jul 16 12:01:01 1901-1 hostapd[10158]: wlan0: interface state UNINITIALIZED->DISABLED Jul 16 12:01:01 1901-1 hostapd[10158]: wlan0: AP-DISABLED Jul 16 12:01:01 1901-1 hostapd[10158]: wlan0: CTRL-EVENT-TERMINATING Jul 16 12:01:01 1901-1 hostapd[10158]: hostapd_free_hapd_data: Interface wlan0 wasn't started Jul 16 12:01:01 1901-1 systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Jul 16 12:01:01 1901-1 systemd[1]: hostapd.service: Failed with result 'exit-code'. Jul 16 12:01:01 1901-1 systemd[1]: Failed to start Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Jul 16 12:01:01 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:02 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:02 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:03 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:03 1901-1 systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 399. Jul 16 12:01:03 1901-1 systemd[1]: Stopped Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Jul 16 12:01:03 1901-1 systemd[1]: Starting Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator... Jul 16 12:01:03 1901-1 hostapd[10174]: Configuration file: /etc/hostapd/hostapd.conf Jul 16 12:01:03 1901-1 hostapd[10174]: Could not read interface wlan0 flags: No such device Jul 16 12:01:03 1901-1 hostapd[10174]: nl80211: Driver does not support authentication/association or connect commands Jul 16 12:01:03 1901-1 hostapd[10174]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Jul 16 12:01:03 1901-1 hostapd[10174]: Could not read interface wlan0 flags: No such device Jul 16 12:01:03 1901-1 hostapd[10174]: nl80211 driver initialization failed. Jul 16 12:01:03 1901-1 hostapd[10174]: wlan0: interface state UNINITIALIZED->DISABLED Jul 16 12:01:03 1901-1 hostapd[10174]: wlan0: AP-DISABLED Jul 16 12:01:03 1901-1 hostapd[10174]: wlan0: CTRL-EVENT-TERMINATING Jul 16 12:01:03 1901-1 hostapd[10174]: hostapd_free_hapd_data: Interface wlan0 wasn't started Jul 16 12:01:03 1901-1 systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Jul 16 12:01:03 1901-1 systemd[1]: hostapd.service: Failed with result 'exit-code'. Jul 16 12:01:03 1901-1 systemd[1]: Failed to start Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Jul 16 12:01:04 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:04 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:05 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:05 1901-1 systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 400. Jul 16 12:01:05 1901-1 systemd[1]: Stopped Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Jul 16 12:01:05 1901-1 systemd[1]: Starting Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator... Jul 16 12:01:06 1901-1 hostapd[10236]: Configuration file: /etc/hostapd/hostapd.conf Jul 16 12:01:06 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:06 1901-1 hostapd[10236]: Could not read interface wlan0 flags: No such device Jul 16 12:01:06 1901-1 hostapd[10236]: nl80211: Driver does not support authentication/association or connect commands Jul 16 12:01:06 1901-1 hostapd[10236]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Jul 16 12:01:06 1901-1 hostapd[10236]: Could not read interface wlan0 flags: No such device Jul 16 12:01:06 1901-1 hostapd[10236]: nl80211 driver initialization failed. Jul 16 12:01:06 1901-1 hostapd[10236]: wlan0: interface state UNINITIALIZED->DISABLED Jul 16 12:01:06 1901-1 hostapd[10236]: wlan0: AP-DISABLED Jul 16 12:01:06 1901-1 hostapd[10236]: wlan0: CTRL-EVENT-TERMINATING Jul 16 12:01:06 1901-1 hostapd[10236]: hostapd_free_hapd_data: Interface wlan0 wasn't started Jul 16 12:01:06 1901-1 systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Jul 16 12:01:06 1901-1 systemd[1]: hostapd.service: Failed with result 'exit-code'. Jul 16 12:01:06 1901-1 systemd[1]: Failed to start Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Jul 16 12:01:06 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:07 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:07 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:08 1901-1 systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 401. Jul 16 12:01:08 1901-1 systemd[1]: Stopped Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Jul 16 12:01:08 1901-1 systemd[1]: Starting Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator... Jul 16 12:01:08 1901-1 hostapd[10249]: Configuration file: /etc/hostapd/hostapd.conf Jul 16 12:01:08 1901-1 hostapd[10249]: Could not read interface wlan0 flags: No such device Jul 16 12:01:08 1901-1 hostapd[10249]: nl80211: Driver does not support authentication/association or connect commands Jul 16 12:01:08 1901-1 hostapd[10249]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Jul 16 12:01:08 1901-1 hostapd[10249]: Could not read interface wlan0 flags: No such device Jul 16 12:01:08 1901-1 hostapd[10249]: nl80211 driver initialization failed. Jul 16 12:01:08 1901-1 hostapd[10249]: wlan0: interface state UNINITIALIZED->DISABLED Jul 16 12:01:08 1901-1 hostapd[10249]: wlan0: AP-DISABLED Jul 16 12:01:08 1901-1 hostapd[10249]: wlan0: CTRL-EVENT-TERMINATING Jul 16 12:01:08 1901-1 hostapd[10249]: hostapd_free_hapd_data: Interface wlan0 wasn't started Jul 16 12:01:08 1901-1 systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Jul 16 12:01:08 1901-1 systemd[1]: hostapd.service: Failed with result 'exit-code'. Jul 16 12:01:08 1901-1 systemd[1]: Failed to start Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Jul 16 12:01:08 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:09 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:09 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:10 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:10 1901-1 systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 402. Jul 16 12:01:10 1901-1 systemd[1]: Stopped Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Jul 16 12:01:10 1901-1 systemd[1]: Starting Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator... Jul 16 12:01:10 1901-1 hostapd[10264]: Configuration file: /etc/hostapd/hostapd.conf Jul 16 12:01:10 1901-1 hostapd[10264]: Could not read interface wlan0 flags: No such device Jul 16 12:01:10 1901-1 hostapd[10264]: nl80211: Driver does not support authentication/association or connect commands Jul 16 12:01:10 1901-1 hostapd[10264]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Jul 16 12:01:10 1901-1 hostapd[10264]: Could not read interface wlan0 flags: No such device Jul 16 12:01:10 1901-1 hostapd[10264]: nl80211 driver initialization failed. Jul 16 12:01:10 1901-1 hostapd[10264]: wlan0: interface state UNINITIALIZED->DISABLED Jul 16 12:01:10 1901-1 hostapd[10264]: wlan0: AP-DISABLED Jul 16 12:01:10 1901-1 hostapd[10264]: wlan0: CTRL-EVENT-TERMINATING Jul 16 12:01:10 1901-1 hostapd[10264]: hostapd_free_hapd_data: Interface wlan0 wasn't started Jul 16 12:01:10 1901-1 systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Jul 16 12:01:10 1901-1 systemd[1]: hostapd.service: Failed with result 'exit-code'. Jul 16 12:01:10 1901-1 systemd[1]: Failed to start Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Jul 16 12:01:10 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:11 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:12 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:12 1901-1 volumio[2335]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E6%9E%97%E4%BF%8A%E6%9D%B0/05aef5e9-25f9-4c8c-a04c-003899a7c5cb.jpg' Jul 16 12:01:12 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:12 1901-1 systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 403. Jul 16 12:01:12 1901-1 systemd[1]: Stopped Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Jul 16 12:01:12 1901-1 systemd[1]: Starting Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator... Jul 16 12:01:12 1901-1 hostapd[10279]: Configuration file: /etc/hostapd/hostapd.conf Jul 16 12:01:12 1901-1 hostapd[10279]: Could not read interface wlan0 flags: No such device Jul 16 12:01:12 1901-1 hostapd[10279]: nl80211: Driver does not support authentication/association or connect commands Jul 16 12:01:12 1901-1 hostapd[10279]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Jul 16 12:01:12 1901-1 hostapd[10279]: Could not read interface wlan0 flags: No such device Jul 16 12:01:12 1901-1 hostapd[10279]: nl80211 driver initialization failed. Jul 16 12:01:12 1901-1 hostapd[10279]: wlan0: interface state UNINITIALIZED->DISABLED Jul 16 12:01:12 1901-1 hostapd[10279]: wlan0: AP-DISABLED Jul 16 12:01:12 1901-1 hostapd[10279]: wlan0: CTRL-EVENT-TERMINATING Jul 16 12:01:12 1901-1 hostapd[10279]: hostapd_free_hapd_data: Interface wlan0 wasn't started Jul 16 12:01:12 1901-1 systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Jul 16 12:01:12 1901-1 systemd[1]: hostapd.service: Failed with result 'exit-code'. Jul 16 12:01:12 1901-1 systemd[1]: Failed to start Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Jul 16 12:01:13 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:13 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:14 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:14 1901-1 systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 404. Jul 16 12:01:14 1901-1 systemd[1]: Stopped Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Jul 16 12:01:14 1901-1 systemd[1]: Starting Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator... Jul 16 12:01:14 1901-1 hostapd[10293]: Configuration file: /etc/hostapd/hostapd.conf Jul 16 12:01:15 1901-1 hostapd[10293]: Could not read interface wlan0 flags: No such device Jul 16 12:01:15 1901-1 hostapd[10293]: nl80211: Driver does not support authentication/association or connect commands Jul 16 12:01:15 1901-1 hostapd[10293]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Jul 16 12:01:15 1901-1 hostapd[10293]: Could not read interface wlan0 flags: No such device Jul 16 12:01:15 1901-1 hostapd[10293]: nl80211 driver initialization failed. Jul 16 12:01:15 1901-1 hostapd[10293]: wlan0: interface state UNINITIALIZED->DISABLED Jul 16 12:01:15 1901-1 hostapd[10293]: wlan0: AP-DISABLED Jul 16 12:01:15 1901-1 hostapd[10293]: wlan0: CTRL-EVENT-TERMINATING Jul 16 12:01:15 1901-1 hostapd[10293]: hostapd_free_hapd_data: Interface wlan0 wasn't started Jul 16 12:01:15 1901-1 systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Jul 16 12:01:15 1901-1 systemd[1]: hostapd.service: Failed with result 'exit-code'. Jul 16 12:01:15 1901-1 systemd[1]: Failed to start Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Jul 16 12:01:15 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:15 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:16 1901-1 volumio[2335]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E6%9E%97%E4%BF%8A%E6%9D%B0/05aef5e9-25f9-4c8c-a04c-003899a7c5cb.jpg' Jul 16 12:01:16 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:16 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:17 1901-1 systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 405. Jul 16 12:01:17 1901-1 systemd[1]: Stopped Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Jul 16 12:01:17 1901-1 systemd[1]: Starting Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator... Jul 16 12:01:17 1901-1 hostapd[10307]: Configuration file: /etc/hostapd/hostapd.conf Jul 16 12:01:17 1901-1 hostapd[10307]: Could not read interface wlan0 flags: No such device Jul 16 12:01:17 1901-1 hostapd[10307]: nl80211: Driver does not support authentication/association or connect commands Jul 16 12:01:17 1901-1 hostapd[10307]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Jul 16 12:01:17 1901-1 hostapd[10307]: Could not read interface wlan0 flags: No such device Jul 16 12:01:17 1901-1 hostapd[10307]: nl80211 driver initialization failed. Jul 16 12:01:17 1901-1 hostapd[10307]: wlan0: interface state UNINITIALIZED->DISABLED Jul 16 12:01:17 1901-1 hostapd[10307]: wlan0: AP-DISABLED Jul 16 12:01:17 1901-1 hostapd[10307]: wlan0: CTRL-EVENT-TERMINATING Jul 16 12:01:17 1901-1 hostapd[10307]: hostapd_free_hapd_data: Interface wlan0 wasn't started Jul 16 12:01:17 1901-1 systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Jul 16 12:01:17 1901-1 systemd[1]: hostapd.service: Failed with result 'exit-code'. Jul 16 12:01:17 1901-1 systemd[1]: Failed to start Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Jul 16 12:01:17 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:18 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:18 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:19 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:19 1901-1 systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 406. Jul 16 12:01:19 1901-1 systemd[1]: Stopped Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Jul 16 12:01:19 1901-1 systemd[1]: Starting Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator... Jul 16 12:01:19 1901-1 hostapd[10322]: Configuration file: /etc/hostapd/hostapd.conf Jul 16 12:01:19 1901-1 hostapd[10322]: Could not read interface wlan0 flags: No such device Jul 16 12:01:19 1901-1 hostapd[10322]: nl80211: Driver does not support authentication/association or connect commands Jul 16 12:01:19 1901-1 hostapd[10322]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Jul 16 12:01:19 1901-1 hostapd[10322]: Could not read interface wlan0 flags: No such device Jul 16 12:01:19 1901-1 hostapd[10322]: nl80211 driver initialization failed. Jul 16 12:01:19 1901-1 hostapd[10322]: wlan0: interface state UNINITIALIZED->DISABLED Jul 16 12:01:19 1901-1 hostapd[10322]: wlan0: AP-DISABLED Jul 16 12:01:19 1901-1 hostapd[10322]: wlan0: CTRL-EVENT-TERMINATING Jul 16 12:01:19 1901-1 hostapd[10322]: hostapd_free_hapd_data: Interface wlan0 wasn't started Jul 16 12:01:19 1901-1 systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Jul 16 12:01:19 1901-1 systemd[1]: hostapd.service: Failed with result 'exit-code'. Jul 16 12:01:19 1901-1 systemd[1]: Failed to start Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Jul 16 12:01:19 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:20 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:20 1901-1 rc.local[10335]: % Total % Received % Xferd Average Speed Time Time Time Current Jul 16 12:01:20 1901-1 rc.local[10335]: Dload Upload Total Spent Left Speed Jul 16 12:01:20 1901-1 volumio[2335]: info: Jul 16 12:01:20 1901-1 volumio[2335]: ---------------------------- Client requests Volumio toggle Jul 16 12:01:20 1901-1 volumio[2335]: info: CoreCommandRouter::volumioToggle Jul 16 12:01:20 1901-1 volumio[2335]: info: CoreStateMachine::pause Jul 16 12:01:20 1901-1 rc.local[10335]: [158B blob data] Jul 16 12:01:21 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:21 1901-1 systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 407. Jul 16 12:01:21 1901-1 systemd[1]: Stopped Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Jul 16 12:01:21 1901-1 systemd[1]: Starting Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator... Jul 16 12:01:21 1901-1 hostapd[10340]: Configuration file: /etc/hostapd/hostapd.conf Jul 16 12:01:21 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:21 1901-1 hostapd[10340]: Could not read interface wlan0 flags: No such device Jul 16 12:01:21 1901-1 hostapd[10340]: nl80211: Driver does not support authentication/association or connect commands Jul 16 12:01:21 1901-1 hostapd[10340]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Jul 16 12:01:21 1901-1 hostapd[10340]: Could not read interface wlan0 flags: No such device Jul 16 12:01:21 1901-1 hostapd[10340]: nl80211 driver initialization failed. Jul 16 12:01:21 1901-1 hostapd[10340]: wlan0: interface state UNINITIALIZED->DISABLED Jul 16 12:01:21 1901-1 hostapd[10340]: wlan0: AP-DISABLED Jul 16 12:01:21 1901-1 hostapd[10340]: wlan0: CTRL-EVENT-TERMINATING Jul 16 12:01:21 1901-1 hostapd[10340]: hostapd_free_hapd_data: Interface wlan0 wasn't started Jul 16 12:01:21 1901-1 systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Jul 16 12:01:21 1901-1 systemd[1]: hostapd.service: Failed with result 'exit-code'. Jul 16 12:01:21 1901-1 systemd[1]: Failed to start Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Jul 16 12:01:22 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:23 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:23 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:23 1901-1 systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 408. Jul 16 12:01:23 1901-1 systemd[1]: Stopped Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Jul 16 12:01:23 1901-1 systemd[1]: Starting Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator... Jul 16 12:01:23 1901-1 hostapd[10354]: Configuration file: /etc/hostapd/hostapd.conf Jul 16 12:01:24 1901-1 hostapd[10354]: Could not read interface wlan0 flags: No such device Jul 16 12:01:24 1901-1 hostapd[10354]: nl80211: Driver does not support authentication/association or connect commands Jul 16 12:01:24 1901-1 hostapd[10354]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Jul 16 12:01:24 1901-1 hostapd[10354]: Could not read interface wlan0 flags: No such device Jul 16 12:01:24 1901-1 hostapd[10354]: nl80211 driver initialization failed. Jul 16 12:01:24 1901-1 hostapd[10354]: wlan0: interface state UNINITIALIZED->DISABLED Jul 16 12:01:24 1901-1 hostapd[10354]: wlan0: AP-DISABLED Jul 16 12:01:24 1901-1 hostapd[10354]: wlan0: CTRL-EVENT-TERMINATING Jul 16 12:01:24 1901-1 hostapd[10354]: hostapd_free_hapd_data: Interface wlan0 wasn't started Jul 16 12:01:24 1901-1 systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Jul 16 12:01:24 1901-1 systemd[1]: hostapd.service: Failed with result 'exit-code'. Jul 16 12:01:24 1901-1 systemd[1]: Failed to start Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Jul 16 12:01:24 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:24 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:25 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:26 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:26 1901-1 systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 409. Jul 16 12:01:26 1901-1 systemd[1]: Stopped Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Jul 16 12:01:26 1901-1 rc.local[10371]: % Total % Received % Xferd Average Speed Time Time Time Current Jul 16 12:01:26 1901-1 rc.local[10371]: Dload Upload Total Spent Left Speed Jul 16 12:01:26 1901-1 volumio[2335]: info: Jul 16 12:01:26 1901-1 volumio[2335]: ---------------------------- Client requests Volumio toggle Jul 16 12:01:26 1901-1 volumio[2335]: info: CoreCommandRouter::volumioToggle Jul 16 12:01:26 1901-1 volumio[2335]: info: CoreStateMachine::pause Jul 16 12:01:26 1901-1 rc.local[10371]: [158B blob data] Jul 16 12:01:26 1901-1 systemd[1]: Starting Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator... Jul 16 12:01:26 1901-1 hostapd[10372]: Configuration file: /etc/hostapd/hostapd.conf Jul 16 12:01:26 1901-1 hostapd[10372]: Could not read interface wlan0 flags: No such device Jul 16 12:01:26 1901-1 hostapd[10372]: nl80211: Driver does not support authentication/association or connect commands Jul 16 12:01:26 1901-1 hostapd[10372]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Jul 16 12:01:26 1901-1 hostapd[10372]: Could not read interface wlan0 flags: No such device Jul 16 12:01:26 1901-1 hostapd[10372]: nl80211 driver initialization failed. Jul 16 12:01:26 1901-1 hostapd[10372]: wlan0: interface state UNINITIALIZED->DISABLED Jul 16 12:01:26 1901-1 hostapd[10372]: wlan0: AP-DISABLED Jul 16 12:01:26 1901-1 hostapd[10372]: wlan0: CTRL-EVENT-TERMINATING Jul 16 12:01:26 1901-1 hostapd[10372]: hostapd_free_hapd_data: Interface wlan0 wasn't started Jul 16 12:01:26 1901-1 systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Jul 16 12:01:26 1901-1 systemd[1]: hostapd.service: Failed with result 'exit-code'. Jul 16 12:01:26 1901-1 systemd[1]: Failed to start Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Jul 16 12:01:26 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:27 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:27 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:28 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:28 1901-1 systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 410. Jul 16 12:01:28 1901-1 systemd[1]: Stopped Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Jul 16 12:01:28 1901-1 systemd[1]: Starting Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator... Jul 16 12:01:28 1901-1 hostapd[10387]: Configuration file: /etc/hostapd/hostapd.conf Jul 16 12:01:28 1901-1 hostapd[10387]: Could not read interface wlan0 flags: No such device Jul 16 12:01:28 1901-1 hostapd[10387]: nl80211: Driver does not support authentication/association or connect commands Jul 16 12:01:28 1901-1 hostapd[10387]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Jul 16 12:01:28 1901-1 hostapd[10387]: Could not read interface wlan0 flags: No such device Jul 16 12:01:28 1901-1 hostapd[10387]: nl80211 driver initialization failed. Jul 16 12:01:28 1901-1 hostapd[10387]: wlan0: interface state UNINITIALIZED->DISABLED Jul 16 12:01:28 1901-1 hostapd[10387]: wlan0: AP-DISABLED Jul 16 12:01:28 1901-1 hostapd[10387]: wlan0: CTRL-EVENT-TERMINATING Jul 16 12:01:28 1901-1 hostapd[10387]: hostapd_free_hapd_data: Interface wlan0 wasn't started Jul 16 12:01:28 1901-1 systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Jul 16 12:01:28 1901-1 systemd[1]: hostapd.service: Failed with result 'exit-code'. Jul 16 12:01:28 1901-1 systemd[1]: Failed to start Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Jul 16 12:01:29 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:29 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:30 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:30 1901-1 systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 411. Jul 16 12:01:30 1901-1 systemd[1]: Stopped Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Jul 16 12:01:30 1901-1 systemd[1]: Starting Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator... Jul 16 12:01:30 1901-1 hostapd[10400]: Configuration file: /etc/hostapd/hostapd.conf Jul 16 12:01:30 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:30 1901-1 hostapd[10400]: Could not read interface wlan0 flags: No such device Jul 16 12:01:30 1901-1 hostapd[10400]: nl80211: Driver does not support authentication/association or connect commands Jul 16 12:01:30 1901-1 hostapd[10400]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Jul 16 12:01:30 1901-1 hostapd[10400]: Could not read interface wlan0 flags: No such device Jul 16 12:01:30 1901-1 hostapd[10400]: nl80211 driver initialization failed. Jul 16 12:01:30 1901-1 hostapd[10400]: wlan0: interface state UNINITIALIZED->DISABLED Jul 16 12:01:30 1901-1 hostapd[10400]: wlan0: AP-DISABLED Jul 16 12:01:30 1901-1 hostapd[10400]: wlan0: CTRL-EVENT-TERMINATING Jul 16 12:01:30 1901-1 hostapd[10400]: hostapd_free_hapd_data: Interface wlan0 wasn't started Jul 16 12:01:30 1901-1 systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Jul 16 12:01:30 1901-1 systemd[1]: hostapd.service: Failed with result 'exit-code'. Jul 16 12:01:30 1901-1 systemd[1]: Failed to start Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Jul 16 12:01:31 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:31 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:32 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:32 1901-1 systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 412. Jul 16 12:01:32 1901-1 systemd[1]: Stopped Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Jul 16 12:01:32 1901-1 systemd[1]: Starting Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator... Jul 16 12:01:32 1901-1 hostapd[10415]: Configuration file: /etc/hostapd/hostapd.conf Jul 16 12:01:33 1901-1 hostapd[10415]: Could not read interface wlan0 flags: No such device Jul 16 12:01:33 1901-1 hostapd[10415]: nl80211: Driver does not support authentication/association or connect commands Jul 16 12:01:33 1901-1 hostapd[10415]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Jul 16 12:01:33 1901-1 hostapd[10415]: Could not read interface wlan0 flags: No such device Jul 16 12:01:33 1901-1 hostapd[10415]: nl80211 driver initialization failed. Jul 16 12:01:33 1901-1 hostapd[10415]: wlan0: interface state UNINITIALIZED->DISABLED Jul 16 12:01:33 1901-1 hostapd[10415]: wlan0: AP-DISABLED Jul 16 12:01:33 1901-1 hostapd[10415]: wlan0: CTRL-EVENT-TERMINATING Jul 16 12:01:33 1901-1 hostapd[10415]: hostapd_free_hapd_data: Interface wlan0 wasn't started Jul 16 12:01:33 1901-1 systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Jul 16 12:01:33 1901-1 systemd[1]: hostapd.service: Failed with result 'exit-code'. Jul 16 12:01:33 1901-1 systemd[1]: Failed to start Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Jul 16 12:01:33 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:33 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:34 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:35 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:35 1901-1 systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 413. Jul 16 12:01:35 1901-1 systemd[1]: Stopped Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Jul 16 12:01:35 1901-1 systemd[1]: Starting Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator... Jul 16 12:01:35 1901-1 hostapd[10430]: Configuration file: /etc/hostapd/hostapd.conf Jul 16 12:01:35 1901-1 hostapd[10430]: Could not read interface wlan0 flags: No such device Jul 16 12:01:35 1901-1 hostapd[10430]: nl80211: Driver does not support authentication/association or connect commands Jul 16 12:01:35 1901-1 hostapd[10430]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Jul 16 12:01:35 1901-1 hostapd[10430]: Could not read interface wlan0 flags: No such device Jul 16 12:01:35 1901-1 hostapd[10430]: nl80211 driver initialization failed. Jul 16 12:01:35 1901-1 hostapd[10430]: wlan0: interface state UNINITIALIZED->DISABLED Jul 16 12:01:35 1901-1 hostapd[10430]: wlan0: AP-DISABLED Jul 16 12:01:35 1901-1 hostapd[10430]: wlan0: CTRL-EVENT-TERMINATING Jul 16 12:01:35 1901-1 hostapd[10430]: hostapd_free_hapd_data: Interface wlan0 wasn't started Jul 16 12:01:35 1901-1 systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Jul 16 12:01:35 1901-1 systemd[1]: hostapd.service: Failed with result 'exit-code'. Jul 16 12:01:35 1901-1 volumio[2335]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 16 12:01:35 1901-1 systemd[1]: Failed to start Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Jul 16 12:01:35 1901-1 volumio[2335]: info: CURURI: playlists Jul 16 12:01:35 1901-1 volumio[2335]: info: Listing playlists Jul 16 12:01:35 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:36 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:36 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:37 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:37 1901-1 systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 414. Jul 16 12:01:37 1901-1 systemd[1]: Stopped Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Jul 16 12:01:37 1901-1 systemd[1]: Starting Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator... Jul 16 12:01:37 1901-1 hostapd[10445]: Configuration file: /etc/hostapd/hostapd.conf Jul 16 12:01:37 1901-1 hostapd[10445]: Could not read interface wlan0 flags: No such device Jul 16 12:01:37 1901-1 hostapd[10445]: nl80211: Driver does not support authentication/association or connect commands Jul 16 12:01:37 1901-1 hostapd[10445]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Jul 16 12:01:37 1901-1 hostapd[10445]: Could not read interface wlan0 flags: No such device Jul 16 12:01:37 1901-1 hostapd[10445]: nl80211 driver initialization failed. Jul 16 12:01:37 1901-1 hostapd[10445]: wlan0: interface state UNINITIALIZED->DISABLED Jul 16 12:01:37 1901-1 hostapd[10445]: wlan0: AP-DISABLED Jul 16 12:01:37 1901-1 hostapd[10445]: wlan0: CTRL-EVENT-TERMINATING Jul 16 12:01:37 1901-1 hostapd[10445]: hostapd_free_hapd_data: Interface wlan0 wasn't started Jul 16 12:01:37 1901-1 systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Jul 16 12:01:37 1901-1 systemd[1]: hostapd.service: Failed with result 'exit-code'. Jul 16 12:01:37 1901-1 systemd[1]: Failed to start Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Jul 16 12:01:38 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:38 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:39 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:39 1901-1 systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 415. Jul 16 12:01:39 1901-1 systemd[1]: Stopped Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Jul 16 12:01:39 1901-1 systemd[1]: Starting Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator... Jul 16 12:01:39 1901-1 hostapd[10458]: Configuration file: /etc/hostapd/hostapd.conf Jul 16 12:01:39 1901-1 hostapd[10458]: Could not read interface wlan0 flags: No such device Jul 16 12:01:39 1901-1 hostapd[10458]: nl80211: Driver does not support authentication/association or connect commands Jul 16 12:01:39 1901-1 hostapd[10458]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Jul 16 12:01:39 1901-1 hostapd[10458]: Could not read interface wlan0 flags: No such device Jul 16 12:01:39 1901-1 hostapd[10458]: nl80211 driver initialization failed. Jul 16 12:01:39 1901-1 hostapd[10458]: wlan0: interface state UNINITIALIZED->DISABLED Jul 16 12:01:39 1901-1 hostapd[10458]: wlan0: AP-DISABLED Jul 16 12:01:39 1901-1 hostapd[10458]: wlan0: CTRL-EVENT-TERMINATING Jul 16 12:01:39 1901-1 hostapd[10458]: hostapd_free_hapd_data: Interface wlan0 wasn't started Jul 16 12:01:39 1901-1 systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Jul 16 12:01:39 1901-1 systemd[1]: hostapd.service: Failed with result 'exit-code'. Jul 16 12:01:39 1901-1 systemd[1]: Failed to start Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Jul 16 12:01:39 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:40 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:40 1901-1 volumio[2335]: info: CoreCommandRouter::volumioPlay Jul 16 12:01:40 1901-1 volumio[2335]: verbose: UNSET VOLATILE Jul 16 12:01:40 1901-1 volumio[2335]: info: CoreStateMachine::play index 12 Jul 16 12:01:40 1901-1 volumio[2335]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 16 12:01:40 1901-1 volumio[2335]: info: CoreStateMachine::stop Jul 16 12:01:40 1901-1 volumio[2335]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 16 12:01:40 1901-1 volumio[2335]: verbose: UNSET VOLATILE Jul 16 12:01:40 1901-1 volumio[2335]: info: CoreStateMachine::updateTrackBlock Jul 16 12:01:40 1901-1 volumio[2335]: info: CorePlayQueue::getTrackBlock Jul 16 12:01:40 1901-1 volumio[2335]: info: CoreStateMachine::stPlaybackTimer Jul 16 12:01:40 1901-1 volumio[2335]: info: CoreStateMachine::pushState Jul 16 12:01:40 1901-1 volumio[2335]: info: CorePlayQueue::getTrack 14 Jul 16 12:01:40 1901-1 volumio[2335]: info: CoreCommandRouter::volumioPushState Jul 16 12:01:40 1901-1 volumio[2335]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 16 12:01:40 1901-1 volumio[2335]: info: CoreStateMachine::serviceStop Jul 16 12:01:40 1901-1 volumio[2335]: info: CorePlayQueue::getTrack 14 Jul 16 12:01:40 1901-1 volumio[2335]: info: CoreCommandRouter::serviceStop Jul 16 12:01:40 1901-1 volumio[2335]: info: [1721102500845] ControllerUPNPBrowser::stop Jul 16 12:01:40 1901-1 volumio[2335]: verbose: ControllerMpd::sendMpdCommand stop Jul 16 12:01:40 1901-1 volumio[2335]: info: sendMpdCommand stop took 8 milliseconds Jul 16 12:01:40 1901-1 volumio[2335]: info: CoreStateMachine::play index undefined Jul 16 12:01:40 1901-1 volumio[2335]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 16 12:01:40 1901-1 volumio[2335]: info: CorePlayQueue::getTrack 12 Jul 16 12:01:40 1901-1 volumio[2335]: info: CoreStateMachine::startPlaybackTimer Jul 16 12:01:40 1901-1 volumio[2335]: info: CorePlayQueue::getTrack 12 Jul 16 12:01:40 1901-1 volumio[2335]: info: [1721102500858] ControllerUPNPBrowser::clearAddPlayTrack Jul 16 12:01:40 1901-1 volumio[2335]: verbose: ControllerMpd::sendMpdCommand stop Jul 16 12:01:40 1901-1 volumio[2335]: info: sendMpdCommand stop took 23 milliseconds Jul 16 12:01:40 1901-1 volumio[2335]: verbose: ControllerMpd::sendMpdCommand clear Jul 16 12:01:40 1901-1 volumio[2335]: info: Jul 16 12:01:40 1901-1 volumio[2335]: ---------------------------- MPD announces system playlist update Jul 16 12:01:40 1901-1 volumio[2335]: info: Ignoring MPD Status Update Jul 16 12:01:40 1901-1 volumio[2335]: info: sendMpdCommand clear took 4 milliseconds Jul 16 12:01:40 1901-1 volumio[2335]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.23.23:50002/m/NDLNA/4545.m4a" Jul 16 12:01:40 1901-1 volumio[2335]: info: Jul 16 12:01:40 1901-1 volumio[2335]: ---------------------------- MPD announces system playlist update Jul 16 12:01:40 1901-1 volumio[2335]: info: Ignoring MPD Status Update Jul 16 12:01:40 1901-1 volumio[2335]: error: updateQueue error: null Jul 16 12:01:40 1901-1 volumio[2335]: info: ------------------------------ 13ms Jul 16 12:01:40 1901-1 volumio[2335]: error: Could not retrieve plugin audio_interface multiroom Jul 16 12:01:40 1901-1 volumio[2335]: error: updateQueue error: null Jul 16 12:01:40 1901-1 volumio[2335]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.23.23:50002/m/NDLNA/4545.m4a" Jul 16 12:01:40 1901-1 volumio[2335]: info: ------------------------------ 34ms Jul 16 12:01:40 1901-1 volumio[2335]: info: Jul 16 12:01:40 1901-1 volumio[2335]: ---------------------------- MPD announces system playlist update Jul 16 12:01:40 1901-1 volumio[2335]: info: Ignoring MPD Status Update Jul 16 12:01:40 1901-1 volumio[2335]: info: sendMpdCommand add "http://192.168.23.23:50002/m/NDLNA/4545.m4a" took 5 milliseconds Jul 16 12:01:40 1901-1 volumio[2335]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 16 12:01:40 1901-1 volumio[2335]: verbose: ControllerMpd::sendMpdCommand play Jul 16 12:01:40 1901-1 volumio[2335]: info: Jul 16 12:01:40 1901-1 volumio[2335]: ---------------------------- MPD announces system playlist update Jul 16 12:01:40 1901-1 volumio[2335]: info: Ignoring MPD Status Update Jul 16 12:01:40 1901-1 volumio[2335]: info: ------------------------------ 9ms Jul 16 12:01:40 1901-1 volumio[2335]: info: sendMpdCommand play took 11 milliseconds Jul 16 12:01:40 1901-1 volumio[2335]: info: ------------------------------ 10ms Jul 16 12:01:41 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:41 1901-1 rc.local[2232]: command_len 9 Jul 16 12:01:41 1901-1 rc.local[2232]: getQueue Jul 16 12:01:41 1901-1 rc.local[2232]: Jul 16 12:01:41 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetQueue Jul 16 12:01:41 1901-1 volumio[2335]: info: CoreStateMachine::getQueue Jul 16 12:01:41 1901-1 volumio[2335]: info: CorePlayQueue::getQueue Jul 16 12:01:41 1901-1 rc.local[2232]: socket send Jul 16 12:01:41 1901-1 volumio[2335]: info: Jul 16 12:01:41 1901-1 volumio[2335]: ---------------------------- MPD announces state update: player Jul 16 12:01:41 1901-1 volumio[2335]: info: ControllerMpd::getState Jul 16 12:01:41 1901-1 volumio[2335]: verbose: ControllerMpd::sendMpdCommand status Jul 16 12:01:41 1901-1 volumio[2335]: info: Jul 16 12:01:41 1901-1 volumio[2335]: ---------------------------- MPD announces state update: player Jul 16 12:01:41 1901-1 volumio[2335]: info: ControllerMpd::getState Jul 16 12:01:41 1901-1 volumio[2335]: verbose: ControllerMpd::sendMpdCommand status Jul 16 12:01:41 1901-1 kernel: sunxi-spdif 2036000.spdif: active: 1 Jul 16 12:01:41 1901-1 volumio[2335]: info: Jul 16 12:01:41 1901-1 volumio[2335]: ---------------------------- MPD announces state update: player Jul 16 12:01:41 1901-1 volumio[2335]: info: sendMpdCommand status took 30 milliseconds Jul 16 12:01:41 1901-1 volumio[2335]: info: ControllerMpd::getState Jul 16 12:01:41 1901-1 volumio[2335]: verbose: ControllerMpd::sendMpdCommand status Jul 16 12:01:41 1901-1 volumio[2335]: info: sendMpdCommand status took 33 milliseconds Jul 16 12:01:41 1901-1 volumio[2335]: verbose: ControllerMpd::parseState Jul 16 12:01:41 1901-1 volumio[2335]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 16 12:01:41 1901-1 volumio[2335]: verbose: ControllerMpd::parseState Jul 16 12:01:41 1901-1 volumio[2335]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 16 12:01:41 1901-1 volumio[2335]: info: Jul 16 12:01:41 1901-1 volumio[2335]: ---------------------------- MPD announces state update: player Jul 16 12:01:41 1901-1 volumio[2335]: info: ControllerMpd::getState Jul 16 12:01:41 1901-1 volumio[2335]: verbose: ControllerMpd::sendMpdCommand status Jul 16 12:01:41 1901-1 volumio[2335]: info: sendMpdCommand status took 27 milliseconds Jul 16 12:01:41 1901-1 volumio[2335]: info: sendMpdCommand playlistinfo took 18 milliseconds Jul 16 12:01:41 1901-1 volumio[2335]: info: sendMpdCommand playlistinfo took 16 milliseconds Jul 16 12:01:41 1901-1 volumio[2335]: info: sendMpdCommand status took 17 milliseconds Jul 16 12:01:41 1901-1 volumio[2335]: verbose: ControllerMpd::parseState Jul 16 12:01:41 1901-1 volumio[2335]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 16 12:01:41 1901-1 volumio[2335]: verbose: ControllerMpd::parseTrackInfo Jul 16 12:01:41 1901-1 volumio[2335]: verbose: ControllerMpd::parseTrackInfo Jul 16 12:01:41 1901-1 volumio[2335]: verbose: ControllerMpd::parseState Jul 16 12:01:41 1901-1 volumio[2335]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 16 12:01:41 1901-1 volumio[2335]: info: ControllerMpd::pushState Jul 16 12:01:41 1901-1 volumio[2335]: info: CoreCommandRouter::servicePushState Jul 16 12:01:41 1901-1 volumio[2335]: info: CorePlayQueue::getTrack 12 Jul 16 12:01:41 1901-1 volumio[2335]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":230,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"4545.m4a","artist":null,"album":null,"uri":"http://192.168.23.23:50002/m/NDLNA/4545.m4a","trackType":"m4a"} Jul 16 12:01:41 1901-1 volumio[2335]: verbose: CURRENT POSITION 12 Jul 16 12:01:41 1901-1 volumio[2335]: info: CoreStateMachine::syncState stateService play Jul 16 12:01:41 1901-1 volumio[2335]: info: CoreStateMachine::syncState currentStatus stop Jul 16 12:01:41 1901-1 volumio[2335]: info: CoreStateMachine::pushState Jul 16 12:01:41 1901-1 volumio[2335]: info: CoreCommandRouter::volumioPushState Jul 16 12:01:41 1901-1 volumio[2335]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 16 12:01:41 1901-1 volumio[2335]: info: ControllerMpd::pushState Jul 16 12:01:41 1901-1 volumio[2335]: info: CoreCommandRouter::servicePushState Jul 16 12:01:41 1901-1 volumio[2335]: info: CorePlayQueue::getTrack 12 Jul 16 12:01:41 1901-1 volumio[2335]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":230,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"4545.m4a","artist":null,"album":null,"uri":"http://192.168.23.23:50002/m/NDLNA/4545.m4a","trackType":"m4a"} Jul 16 12:01:41 1901-1 volumio[2335]: verbose: CURRENT POSITION 12 Jul 16 12:01:41 1901-1 volumio[2335]: info: CoreStateMachine::syncState stateService play Jul 16 12:01:41 1901-1 volumio[2335]: info: CoreStateMachine::syncState currentStatus play Jul 16 12:01:41 1901-1 volumio[2335]: info: Received an update from plugin. extracting info from payload Jul 16 12:01:41 1901-1 volumio[2335]: info: CoreStateMachine::pushState Jul 16 12:01:41 1901-1 volumio[2335]: info: CoreCommandRouter::volumioPushState Jul 16 12:01:41 1901-1 volumio[2335]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 16 12:01:41 1901-1 volumio[2335]: info: CoreStateMachine::pushState Jul 16 12:01:41 1901-1 volumio[2335]: info: CoreCommandRouter::volumioPushState Jul 16 12:01:41 1901-1 volumio[2335]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 16 12:01:41 1901-1 volumio[2335]: info: ------------------------------ 149ms Jul 16 12:01:41 1901-1 volumio[2335]: info: ------------------------------ 147ms Jul 16 12:01:41 1901-1 volumio[2335]: info: sendMpdCommand playlistinfo took 69 milliseconds Jul 16 12:01:41 1901-1 volumio[2335]: info: sendMpdCommand playlistinfo took 64 milliseconds Jul 16 12:01:41 1901-1 volumio[2335]: verbose: ControllerMpd::parseTrackInfo Jul 16 12:01:41 1901-1 volumio[2335]: verbose: ControllerMpd::parseTrackInfo Jul 16 12:01:41 1901-1 volumio[2335]: info: ControllerMpd::pushState Jul 16 12:01:41 1901-1 volumio[2335]: info: CoreCommandRouter::servicePushState Jul 16 12:01:41 1901-1 volumio[2335]: info: CorePlayQueue::getTrack 12 Jul 16 12:01:41 1901-1 volumio[2335]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":230,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"4545.m4a","artist":null,"album":null,"uri":"http://192.168.23.23:50002/m/NDLNA/4545.m4a","trackType":"m4a"} Jul 16 12:01:41 1901-1 volumio[2335]: verbose: CURRENT POSITION 12 Jul 16 12:01:41 1901-1 volumio[2335]: info: CoreStateMachine::syncState stateService play Jul 16 12:01:41 1901-1 volumio[2335]: info: CoreStateMachine::syncState currentStatus play Jul 16 12:01:41 1901-1 volumio[2335]: info: Received an update from plugin. extracting info from payload Jul 16 12:01:41 1901-1 volumio[2335]: info: CoreStateMachine::pushState Jul 16 12:01:41 1901-1 volumio[2335]: info: CoreCommandRouter::volumioPushState Jul 16 12:01:41 1901-1 volumio[2335]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 16 12:01:41 1901-1 volumio[2335]: info: CoreStateMachine::pushState Jul 16 12:01:41 1901-1 volumio[2335]: info: CoreCommandRouter::volumioPushState Jul 16 12:01:41 1901-1 volumio[2335]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 16 12:01:41 1901-1 volumio[2335]: info: ControllerMpd::pushState Jul 16 12:01:41 1901-1 volumio[2335]: info: CoreCommandRouter::servicePushState Jul 16 12:01:41 1901-1 volumio[2335]: info: CorePlayQueue::getTrack 12 Jul 16 12:01:41 1901-1 volumio[2335]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":230,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"4545.m4a","artist":null,"album":null,"uri":"http://192.168.23.23:50002/m/NDLNA/4545.m4a","trackType":"m4a"} Jul 16 12:01:41 1901-1 volumio[2335]: verbose: CURRENT POSITION 12 Jul 16 12:01:41 1901-1 volumio[2335]: info: CoreStateMachine::syncState stateService play Jul 16 12:01:41 1901-1 volumio[2335]: info: CoreStateMachine::syncState currentStatus play Jul 16 12:01:41 1901-1 volumio[2335]: info: Received an update from plugin. extracting info from payload Jul 16 12:01:41 1901-1 volumio[2335]: info: CoreStateMachine::pushState Jul 16 12:01:41 1901-1 volumio[2335]: info: CoreCommandRouter::volumioPushState Jul 16 12:01:41 1901-1 volumio[2335]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 16 12:01:41 1901-1 volumio[2335]: info: CoreStateMachine::pushState Jul 16 12:01:41 1901-1 volumio[2335]: info: CoreCommandRouter::volumioPushState Jul 16 12:01:41 1901-1 volumio[2335]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 16 12:01:41 1901-1 volumio[2335]: info: ------------------------------ 188ms Jul 16 12:01:41 1901-1 volumio[2335]: info: ------------------------------ 161ms Jul 16 12:01:41 1901-1 volumio[2335]: error: Could not retrieve plugin audio_interface multiroom Jul 16 12:01:41 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:41 1901-1 volumio[2335]: error: Could not retrieve plugin audio_interface multiroom Jul 16 12:01:41 1901-1 systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 416. Jul 16 12:01:41 1901-1 systemd[1]: Stopped Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Jul 16 12:01:41 1901-1 systemd[1]: Starting Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator... Jul 16 12:01:42 1901-1 volumio[2335]: error: Could not retrieve plugin audio_interface multiroom Jul 16 12:01:42 1901-1 volumio[2335]: error: Could not retrieve plugin audio_interface multiroom Jul 16 12:01:42 1901-1 volumio[2335]: error: Could not retrieve plugin audio_interface multiroom Jul 16 12:01:42 1901-1 hostapd[10481]: Configuration file: /etc/hostapd/hostapd.conf Jul 16 12:01:42 1901-1 volumio[2335]: error: Could not retrieve plugin audio_interface multiroom Jul 16 12:01:42 1901-1 volumio[2335]: error: Could not retrieve plugin audio_interface multiroom Jul 16 12:01:42 1901-1 hostapd[10481]: Could not read interface wlan0 flags: No such device Jul 16 12:01:42 1901-1 hostapd[10481]: nl80211: Driver does not support authentication/association or connect commands Jul 16 12:01:42 1901-1 hostapd[10481]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Jul 16 12:01:42 1901-1 rc.local[10483]: % Total % Received % Xferd Average Speed Time Time Time Current Jul 16 12:01:42 1901-1 rc.local[10483]: Dload Upload Total Spent Left Speed Jul 16 12:01:42 1901-1 hostapd[10481]: Could not read interface wlan0 flags: No such device Jul 16 12:01:42 1901-1 hostapd[10481]: nl80211 driver initialization failed. Jul 16 12:01:42 1901-1 hostapd[10481]: wlan0: interface state UNINITIALIZED->DISABLED Jul 16 12:01:42 1901-1 hostapd[10481]: wlan0: AP-DISABLED Jul 16 12:01:42 1901-1 hostapd[10481]: wlan0: CTRL-EVENT-TERMINATING Jul 16 12:01:42 1901-1 hostapd[10481]: hostapd_free_hapd_data: Interface wlan0 wasn't started Jul 16 12:01:42 1901-1 systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Jul 16 12:01:42 1901-1 systemd[1]: hostapd.service: Failed with result 'exit-code'. Jul 16 12:01:42 1901-1 systemd[1]: Failed to start Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Jul 16 12:01:42 1901-1 rc.local[10483]: [237B blob data] Jul 16 12:01:43 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:44 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:44 1901-1 systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 417. Jul 16 12:01:44 1901-1 systemd[1]: Stopped Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Jul 16 12:01:44 1901-1 systemd[1]: Starting Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator... Jul 16 12:01:44 1901-1 hostapd[10503]: Configuration file: /etc/hostapd/hostapd.conf Jul 16 12:01:44 1901-1 hostapd[10503]: Could not read interface wlan0 flags: No such device Jul 16 12:01:44 1901-1 hostapd[10503]: nl80211: Driver does not support authentication/association or connect commands Jul 16 12:01:44 1901-1 hostapd[10503]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Jul 16 12:01:44 1901-1 hostapd[10503]: Could not read interface wlan0 flags: No such device Jul 16 12:01:44 1901-1 hostapd[10503]: nl80211 driver initialization failed. Jul 16 12:01:44 1901-1 hostapd[10503]: wlan0: interface state UNINITIALIZED->DISABLED Jul 16 12:01:44 1901-1 hostapd[10503]: wlan0: AP-DISABLED Jul 16 12:01:44 1901-1 hostapd[10503]: wlan0: CTRL-EVENT-TERMINATING Jul 16 12:01:44 1901-1 hostapd[10503]: hostapd_free_hapd_data: Interface wlan0 wasn't started Jul 16 12:01:44 1901-1 systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Jul 16 12:01:44 1901-1 systemd[1]: hostapd.service: Failed with result 'exit-code'. Jul 16 12:01:44 1901-1 systemd[1]: Failed to start Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Jul 16 12:01:44 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:45 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:45 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:46 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:46 1901-1 systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 418. Jul 16 12:01:46 1901-1 systemd[1]: Stopped Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Jul 16 12:01:46 1901-1 systemd[1]: Starting Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator... Jul 16 12:01:46 1901-1 hostapd[10518]: Configuration file: /etc/hostapd/hostapd.conf Jul 16 12:01:46 1901-1 hostapd[10518]: Could not read interface wlan0 flags: No such device Jul 16 12:01:46 1901-1 hostapd[10518]: nl80211: Driver does not support authentication/association or connect commands Jul 16 12:01:46 1901-1 hostapd[10518]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Jul 16 12:01:46 1901-1 hostapd[10518]: Could not read interface wlan0 flags: No such device Jul 16 12:01:46 1901-1 hostapd[10518]: nl80211 driver initialization failed. Jul 16 12:01:46 1901-1 hostapd[10518]: wlan0: interface state UNINITIALIZED->DISABLED Jul 16 12:01:46 1901-1 hostapd[10518]: wlan0: AP-DISABLED Jul 16 12:01:46 1901-1 hostapd[10518]: wlan0: CTRL-EVENT-TERMINATING Jul 16 12:01:46 1901-1 hostapd[10518]: hostapd_free_hapd_data: Interface wlan0 wasn't started Jul 16 12:01:46 1901-1 systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Jul 16 12:01:46 1901-1 systemd[1]: hostapd.service: Failed with result 'exit-code'. Jul 16 12:01:46 1901-1 systemd[1]: Failed to start Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Jul 16 12:01:47 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:47 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:47 1901-1 volumio[2335]: info: CoreCommandRouter::volumioPlay Jul 16 12:01:47 1901-1 volumio[2335]: verbose: UNSET VOLATILE Jul 16 12:01:47 1901-1 volumio[2335]: info: CoreStateMachine::play index 14 Jul 16 12:01:47 1901-1 volumio[2335]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 16 12:01:47 1901-1 volumio[2335]: info: CoreStateMachine::stop Jul 16 12:01:47 1901-1 volumio[2335]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 16 12:01:47 1901-1 volumio[2335]: verbose: UNSET VOLATILE Jul 16 12:01:47 1901-1 volumio[2335]: info: CoreStateMachine::stPlaybackTimer Jul 16 12:01:47 1901-1 volumio[2335]: info: CoreStateMachine::updateTrackBlock Jul 16 12:01:47 1901-1 volumio[2335]: info: CorePlayQueue::getTrackBlock Jul 16 12:01:47 1901-1 volumio[2335]: info: CoreStateMachine::pushState Jul 16 12:01:47 1901-1 volumio[2335]: info: CorePlayQueue::getTrack 12 Jul 16 12:01:47 1901-1 volumio[2335]: info: CoreCommandRouter::volumioPushState Jul 16 12:01:47 1901-1 volumio[2335]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 16 12:01:47 1901-1 volumio[2335]: info: CoreStateMachine::serviceStop Jul 16 12:01:47 1901-1 volumio[2335]: info: CorePlayQueue::getTrack 12 Jul 16 12:01:47 1901-1 volumio[2335]: info: CoreCommandRouter::serviceStop Jul 16 12:01:47 1901-1 volumio[2335]: info: [1721102507725] ControllerUPNPBrowser::stop Jul 16 12:01:47 1901-1 volumio[2335]: verbose: ControllerMpd::sendMpdCommand stop Jul 16 12:01:47 1901-1 volumio[2335]: error: Could not retrieve plugin audio_interface multiroom Jul 16 12:01:47 1901-1 volumio[2335]: info: sendMpdCommand stop took 70 milliseconds Jul 16 12:01:47 1901-1 volumio[2335]: info: CoreStateMachine::play index undefined Jul 16 12:01:47 1901-1 volumio[2335]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 16 12:01:47 1901-1 volumio[2335]: info: CorePlayQueue::getTrack 14 Jul 16 12:01:47 1901-1 volumio[2335]: info: CoreStateMachine::startPlaybackTimer Jul 16 12:01:47 1901-1 volumio[2335]: info: CorePlayQueue::getTrack 14 Jul 16 12:01:47 1901-1 volumio[2335]: info: [1721102507799] ControllerUPNPBrowser::clearAddPlayTrack Jul 16 12:01:47 1901-1 volumio[2335]: verbose: ControllerMpd::sendMpdCommand stop Jul 16 12:01:47 1901-1 volumio[2335]: info: Jul 16 12:01:47 1901-1 volumio[2335]: ---------------------------- MPD announces state update: player Jul 16 12:01:47 1901-1 volumio[2335]: info: ControllerMpd::getState Jul 16 12:01:47 1901-1 volumio[2335]: verbose: ControllerMpd::sendMpdCommand status Jul 16 12:01:47 1901-1 volumio[2335]: info: sendMpdCommand stop took 10 milliseconds Jul 16 12:01:47 1901-1 volumio[2335]: verbose: ControllerMpd::sendMpdCommand clear Jul 16 12:01:47 1901-1 volumio[2335]: info: Jul 16 12:01:47 1901-1 volumio[2335]: ---------------------------- MPD announces state update: player Jul 16 12:01:47 1901-1 volumio[2335]: info: ControllerMpd::getState Jul 16 12:01:47 1901-1 volumio[2335]: verbose: ControllerMpd::sendMpdCommand status Jul 16 12:01:47 1901-1 volumio[2335]: info: Jul 16 12:01:47 1901-1 volumio[2335]: ---------------------------- MPD announces system playlist update Jul 16 12:01:47 1901-1 volumio[2335]: info: Ignoring MPD Status Update Jul 16 12:01:47 1901-1 volumio[2335]: info: sendMpdCommand status took 30 milliseconds Jul 16 12:01:47 1901-1 volumio[2335]: info: sendMpdCommand clear took 31 milliseconds Jul 16 12:01:47 1901-1 volumio[2335]: info: sendMpdCommand status took 28 milliseconds Jul 16 12:01:47 1901-1 volumio[2335]: verbose: ControllerMpd::parseState Jul 16 12:01:47 1901-1 volumio[2335]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 16 12:01:47 1901-1 volumio[2335]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.23.23:50002/m/NDLNA/4550.flac" Jul 16 12:01:47 1901-1 volumio[2335]: verbose: ControllerMpd::parseState Jul 16 12:01:47 1901-1 volumio[2335]: info: ControllerMpd::pushState Jul 16 12:01:47 1901-1 volumio[2335]: info: CoreCommandRouter::servicePushState Jul 16 12:01:47 1901-1 volumio[2335]: info: CoreStateMachine::pushState Jul 16 12:01:47 1901-1 volumio[2335]: info: CorePlayQueue::getTrack 14 Jul 16 12:01:47 1901-1 volumio[2335]: info: CoreCommandRouter::volumioPushState Jul 16 12:01:47 1901-1 volumio[2335]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 16 12:01:47 1901-1 volumio[2335]: info: CorePlayQueue::getTrack 14 Jul 16 12:01:47 1901-1 volumio[2335]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jul 16 12:01:47 1901-1 volumio[2335]: verbose: CURRENT POSITION 14 Jul 16 12:01:47 1901-1 volumio[2335]: info: CoreStateMachine::syncState stateService stop Jul 16 12:01:47 1901-1 volumio[2335]: info: CoreStateMachine::syncState currentStatus stop Jul 16 12:01:47 1901-1 volumio[2335]: info: CoreStateMachine::pushState Jul 16 12:01:47 1901-1 volumio[2335]: info: CorePlayQueue::getTrack 14 Jul 16 12:01:47 1901-1 volumio[2335]: info: CoreCommandRouter::volumioPushState Jul 16 12:01:47 1901-1 volumio[2335]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 16 12:01:47 1901-1 volumio[2335]: info: No code Jul 16 12:01:47 1901-1 volumio[2335]: info: CoreStateMachine::pushState Jul 16 12:01:47 1901-1 volumio[2335]: info: CorePlayQueue::getTrack 14 Jul 16 12:01:47 1901-1 volumio[2335]: info: CoreCommandRouter::volumioPushState Jul 16 12:01:47 1901-1 volumio[2335]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 16 12:01:47 1901-1 volumio[2335]: info: ------------------------------ 73ms Jul 16 12:01:47 1901-1 volumio[2335]: info: Jul 16 12:01:47 1901-1 volumio[2335]: ---------------------------- MPD announces system playlist update Jul 16 12:01:47 1901-1 volumio[2335]: info: Ignoring MPD Status Update Jul 16 12:01:47 1901-1 volumio[2335]: error: updateQueue error: null Jul 16 12:01:47 1901-1 volumio[2335]: info: ------------------------------ 68ms Jul 16 12:01:47 1901-1 volumio[2335]: info: sendMpdCommand playlistinfo took 46 milliseconds Jul 16 12:01:47 1901-1 volumio[2335]: verbose: ControllerMpd::parseTrackInfo Jul 16 12:01:47 1901-1 volumio[2335]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jul 16 12:01:47 1901-1 volumio[2335]: info: ------------------------------ 89ms Jul 16 12:01:47 1901-1 volumio[2335]: error: Could not retrieve plugin audio_interface multiroom Jul 16 12:01:47 1901-1 volumio[2335]: error: Could not retrieve plugin audio_interface multiroom Jul 16 12:01:47 1901-1 volumio[2335]: error: Could not retrieve plugin audio_interface multiroom Jul 16 12:01:48 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:48 1901-1 volumio[2335]: info: CorePlayQueue::getTrack 14 Jul 16 12:01:48 1901-1 rc.local[10534]: % Total % Received % Xferd Average Speed Time Time Time Current Jul 16 12:01:48 1901-1 rc.local[10534]: Dload Upload Total Spent Left Speed Jul 16 12:01:48 1901-1 rc.local[10534]: [158B blob data] Jul 16 12:01:48 1901-1 volumio[2335]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.23.23:50002/m/NDLNA/4550.flac" Jul 16 12:01:48 1901-1 volumio[2335]: error: updateQueue error: null Jul 16 12:01:48 1901-1 volumio[2335]: info: Jul 16 12:01:48 1901-1 volumio[2335]: ---------------------------- MPD announces system playlist update Jul 16 12:01:48 1901-1 volumio[2335]: info: Ignoring MPD Status Update Jul 16 12:01:48 1901-1 volumio[2335]: info: ------------------------------ 1012ms Jul 16 12:01:48 1901-1 volumio[2335]: info: sendMpdCommand add "http://192.168.23.23:50002/m/NDLNA/4550.flac" took 9 milliseconds Jul 16 12:01:48 1901-1 volumio[2335]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 16 12:01:48 1901-1 volumio[2335]: verbose: ControllerMpd::sendMpdCommand play Jul 16 12:01:48 1901-1 volumio[2335]: info: Jul 16 12:01:48 1901-1 volumio[2335]: ---------------------------- MPD announces system playlist update Jul 16 12:01:48 1901-1 volumio[2335]: info: Ignoring MPD Status Update Jul 16 12:01:48 1901-1 systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 419. Jul 16 12:01:48 1901-1 kernel: sunxi-spdif 2036000.spdif: active: 1 Jul 16 12:01:48 1901-1 volumio[2335]: info: Jul 16 12:01:48 1901-1 volumio[2335]: ---------------------------- MPD announces state update: player Jul 16 12:01:48 1901-1 systemd[1]: Stopped Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Jul 16 12:01:48 1901-1 volumio[2335]: info: Jul 16 12:01:48 1901-1 volumio[2335]: ---------------------------- MPD announces state update: player Jul 16 12:01:48 1901-1 volumio[2335]: info: ------------------------------ 53ms Jul 16 12:01:48 1901-1 volumio[2335]: info: sendMpdCommand play took 32 milliseconds Jul 16 12:01:48 1901-1 volumio[2335]: info: ControllerMpd::getState Jul 16 12:01:48 1901-1 volumio[2335]: verbose: ControllerMpd::sendMpdCommand status Jul 16 12:01:48 1901-1 volumio[2335]: info: ------------------------------ 25ms Jul 16 12:01:48 1901-1 volumio[2335]: info: ControllerMpd::getState Jul 16 12:01:48 1901-1 volumio[2335]: verbose: ControllerMpd::sendMpdCommand status Jul 16 12:01:48 1901-1 volumio[2335]: info: Jul 16 12:01:48 1901-1 volumio[2335]: ---------------------------- MPD announces state update: player Jul 16 12:01:48 1901-1 volumio[2335]: info: ControllerMpd::getState Jul 16 12:01:48 1901-1 volumio[2335]: verbose: ControllerMpd::sendMpdCommand status Jul 16 12:01:48 1901-1 systemd[1]: Starting Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator... Jul 16 12:01:48 1901-1 volumio[2335]: info: sendMpdCommand status took 35 milliseconds Jul 16 12:01:49 1901-1 volumio[2335]: info: sendMpdCommand status took 37 milliseconds Jul 16 12:01:49 1901-1 volumio[2335]: info: sendMpdCommand status took 34 milliseconds Jul 16 12:01:49 1901-1 volumio[2335]: verbose: ControllerMpd::parseState Jul 16 12:01:49 1901-1 volumio[2335]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 16 12:01:49 1901-1 volumio[2335]: verbose: ControllerMpd::parseState Jul 16 12:01:49 1901-1 volumio[2335]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 16 12:01:49 1901-1 volumio[2335]: verbose: ControllerMpd::parseState Jul 16 12:01:49 1901-1 volumio[2335]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 16 12:01:49 1901-1 volumio[2335]: info: Jul 16 12:01:49 1901-1 volumio[2335]: ---------------------------- MPD announces state update: player Jul 16 12:01:49 1901-1 volumio[2335]: info: ControllerMpd::getState Jul 16 12:01:49 1901-1 volumio[2335]: verbose: ControllerMpd::sendMpdCommand status Jul 16 12:01:49 1901-1 rc.local[2232]: command_len 9 Jul 16 12:01:49 1901-1 rc.local[2232]: getQueue Jul 16 12:01:49 1901-1 rc.local[2232]: Jul 16 12:01:49 1901-1 volumio[2335]: info: sendMpdCommand playlistinfo took 54 milliseconds Jul 16 12:01:49 1901-1 volumio[2335]: info: sendMpdCommand playlistinfo took 48 milliseconds Jul 16 12:01:49 1901-1 volumio[2335]: info: sendMpdCommand playlistinfo took 42 milliseconds Jul 16 12:01:49 1901-1 hostapd[10542]: Configuration file: /etc/hostapd/hostapd.conf Jul 16 12:01:49 1901-1 volumio[2335]: info: sendMpdCommand status took 10 milliseconds Jul 16 12:01:49 1901-1 volumio[2335]: verbose: ControllerMpd::parseTrackInfo Jul 16 12:01:49 1901-1 volumio[2335]: verbose: ControllerMpd::parseTrackInfo Jul 16 12:01:49 1901-1 volumio[2335]: verbose: ControllerMpd::parseTrackInfo Jul 16 12:01:49 1901-1 volumio[2335]: verbose: ControllerMpd::parseState Jul 16 12:01:49 1901-1 volumio[2335]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 16 12:01:49 1901-1 volumio[2335]: info: ControllerMpd::pushState Jul 16 12:01:49 1901-1 volumio[2335]: info: CoreCommandRouter::servicePushState Jul 16 12:01:49 1901-1 volumio[2335]: info: CorePlayQueue::getTrack 14 Jul 16 12:01:49 1901-1 hostapd[10542]: Could not read interface wlan0 flags: No such device Jul 16 12:01:49 1901-1 hostapd[10542]: nl80211: Driver does not support authentication/association or connect commands Jul 16 12:01:49 1901-1 hostapd[10542]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Jul 16 12:01:49 1901-1 volumio[2335]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":255,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"4550.flac","artist":null,"album":null,"uri":"http://192.168.23.23:50002/m/NDLNA/4550.flac","trackType":"flac"} Jul 16 12:01:49 1901-1 volumio[2335]: verbose: CURRENT POSITION 14 Jul 16 12:01:49 1901-1 volumio[2335]: info: CoreStateMachine::syncState stateService play Jul 16 12:01:49 1901-1 volumio[2335]: info: CoreStateMachine::syncState currentStatus stop Jul 16 12:01:49 1901-1 volumio[2335]: info: CoreStateMachine::pushState Jul 16 12:01:49 1901-1 hostapd[10542]: Could not read interface wlan0 flags: No such device Jul 16 12:01:49 1901-1 hostapd[10542]: nl80211 driver initialization failed. Jul 16 12:01:49 1901-1 hostapd[10542]: wlan0: interface state UNINITIALIZED->DISABLED Jul 16 12:01:49 1901-1 hostapd[10542]: wlan0: AP-DISABLED Jul 16 12:01:49 1901-1 hostapd[10542]: wlan0: CTRL-EVENT-TERMINATING Jul 16 12:01:49 1901-1 hostapd[10542]: hostapd_free_hapd_data: Interface wlan0 wasn't started Jul 16 12:01:49 1901-1 systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Jul 16 12:01:49 1901-1 systemd[1]: hostapd.service: Failed with result 'exit-code'. Jul 16 12:01:49 1901-1 systemd[1]: Failed to start Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Jul 16 12:01:49 1901-1 volumio[2335]: info: CoreCommandRouter::volumioPushState Jul 16 12:01:49 1901-1 volumio[2335]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 16 12:01:49 1901-1 volumio[2335]: info: ControllerMpd::pushState Jul 16 12:01:49 1901-1 volumio[2335]: info: CoreCommandRouter::servicePushState Jul 16 12:01:49 1901-1 volumio[2335]: info: CorePlayQueue::getTrack 14 Jul 16 12:01:49 1901-1 volumio[2335]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":255,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"4550.flac","artist":null,"album":null,"uri":"http://192.168.23.23:50002/m/NDLNA/4550.flac","trackType":"flac"} Jul 16 12:01:49 1901-1 volumio[2335]: verbose: CURRENT POSITION 14 Jul 16 12:01:49 1901-1 volumio[2335]: info: CoreStateMachine::syncState stateService play Jul 16 12:01:49 1901-1 volumio[2335]: info: CoreStateMachine::syncState currentStatus play Jul 16 12:01:49 1901-1 volumio[2335]: info: Received an update from plugin. extracting info from payload Jul 16 12:01:49 1901-1 volumio[2335]: info: CoreStateMachine::pushState Jul 16 12:01:49 1901-1 volumio[2335]: info: CoreCommandRouter::volumioPushState Jul 16 12:01:49 1901-1 volumio[2335]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 16 12:01:49 1901-1 volumio[2335]: info: CoreStateMachine::pushState Jul 16 12:01:49 1901-1 volumio[2335]: info: CoreCommandRouter::volumioPushState Jul 16 12:01:49 1901-1 volumio[2335]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 16 12:01:49 1901-1 volumio[2335]: info: ControllerMpd::pushState Jul 16 12:01:49 1901-1 volumio[2335]: info: CoreCommandRouter::servicePushState Jul 16 12:01:49 1901-1 volumio[2335]: info: CorePlayQueue::getTrack 14 Jul 16 12:01:49 1901-1 volumio[2335]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":255,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"4550.flac","artist":null,"album":null,"uri":"http://192.168.23.23:50002/m/NDLNA/4550.flac","trackType":"flac"} Jul 16 12:01:49 1901-1 volumio[2335]: verbose: CURRENT POSITION 14 Jul 16 12:01:49 1901-1 volumio[2335]: info: CoreStateMachine::syncState stateService play Jul 16 12:01:49 1901-1 volumio[2335]: info: CoreStateMachine::syncState currentStatus play Jul 16 12:01:49 1901-1 volumio[2335]: info: Received an update from plugin. extracting info from payload Jul 16 12:01:49 1901-1 volumio[2335]: info: CoreStateMachine::pushState Jul 16 12:01:49 1901-1 volumio[2335]: info: CoreCommandRouter::volumioPushState Jul 16 12:01:49 1901-1 volumio[2335]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 16 12:01:49 1901-1 volumio[2335]: info: CoreStateMachine::pushState Jul 16 12:01:49 1901-1 volumio[2335]: info: CoreCommandRouter::volumioPushState Jul 16 12:01:49 1901-1 volumio[2335]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 16 12:01:49 1901-1 volumio[2335]: info: ------------------------------ 303ms Jul 16 12:01:49 1901-1 volumio[2335]: info: ------------------------------ 301ms Jul 16 12:01:49 1901-1 volumio[2335]: info: ------------------------------ 284ms Jul 16 12:01:49 1901-1 volumio[2335]: info: sendMpdCommand playlistinfo took 148 milliseconds Jul 16 12:01:49 1901-1 volumio[2335]: verbose: ControllerMpd::parseTrackInfo Jul 16 12:01:49 1901-1 volumio[2335]: info: ControllerMpd::pushState Jul 16 12:01:49 1901-1 volumio[2335]: info: CoreCommandRouter::servicePushState Jul 16 12:01:49 1901-1 volumio[2335]: info: CorePlayQueue::getTrack 14 Jul 16 12:01:49 1901-1 volumio[2335]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":255,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"4550.flac","artist":null,"album":null,"uri":"http://192.168.23.23:50002/m/NDLNA/4550.flac","trackType":"flac"} Jul 16 12:01:49 1901-1 volumio[2335]: verbose: CURRENT POSITION 14 Jul 16 12:01:49 1901-1 volumio[2335]: info: CoreStateMachine::syncState stateService play Jul 16 12:01:49 1901-1 volumio[2335]: info: CoreStateMachine::syncState currentStatus play Jul 16 12:01:49 1901-1 volumio[2335]: info: Received an update from plugin. extracting info from payload Jul 16 12:01:49 1901-1 volumio[2335]: info: CoreStateMachine::pushState Jul 16 12:01:49 1901-1 volumio[2335]: info: CoreCommandRouter::volumioPushState Jul 16 12:01:49 1901-1 volumio[2335]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 16 12:01:49 1901-1 volumio[2335]: info: CoreStateMachine::pushState Jul 16 12:01:49 1901-1 volumio[2335]: info: CoreCommandRouter::volumioPushState Jul 16 12:01:49 1901-1 volumio[2335]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 16 12:01:49 1901-1 volumio[2335]: info: ------------------------------ 234ms Jul 16 12:01:49 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetQueue Jul 16 12:01:49 1901-1 volumio[2335]: info: CoreStateMachine::getQueue Jul 16 12:01:49 1901-1 volumio[2335]: info: CorePlayQueue::getQueue Jul 16 12:01:49 1901-1 rc.local[2232]: socket send Jul 16 12:01:49 1901-1 volumio[2335]: error: Could not retrieve plugin audio_interface multiroom Jul 16 12:01:49 1901-1 volumio[2335]: error: Could not retrieve plugin audio_interface multiroom Jul 16 12:01:49 1901-1 volumio[2335]: error: Could not retrieve plugin audio_interface multiroom Jul 16 12:01:49 1901-1 volumio[2335]: error: Could not retrieve plugin audio_interface multiroom Jul 16 12:01:49 1901-1 volumio[2335]: error: Could not retrieve plugin audio_interface multiroom Jul 16 12:01:49 1901-1 volumio[2335]: error: Could not retrieve plugin audio_interface multiroom Jul 16 12:01:49 1901-1 volumio[2335]: error: Could not retrieve plugin audio_interface multiroom Jul 16 12:01:49 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:50 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:50 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:51 1901-1 systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 420. Jul 16 12:01:51 1901-1 systemd[1]: Stopped Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Jul 16 12:01:51 1901-1 systemd[1]: Starting Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator... Jul 16 12:01:51 1901-1 hostapd[10556]: Configuration file: /etc/hostapd/hostapd.conf Jul 16 12:01:51 1901-1 hostapd[10556]: Could not read interface wlan0 flags: No such device Jul 16 12:01:51 1901-1 hostapd[10556]: nl80211: Driver does not support authentication/association or connect commands Jul 16 12:01:51 1901-1 hostapd[10556]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Jul 16 12:01:51 1901-1 hostapd[10556]: Could not read interface wlan0 flags: No such device Jul 16 12:01:51 1901-1 hostapd[10556]: nl80211 driver initialization failed. Jul 16 12:01:51 1901-1 hostapd[10556]: wlan0: interface state UNINITIALIZED->DISABLED Jul 16 12:01:51 1901-1 hostapd[10556]: wlan0: AP-DISABLED Jul 16 12:01:51 1901-1 hostapd[10556]: wlan0: CTRL-EVENT-TERMINATING Jul 16 12:01:51 1901-1 hostapd[10556]: hostapd_free_hapd_data: Interface wlan0 wasn't started Jul 16 12:01:51 1901-1 systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Jul 16 12:01:51 1901-1 systemd[1]: hostapd.service: Failed with result 'exit-code'. Jul 16 12:01:51 1901-1 systemd[1]: Failed to start Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Jul 16 12:01:51 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:52 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:52 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:53 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:53 1901-1 systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 421. Jul 16 12:01:53 1901-1 systemd[1]: Stopped Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Jul 16 12:01:53 1901-1 systemd[1]: Starting Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator... Jul 16 12:01:53 1901-1 hostapd[10571]: Configuration file: /etc/hostapd/hostapd.conf Jul 16 12:01:53 1901-1 hostapd[10571]: Could not read interface wlan0 flags: No such device Jul 16 12:01:53 1901-1 hostapd[10571]: nl80211: Driver does not support authentication/association or connect commands Jul 16 12:01:53 1901-1 hostapd[10571]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Jul 16 12:01:53 1901-1 hostapd[10571]: Could not read interface wlan0 flags: No such device Jul 16 12:01:53 1901-1 hostapd[10571]: nl80211 driver initialization failed. Jul 16 12:01:53 1901-1 hostapd[10571]: wlan0: interface state UNINITIALIZED->DISABLED Jul 16 12:01:53 1901-1 hostapd[10571]: wlan0: AP-DISABLED Jul 16 12:01:53 1901-1 hostapd[10571]: wlan0: CTRL-EVENT-TERMINATING Jul 16 12:01:53 1901-1 hostapd[10571]: hostapd_free_hapd_data: Interface wlan0 wasn't started Jul 16 12:01:53 1901-1 systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Jul 16 12:01:53 1901-1 systemd[1]: hostapd.service: Failed with result 'exit-code'. Jul 16 12:01:53 1901-1 systemd[1]: Failed to start Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Jul 16 12:01:53 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:54 1901-1 volumio[2335]: info: CoreCommandRouter::volumioPlay Jul 16 12:01:54 1901-1 volumio[2335]: verbose: UNSET VOLATILE Jul 16 12:01:54 1901-1 volumio[2335]: info: CoreStateMachine::play index 13 Jul 16 12:01:54 1901-1 volumio[2335]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 16 12:01:54 1901-1 volumio[2335]: info: CoreStateMachine::stop Jul 16 12:01:54 1901-1 volumio[2335]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 16 12:01:54 1901-1 volumio[2335]: verbose: UNSET VOLATILE Jul 16 12:01:54 1901-1 volumio[2335]: info: CoreStateMachine::stPlaybackTimer Jul 16 12:01:54 1901-1 volumio[2335]: info: CoreStateMachine::updateTrackBlock Jul 16 12:01:54 1901-1 volumio[2335]: info: CorePlayQueue::getTrackBlock Jul 16 12:01:54 1901-1 volumio[2335]: info: CoreStateMachine::pushState Jul 16 12:01:54 1901-1 volumio[2335]: info: CorePlayQueue::getTrack 14 Jul 16 12:01:54 1901-1 volumio[2335]: info: CoreCommandRouter::volumioPushState Jul 16 12:01:54 1901-1 volumio[2335]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 16 12:01:54 1901-1 volumio[2335]: info: CoreStateMachine::serviceStop Jul 16 12:01:54 1901-1 volumio[2335]: info: CorePlayQueue::getTrack 14 Jul 16 12:01:54 1901-1 volumio[2335]: info: CoreCommandRouter::serviceStop Jul 16 12:01:54 1901-1 volumio[2335]: info: [1721102514412] ControllerUPNPBrowser::stop Jul 16 12:01:54 1901-1 volumio[2335]: verbose: ControllerMpd::sendMpdCommand stop Jul 16 12:01:54 1901-1 volumio[2335]: info: Jul 16 12:01:54 1901-1 volumio[2335]: ---------------------------- MPD announces state update: player Jul 16 12:01:54 1901-1 volumio[2335]: info: sendMpdCommand stop took 8 milliseconds Jul 16 12:01:54 1901-1 volumio[2335]: info: ControllerMpd::getState Jul 16 12:01:54 1901-1 volumio[2335]: verbose: ControllerMpd::sendMpdCommand status Jul 16 12:01:54 1901-1 volumio[2335]: info: CoreStateMachine::play index undefined Jul 16 12:01:54 1901-1 volumio[2335]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 16 12:01:54 1901-1 volumio[2335]: info: CorePlayQueue::getTrack 13 Jul 16 12:01:54 1901-1 volumio[2335]: info: CoreStateMachine::startPlaybackTimer Jul 16 12:01:54 1901-1 volumio[2335]: info: CorePlayQueue::getTrack 13 Jul 16 12:01:54 1901-1 volumio[2335]: info: [1721102514426] ControllerUPNPBrowser::clearAddPlayTrack Jul 16 12:01:54 1901-1 volumio[2335]: verbose: ControllerMpd::sendMpdCommand stop Jul 16 12:01:54 1901-1 volumio[2335]: info: sendMpdCommand status took 24 milliseconds Jul 16 12:01:54 1901-1 volumio[2335]: info: sendMpdCommand stop took 19 milliseconds Jul 16 12:01:54 1901-1 volumio[2335]: verbose: ControllerMpd::parseState Jul 16 12:01:54 1901-1 volumio[2335]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 16 12:01:54 1901-1 volumio[2335]: verbose: ControllerMpd::sendMpdCommand clear Jul 16 12:01:54 1901-1 volumio[2335]: info: Jul 16 12:01:54 1901-1 volumio[2335]: ---------------------------- MPD announces state update: player Jul 16 12:01:54 1901-1 volumio[2335]: info: ControllerMpd::getState Jul 16 12:01:54 1901-1 volumio[2335]: verbose: ControllerMpd::sendMpdCommand status Jul 16 12:01:54 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:54 1901-1 volumio[2335]: info: CorePlayQueue::getTrack 13 Jul 16 12:01:54 1901-1 volumio[2335]: info: Jul 16 12:01:54 1901-1 volumio[2335]: ---------------------------- MPD announces system playlist update Jul 16 12:01:54 1901-1 volumio[2335]: info: Ignoring MPD Status Update Jul 16 12:01:54 1901-1 volumio[2335]: info: sendMpdCommand playlistinfo took 26 milliseconds Jul 16 12:01:54 1901-1 volumio[2335]: info: sendMpdCommand clear took 26 milliseconds Jul 16 12:01:54 1901-1 volumio[2335]: info: sendMpdCommand status took 23 milliseconds Jul 16 12:01:54 1901-1 volumio[2335]: verbose: ControllerMpd::parseTrackInfo Jul 16 12:01:54 1901-1 volumio[2335]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.23.23:50002/m/MP3/4583.mp3" Jul 16 12:01:54 1901-1 volumio[2335]: verbose: ControllerMpd::parseState Jul 16 12:01:54 1901-1 volumio[2335]: info: ControllerMpd::pushState Jul 16 12:01:54 1901-1 volumio[2335]: info: CoreCommandRouter::servicePushState Jul 16 12:01:54 1901-1 volumio[2335]: info: CoreStateMachine::pushState Jul 16 12:01:54 1901-1 volumio[2335]: info: CorePlayQueue::getTrack 13 Jul 16 12:01:54 1901-1 volumio[2335]: info: CoreCommandRouter::volumioPushState Jul 16 12:01:54 1901-1 volumio[2335]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 16 12:01:54 1901-1 volumio[2335]: info: CorePlayQueue::getTrack 13 Jul 16 12:01:54 1901-1 volumio[2335]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"4550.flac","artist":null,"album":null,"uri":"http://192.168.23.23:50002/m/NDLNA/4550.flac","trackType":"flac"} Jul 16 12:01:54 1901-1 volumio[2335]: verbose: CURRENT POSITION 13 Jul 16 12:01:54 1901-1 volumio[2335]: info: CoreStateMachine::syncState stateService stop Jul 16 12:01:54 1901-1 volumio[2335]: info: CoreStateMachine::syncState currentStatus stop Jul 16 12:01:54 1901-1 volumio[2335]: info: CoreStateMachine::pushState Jul 16 12:01:54 1901-1 volumio[2335]: info: CorePlayQueue::getTrack 13 Jul 16 12:01:54 1901-1 volumio[2335]: info: CoreCommandRouter::volumioPushState Jul 16 12:01:54 1901-1 volumio[2335]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 16 12:01:54 1901-1 volumio[2335]: info: No code Jul 16 12:01:54 1901-1 volumio[2335]: info: CoreStateMachine::pushState Jul 16 12:01:54 1901-1 volumio[2335]: info: CorePlayQueue::getTrack 13 Jul 16 12:01:54 1901-1 volumio[2335]: info: CoreCommandRouter::volumioPushState Jul 16 12:01:54 1901-1 volumio[2335]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 16 12:01:54 1901-1 volumio[2335]: info: ControllerMpd::pushState Jul 16 12:01:54 1901-1 volumio[2335]: info: CoreCommandRouter::servicePushState Jul 16 12:01:54 1901-1 volumio[2335]: info: CoreStateMachine::pushState Jul 16 12:01:54 1901-1 volumio[2335]: info: CorePlayQueue::getTrack 13 Jul 16 12:01:54 1901-1 volumio[2335]: info: CoreCommandRouter::volumioPushState Jul 16 12:01:54 1901-1 volumio[2335]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 16 12:01:54 1901-1 volumio[2335]: info: CorePlayQueue::getTrack 13 Jul 16 12:01:54 1901-1 volumio[2335]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jul 16 12:01:54 1901-1 volumio[2335]: verbose: CURRENT POSITION 13 Jul 16 12:01:54 1901-1 volumio[2335]: info: CoreStateMachine::syncState stateService stop Jul 16 12:01:54 1901-1 volumio[2335]: info: CoreStateMachine::syncState currentStatus stop Jul 16 12:01:54 1901-1 volumio[2335]: info: CoreStateMachine::pushState Jul 16 12:01:54 1901-1 volumio[2335]: info: CorePlayQueue::getTrack 13 Jul 16 12:01:54 1901-1 volumio[2335]: info: CoreCommandRouter::volumioPushState Jul 16 12:01:54 1901-1 volumio[2335]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 16 12:01:54 1901-1 volumio[2335]: info: No code Jul 16 12:01:54 1901-1 volumio[2335]: info: CoreStateMachine::pushState Jul 16 12:01:54 1901-1 volumio[2335]: info: CorePlayQueue::getTrack 13 Jul 16 12:01:54 1901-1 volumio[2335]: info: CoreCommandRouter::volumioPushState Jul 16 12:01:54 1901-1 volumio[2335]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 16 12:01:54 1901-1 volumio[2335]: info: ------------------------------ 136ms Jul 16 12:01:54 1901-1 volumio[2335]: info: ------------------------------ 107ms Jul 16 12:01:54 1901-1 volumio[2335]: info: Jul 16 12:01:54 1901-1 volumio[2335]: ---------------------------- MPD announces system playlist update Jul 16 12:01:54 1901-1 volumio[2335]: info: Ignoring MPD Status Update Jul 16 12:01:54 1901-1 volumio[2335]: error: updateQueue error: null Jul 16 12:01:54 1901-1 volumio[2335]: error: updateQueue error: null Jul 16 12:01:54 1901-1 volumio[2335]: info: ------------------------------ 109ms Jul 16 12:01:54 1901-1 volumio[2335]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.23.23:50002/m/MP3/4583.mp3" Jul 16 12:01:54 1901-1 volumio[2335]: info: ------------------------------ 12ms Jul 16 12:01:54 1901-1 volumio[2335]: info: Jul 16 12:01:54 1901-1 volumio[2335]: ---------------------------- MPD announces system playlist update Jul 16 12:01:54 1901-1 volumio[2335]: info: Ignoring MPD Status Update Jul 16 12:01:54 1901-1 volumio[2335]: info: sendMpdCommand add "http://192.168.23.23:50002/m/MP3/4583.mp3" took 19 milliseconds Jul 16 12:01:54 1901-1 volumio[2335]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 16 12:01:54 1901-1 volumio[2335]: verbose: ControllerMpd::sendMpdCommand play Jul 16 12:01:54 1901-1 volumio[2335]: info: Jul 16 12:01:54 1901-1 volumio[2335]: ---------------------------- MPD announces system playlist update Jul 16 12:01:54 1901-1 volumio[2335]: info: Ignoring MPD Status Update Jul 16 12:01:54 1901-1 volumio[2335]: error: Could not retrieve plugin audio_interface multiroom Jul 16 12:01:54 1901-1 volumio[2335]: info: ------------------------------ 28ms Jul 16 12:01:54 1901-1 volumio[2335]: info: sendMpdCommand play took 25 milliseconds Jul 16 12:01:54 1901-1 volumio[2335]: info: ------------------------------ 22ms Jul 16 12:01:54 1901-1 volumio[2335]: error: Could not retrieve plugin audio_interface multiroom Jul 16 12:01:54 1901-1 volumio[2335]: error: Could not retrieve plugin audio_interface multiroom Jul 16 12:01:54 1901-1 volumio[2335]: error: Could not retrieve plugin audio_interface multiroom Jul 16 12:01:54 1901-1 volumio[2335]: error: Could not retrieve plugin audio_interface multiroom Jul 16 12:01:54 1901-1 rc.local[10586]: % Total % Received % Xferd Average Speed Time Time Time Current Jul 16 12:01:54 1901-1 rc.local[10586]: Dload Upload Total Spent Left Speed Jul 16 12:01:54 1901-1 volumio[2335]: error: Could not retrieve plugin audio_interface multiroom Jul 16 12:01:54 1901-1 volumio[2335]: error: Could not retrieve plugin audio_interface multiroom Jul 16 12:01:55 1901-1 rc.local[10586]: [158B blob data] Jul 16 12:01:55 1901-1 rc.local[2232]: command_len 9 Jul 16 12:01:55 1901-1 rc.local[2232]: getQueue Jul 16 12:01:55 1901-1 rc.local[2232]: Jul 16 12:01:55 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetQueue Jul 16 12:01:55 1901-1 volumio[2335]: info: CoreStateMachine::getQueue Jul 16 12:01:55 1901-1 volumio[2335]: info: CorePlayQueue::getQueue Jul 16 12:01:55 1901-1 rc.local[2232]: socket send Jul 16 12:01:55 1901-1 volumio[2335]: info: Jul 16 12:01:55 1901-1 volumio[2335]: ---------------------------- MPD announces state update: player Jul 16 12:01:55 1901-1 volumio[2335]: info: ControllerMpd::getState Jul 16 12:01:55 1901-1 volumio[2335]: verbose: ControllerMpd::sendMpdCommand status Jul 16 12:01:55 1901-1 kernel: sunxi-spdif 2036000.spdif: active: 1 Jul 16 12:01:55 1901-1 volumio[2335]: info: Jul 16 12:01:55 1901-1 volumio[2335]: ---------------------------- MPD announces state update: player Jul 16 12:01:55 1901-1 volumio[2335]: info: ControllerMpd::getState Jul 16 12:01:55 1901-1 volumio[2335]: verbose: ControllerMpd::sendMpdCommand status Jul 16 12:01:55 1901-1 volumio[2335]: info: Jul 16 12:01:55 1901-1 volumio[2335]: ---------------------------- MPD announces state update: player Jul 16 12:01:55 1901-1 volumio[2335]: info: sendMpdCommand status took 14 milliseconds Jul 16 12:01:55 1901-1 volumio[2335]: info: ControllerMpd::getState Jul 16 12:01:55 1901-1 volumio[2335]: verbose: ControllerMpd::sendMpdCommand status Jul 16 12:01:55 1901-1 volumio[2335]: info: sendMpdCommand status took 13 milliseconds Jul 16 12:01:55 1901-1 volumio[2335]: verbose: ControllerMpd::parseState Jul 16 12:01:55 1901-1 volumio[2335]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 16 12:01:55 1901-1 volumio[2335]: verbose: ControllerMpd::parseState Jul 16 12:01:55 1901-1 volumio[2335]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 16 12:01:55 1901-1 volumio[2335]: info: Jul 16 12:01:55 1901-1 volumio[2335]: ---------------------------- MPD announces state update: player Jul 16 12:01:55 1901-1 volumio[2335]: info: ControllerMpd::getState Jul 16 12:01:55 1901-1 volumio[2335]: verbose: ControllerMpd::sendMpdCommand status Jul 16 12:01:55 1901-1 volumio[2335]: info: sendMpdCommand status took 21 milliseconds Jul 16 12:01:55 1901-1 volumio[2335]: info: sendMpdCommand playlistinfo took 19 milliseconds Jul 16 12:01:55 1901-1 volumio[2335]: info: sendMpdCommand playlistinfo took 18 milliseconds Jul 16 12:01:55 1901-1 volumio[2335]: info: sendMpdCommand status took 5 milliseconds Jul 16 12:01:55 1901-1 volumio[2335]: verbose: ControllerMpd::parseState Jul 16 12:01:55 1901-1 volumio[2335]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 16 12:01:55 1901-1 volumio[2335]: verbose: ControllerMpd::parseTrackInfo Jul 16 12:01:55 1901-1 volumio[2335]: verbose: ControllerMpd::parseTrackInfo Jul 16 12:01:55 1901-1 volumio[2335]: verbose: ControllerMpd::parseState Jul 16 12:01:55 1901-1 volumio[2335]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 16 12:01:55 1901-1 volumio[2335]: info: ControllerMpd::pushState Jul 16 12:01:55 1901-1 volumio[2335]: info: CoreCommandRouter::servicePushState Jul 16 12:01:55 1901-1 volumio[2335]: info: CorePlayQueue::getTrack 13 Jul 16 12:01:55 1901-1 volumio[2335]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":269,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"4583.mp3","artist":null,"album":null,"uri":"http://192.168.23.23:50002/m/MP3/4583.mp3","trackType":"mp3"} Jul 16 12:01:55 1901-1 volumio[2335]: verbose: CURRENT POSITION 13 Jul 16 12:01:55 1901-1 volumio[2335]: info: CoreStateMachine::syncState stateService play Jul 16 12:01:55 1901-1 volumio[2335]: info: CoreStateMachine::syncState currentStatus stop Jul 16 12:01:55 1901-1 volumio[2335]: info: CoreStateMachine::pushState Jul 16 12:01:55 1901-1 volumio[2335]: info: CoreCommandRouter::volumioPushState Jul 16 12:01:55 1901-1 volumio[2335]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 16 12:01:55 1901-1 volumio[2335]: info: ControllerMpd::pushState Jul 16 12:01:55 1901-1 volumio[2335]: info: CoreCommandRouter::servicePushState Jul 16 12:01:55 1901-1 volumio[2335]: info: CorePlayQueue::getTrack 13 Jul 16 12:01:55 1901-1 volumio[2335]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":269,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"4583.mp3","artist":null,"album":null,"uri":"http://192.168.23.23:50002/m/MP3/4583.mp3","trackType":"mp3"} Jul 16 12:01:55 1901-1 volumio[2335]: verbose: CURRENT POSITION 13 Jul 16 12:01:55 1901-1 volumio[2335]: info: CoreStateMachine::syncState stateService play Jul 16 12:01:55 1901-1 volumio[2335]: info: CoreStateMachine::syncState currentStatus play Jul 16 12:01:55 1901-1 volumio[2335]: info: Received an update from plugin. extracting info from payload Jul 16 12:01:55 1901-1 volumio[2335]: info: CoreStateMachine::pushState Jul 16 12:01:55 1901-1 volumio[2335]: info: CoreCommandRouter::volumioPushState Jul 16 12:01:55 1901-1 volumio[2335]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 16 12:01:55 1901-1 volumio[2335]: info: CoreStateMachine::pushState Jul 16 12:01:55 1901-1 volumio[2335]: info: CoreCommandRouter::volumioPushState Jul 16 12:01:55 1901-1 volumio[2335]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 16 12:01:55 1901-1 volumio[2335]: info: ------------------------------ 114ms Jul 16 12:01:55 1901-1 volumio[2335]: info: ------------------------------ 112ms Jul 16 12:01:55 1901-1 volumio[2335]: info: sendMpdCommand playlistinfo took 75 milliseconds Jul 16 12:01:55 1901-1 volumio[2335]: info: sendMpdCommand playlistinfo took 63 milliseconds Jul 16 12:01:55 1901-1 volumio[2335]: verbose: ControllerMpd::parseTrackInfo Jul 16 12:01:55 1901-1 volumio[2335]: verbose: ControllerMpd::parseTrackInfo Jul 16 12:01:55 1901-1 volumio[2335]: info: ControllerMpd::pushState Jul 16 12:01:55 1901-1 volumio[2335]: info: CoreCommandRouter::servicePushState Jul 16 12:01:55 1901-1 volumio[2335]: info: CorePlayQueue::getTrack 13 Jul 16 12:01:55 1901-1 volumio[2335]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":269,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"4583.mp3","artist":null,"album":null,"uri":"http://192.168.23.23:50002/m/MP3/4583.mp3","trackType":"mp3"} Jul 16 12:01:55 1901-1 volumio[2335]: verbose: CURRENT POSITION 13 Jul 16 12:01:55 1901-1 volumio[2335]: info: CoreStateMachine::syncState stateService play Jul 16 12:01:55 1901-1 volumio[2335]: info: CoreStateMachine::syncState currentStatus play Jul 16 12:01:55 1901-1 volumio[2335]: info: Received an update from plugin. extracting info from payload Jul 16 12:01:55 1901-1 volumio[2335]: info: CoreStateMachine::pushState Jul 16 12:01:55 1901-1 volumio[2335]: info: CoreCommandRouter::volumioPushState Jul 16 12:01:55 1901-1 volumio[2335]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 16 12:01:55 1901-1 volumio[2335]: info: CoreStateMachine::pushState Jul 16 12:01:55 1901-1 volumio[2335]: info: CoreCommandRouter::volumioPushState Jul 16 12:01:55 1901-1 volumio[2335]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 16 12:01:55 1901-1 volumio[2335]: info: ControllerMpd::pushState Jul 16 12:01:55 1901-1 volumio[2335]: info: CoreCommandRouter::servicePushState Jul 16 12:01:55 1901-1 volumio[2335]: info: CorePlayQueue::getTrack 13 Jul 16 12:01:55 1901-1 volumio[2335]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":269,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"4583.mp3","artist":null,"album":null,"uri":"http://192.168.23.23:50002/m/MP3/4583.mp3","trackType":"mp3"} Jul 16 12:01:55 1901-1 volumio[2335]: verbose: CURRENT POSITION 13 Jul 16 12:01:55 1901-1 volumio[2335]: info: CoreStateMachine::syncState stateService play Jul 16 12:01:55 1901-1 volumio[2335]: info: CoreStateMachine::syncState currentStatus play Jul 16 12:01:55 1901-1 volumio[2335]: info: Received an update from plugin. extracting info from payload Jul 16 12:01:55 1901-1 volumio[2335]: info: CoreStateMachine::pushState Jul 16 12:01:55 1901-1 volumio[2335]: info: CoreCommandRouter::volumioPushState Jul 16 12:01:55 1901-1 volumio[2335]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 16 12:01:55 1901-1 volumio[2335]: info: CoreStateMachine::pushState Jul 16 12:01:55 1901-1 volumio[2335]: info: CoreCommandRouter::volumioPushState Jul 16 12:01:55 1901-1 volumio[2335]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 16 12:01:55 1901-1 volumio[2335]: info: ------------------------------ 155ms Jul 16 12:01:55 1901-1 volumio[2335]: info: ------------------------------ 148ms Jul 16 12:01:55 1901-1 volumio[2335]: info: Jul 16 12:01:55 1901-1 volumio[2335]: ---------------------------- MPD announces system playlist update Jul 16 12:01:55 1901-1 volumio[2335]: info: Ignoring MPD Status Update Jul 16 12:01:55 1901-1 volumio[2335]: info: Jul 16 12:01:55 1901-1 volumio[2335]: ---------------------------- MPD announces state update: player Jul 16 12:01:55 1901-1 volumio[2335]: info: ControllerMpd::getState Jul 16 12:01:55 1901-1 volumio[2335]: verbose: ControllerMpd::sendMpdCommand status Jul 16 12:01:55 1901-1 volumio[2335]: info: Jul 16 12:01:55 1901-1 volumio[2335]: ---------------------------- MPD announces system playlist update Jul 16 12:01:55 1901-1 volumio[2335]: info: Ignoring MPD Status Update Jul 16 12:01:55 1901-1 volumio[2335]: info: Jul 16 12:01:55 1901-1 volumio[2335]: ---------------------------- MPD announces state update: player Jul 16 12:01:55 1901-1 volumio[2335]: info: ControllerMpd::getState Jul 16 12:01:55 1901-1 volumio[2335]: verbose: ControllerMpd::sendMpdCommand status Jul 16 12:01:55 1901-1 systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 422. Jul 16 12:01:55 1901-1 systemd[1]: Stopped Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Jul 16 12:01:55 1901-1 volumio[2335]: info: ------------------------------ 54ms Jul 16 12:01:55 1901-1 volumio[2335]: info: sendMpdCommand status took 52 milliseconds Jul 16 12:01:55 1901-1 volumio[2335]: info: ------------------------------ 22ms Jul 16 12:01:55 1901-1 volumio[2335]: info: sendMpdCommand status took 20 milliseconds Jul 16 12:01:55 1901-1 volumio[2335]: verbose: ControllerMpd::parseState Jul 16 12:01:55 1901-1 volumio[2335]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 16 12:01:55 1901-1 volumio[2335]: verbose: ControllerMpd::parseState Jul 16 12:01:55 1901-1 volumio[2335]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 16 12:01:55 1901-1 systemd[1]: Starting Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator... Jul 16 12:01:55 1901-1 volumio[2335]: info: sendMpdCommand playlistinfo took 25 milliseconds Jul 16 12:01:55 1901-1 volumio[2335]: info: sendMpdCommand playlistinfo took 25 milliseconds Jul 16 12:01:55 1901-1 volumio[2335]: verbose: ControllerMpd::parseTrackInfo Jul 16 12:01:55 1901-1 volumio[2335]: verbose: ControllerMpd::parseTrackInfo Jul 16 12:01:55 1901-1 volumio[2335]: info: ControllerMpd::pushState Jul 16 12:01:55 1901-1 volumio[2335]: info: CoreCommandRouter::servicePushState Jul 16 12:01:55 1901-1 volumio[2335]: info: CorePlayQueue::getTrack 13 Jul 16 12:01:55 1901-1 volumio[2335]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":269,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"ramdom lover","artist":"陈奕迅","album":"是但求其","uri":"http://192.168.23.23:50002/m/MP3/4583.mp3","trackType":"mp3"} Jul 16 12:01:55 1901-1 volumio[2335]: verbose: CURRENT POSITION 13 Jul 16 12:01:55 1901-1 volumio[2335]: info: CoreStateMachine::syncState stateService play Jul 16 12:01:55 1901-1 volumio[2335]: info: CoreStateMachine::syncState currentStatus play Jul 16 12:01:55 1901-1 volumio[2335]: info: Received an update from plugin. extracting info from payload Jul 16 12:01:55 1901-1 hostapd[10596]: Configuration file: /etc/hostapd/hostapd.conf Jul 16 12:01:55 1901-1 volumio[2335]: info: CoreStateMachine::pushState Jul 16 12:01:55 1901-1 volumio[2335]: info: CoreCommandRouter::volumioPushState Jul 16 12:01:55 1901-1 volumio[2335]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 16 12:01:55 1901-1 volumio[2335]: info: CoreStateMachine::pushState Jul 16 12:01:55 1901-1 volumio[2335]: info: CoreCommandRouter::volumioPushState Jul 16 12:01:55 1901-1 volumio[2335]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 16 12:01:55 1901-1 volumio[2335]: info: ControllerMpd::pushState Jul 16 12:01:55 1901-1 volumio[2335]: info: CoreCommandRouter::servicePushState Jul 16 12:01:55 1901-1 volumio[2335]: info: CorePlayQueue::getTrack 13 Jul 16 12:01:55 1901-1 volumio[2335]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":269,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"ramdom lover","artist":"陈奕迅","album":"是但求其","uri":"http://192.168.23.23:50002/m/MP3/4583.mp3","trackType":"mp3"} Jul 16 12:01:55 1901-1 volumio[2335]: verbose: CURRENT POSITION 13 Jul 16 12:01:55 1901-1 volumio[2335]: info: CoreStateMachine::syncState stateService play Jul 16 12:01:55 1901-1 volumio[2335]: info: CoreStateMachine::syncState currentStatus play Jul 16 12:01:55 1901-1 volumio[2335]: info: Received an update from plugin. extracting info from payload Jul 16 12:01:55 1901-1 volumio[2335]: info: CoreStateMachine::pushState Jul 16 12:01:55 1901-1 volumio[2335]: info: CoreCommandRouter::volumioPushState Jul 16 12:01:55 1901-1 volumio[2335]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 16 12:01:55 1901-1 volumio[2335]: info: CoreStateMachine::pushState Jul 16 12:01:55 1901-1 volumio[2335]: info: CoreCommandRouter::volumioPushState Jul 16 12:01:55 1901-1 volumio[2335]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 16 12:01:55 1901-1 volumio[2335]: info: ------------------------------ 162ms Jul 16 12:01:55 1901-1 volumio[2335]: info: ------------------------------ 131ms Jul 16 12:01:55 1901-1 hostapd[10596]: Could not read interface wlan0 flags: No such device Jul 16 12:01:55 1901-1 hostapd[10596]: nl80211: Driver does not support authentication/association or connect commands Jul 16 12:01:55 1901-1 hostapd[10596]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Jul 16 12:01:55 1901-1 volumio[2335]: error: Could not retrieve plugin audio_interface multiroom Jul 16 12:01:55 1901-1 hostapd[10596]: Could not read interface wlan0 flags: No such device Jul 16 12:01:55 1901-1 hostapd[10596]: nl80211 driver initialization failed. Jul 16 12:01:55 1901-1 hostapd[10596]: wlan0: interface state UNINITIALIZED->DISABLED Jul 16 12:01:55 1901-1 hostapd[10596]: wlan0: AP-DISABLED Jul 16 12:01:55 1901-1 hostapd[10596]: wlan0: CTRL-EVENT-TERMINATING Jul 16 12:01:55 1901-1 hostapd[10596]: hostapd_free_hapd_data: Interface wlan0 wasn't started Jul 16 12:01:55 1901-1 systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Jul 16 12:01:55 1901-1 systemd[1]: hostapd.service: Failed with result 'exit-code'. Jul 16 12:01:55 1901-1 systemd[1]: Failed to start Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Jul 16 12:01:55 1901-1 volumio[2335]: error: Could not retrieve plugin audio_interface multiroom Jul 16 12:01:56 1901-1 volumio[2335]: error: Could not retrieve plugin audio_interface multiroom Jul 16 12:01:56 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:56 1901-1 volumio[2335]: error: Could not retrieve plugin audio_interface multiroom Jul 16 12:01:56 1901-1 volumio[2335]: error: Could not retrieve plugin audio_interface multiroom Jul 16 12:01:56 1901-1 volumio[2335]: error: Could not retrieve plugin audio_interface multiroom Jul 16 12:01:56 1901-1 volumio[2335]: error: Could not retrieve plugin audio_interface multiroom Jul 16 12:01:56 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetQueue Jul 16 12:01:56 1901-1 volumio[2335]: info: CoreStateMachine::getQueue Jul 16 12:01:56 1901-1 volumio[2335]: info: CorePlayQueue::getQueue Jul 16 12:01:56 1901-1 volumio[2335]: error: Could not retrieve plugin audio_interface multiroom Jul 16 12:01:56 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetQueue Jul 16 12:01:56 1901-1 volumio[2335]: info: CoreStateMachine::getQueue Jul 16 12:01:56 1901-1 volumio[2335]: info: CorePlayQueue::getQueue Jul 16 12:01:56 1901-1 volumio[2335]: error: Could not retrieve plugin audio_interface multiroom Jul 16 12:01:56 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetQueue Jul 16 12:01:56 1901-1 volumio[2335]: info: CoreStateMachine::getQueue Jul 16 12:01:56 1901-1 volumio[2335]: info: CorePlayQueue::getQueue Jul 16 12:01:56 1901-1 volumio[2335]: error: Could not retrieve plugin audio_interface multiroom Jul 16 12:01:56 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetQueue Jul 16 12:01:56 1901-1 volumio[2335]: info: CoreStateMachine::getQueue Jul 16 12:01:56 1901-1 volumio[2335]: info: CorePlayQueue::getQueue Jul 16 12:01:56 1901-1 volumio[2335]: error: Could not retrieve plugin audio_interface multiroom Jul 16 12:01:56 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:57 1901-1 volumio[2335]: info: CoreCommandRouter::volumioPlay Jul 16 12:01:57 1901-1 volumio[2335]: verbose: UNSET VOLATILE Jul 16 12:01:57 1901-1 volumio[2335]: info: CoreStateMachine::play index 12 Jul 16 12:01:57 1901-1 volumio[2335]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 16 12:01:57 1901-1 volumio[2335]: info: CoreStateMachine::stop Jul 16 12:01:57 1901-1 volumio[2335]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 16 12:01:57 1901-1 volumio[2335]: verbose: UNSET VOLATILE Jul 16 12:01:57 1901-1 volumio[2335]: info: CoreStateMachine::stPlaybackTimer Jul 16 12:01:57 1901-1 volumio[2335]: info: CoreStateMachine::updateTrackBlock Jul 16 12:01:57 1901-1 volumio[2335]: info: CorePlayQueue::getTrackBlock Jul 16 12:01:57 1901-1 volumio[2335]: info: CoreStateMachine::pushState Jul 16 12:01:57 1901-1 volumio[2335]: info: CorePlayQueue::getTrack 13 Jul 16 12:01:57 1901-1 volumio[2335]: info: CoreCommandRouter::volumioPushState Jul 16 12:01:57 1901-1 volumio[2335]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 16 12:01:57 1901-1 volumio[2335]: info: CoreStateMachine::serviceStop Jul 16 12:01:57 1901-1 volumio[2335]: info: CorePlayQueue::getTrack 13 Jul 16 12:01:57 1901-1 volumio[2335]: info: CoreCommandRouter::serviceStop Jul 16 12:01:57 1901-1 volumio[2335]: info: [1721102517190] ControllerUPNPBrowser::stop Jul 16 12:01:57 1901-1 volumio[2335]: verbose: ControllerMpd::sendMpdCommand stop Jul 16 12:01:57 1901-1 volumio[2335]: error: Could not retrieve plugin audio_interface multiroom Jul 16 12:01:57 1901-1 volumio[2335]: info: Jul 16 12:01:57 1901-1 volumio[2335]: ---------------------------- MPD announces state update: player Jul 16 12:01:57 1901-1 volumio[2335]: info: sendMpdCommand stop took 54 milliseconds Jul 16 12:01:57 1901-1 volumio[2335]: info: ControllerMpd::getState Jul 16 12:01:57 1901-1 volumio[2335]: verbose: ControllerMpd::sendMpdCommand status Jul 16 12:01:57 1901-1 volumio[2335]: info: CoreStateMachine::play index undefined Jul 16 12:01:57 1901-1 volumio[2335]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 16 12:01:57 1901-1 volumio[2335]: info: CorePlayQueue::getTrack 12 Jul 16 12:01:57 1901-1 volumio[2335]: info: CoreStateMachine::startPlaybackTimer Jul 16 12:01:57 1901-1 volumio[2335]: info: CorePlayQueue::getTrack 12 Jul 16 12:01:57 1901-1 volumio[2335]: info: [1721102517260] ControllerUPNPBrowser::clearAddPlayTrack Jul 16 12:01:57 1901-1 volumio[2335]: verbose: ControllerMpd::sendMpdCommand stop Jul 16 12:01:57 1901-1 volumio[2335]: info: Jul 16 12:01:57 1901-1 volumio[2335]: ---------------------------- MPD announces state update: player Jul 16 12:01:57 1901-1 volumio[2335]: info: ControllerMpd::getState Jul 16 12:01:57 1901-1 volumio[2335]: verbose: ControllerMpd::sendMpdCommand status Jul 16 12:01:57 1901-1 volumio[2335]: info: sendMpdCommand status took 55 milliseconds Jul 16 12:01:57 1901-1 volumio[2335]: info: sendMpdCommand stop took 39 milliseconds Jul 16 12:01:57 1901-1 volumio[2335]: info: sendMpdCommand status took 25 milliseconds Jul 16 12:01:57 1901-1 volumio[2335]: verbose: ControllerMpd::parseState Jul 16 12:01:57 1901-1 volumio[2335]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 16 12:01:57 1901-1 volumio[2335]: verbose: ControllerMpd::sendMpdCommand clear Jul 16 12:01:57 1901-1 volumio[2335]: verbose: ControllerMpd::parseState Jul 16 12:01:57 1901-1 volumio[2335]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 16 12:01:57 1901-1 volumio[2335]: info: Jul 16 12:01:57 1901-1 volumio[2335]: ---------------------------- MPD announces system playlist update Jul 16 12:01:57 1901-1 volumio[2335]: info: Ignoring MPD Status Update Jul 16 12:01:57 1901-1 volumio[2335]: info: sendMpdCommand playlistinfo took 7 milliseconds Jul 16 12:01:57 1901-1 volumio[2335]: info: sendMpdCommand clear took 6 milliseconds Jul 16 12:01:57 1901-1 volumio[2335]: info: sendMpdCommand playlistinfo took 6 milliseconds Jul 16 12:01:57 1901-1 volumio[2335]: verbose: ControllerMpd::parseTrackInfo Jul 16 12:01:57 1901-1 volumio[2335]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.23.23:50002/m/NDLNA/4545.m4a" Jul 16 12:01:57 1901-1 volumio[2335]: verbose: ControllerMpd::parseTrackInfo Jul 16 12:01:57 1901-1 volumio[2335]: info: ControllerMpd::pushState Jul 16 12:01:57 1901-1 volumio[2335]: info: CoreCommandRouter::servicePushState Jul 16 12:01:57 1901-1 volumio[2335]: info: CoreStateMachine::pushState Jul 16 12:01:57 1901-1 volumio[2335]: info: CorePlayQueue::getTrack 12 Jul 16 12:01:57 1901-1 volumio[2335]: info: CoreCommandRouter::volumioPushState Jul 16 12:01:57 1901-1 volumio[2335]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 16 12:01:57 1901-1 volumio[2335]: info: CorePlayQueue::getTrack 12 Jul 16 12:01:57 1901-1 volumio[2335]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"ramdom lover","artist":"陈奕迅","album":"是但求其","uri":"http://192.168.23.23:50002/m/MP3/4583.mp3","trackType":"mp3"} Jul 16 12:01:57 1901-1 volumio[2335]: verbose: CURRENT POSITION 12 Jul 16 12:01:57 1901-1 volumio[2335]: info: CoreStateMachine::syncState stateService stop Jul 16 12:01:57 1901-1 volumio[2335]: info: CoreStateMachine::syncState currentStatus stop Jul 16 12:01:57 1901-1 volumio[2335]: info: CoreStateMachine::pushState Jul 16 12:01:57 1901-1 volumio[2335]: info: CorePlayQueue::getTrack 12 Jul 16 12:01:57 1901-1 volumio[2335]: info: CoreCommandRouter::volumioPushState Jul 16 12:01:57 1901-1 volumio[2335]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 16 12:01:57 1901-1 volumio[2335]: info: No code Jul 16 12:01:57 1901-1 volumio[2335]: info: CoreStateMachine::pushState Jul 16 12:01:57 1901-1 volumio[2335]: info: CorePlayQueue::getTrack 12 Jul 16 12:01:57 1901-1 volumio[2335]: info: CoreCommandRouter::volumioPushState Jul 16 12:01:57 1901-1 volumio[2335]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 16 12:01:57 1901-1 volumio[2335]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jul 16 12:01:57 1901-1 volumio[2335]: info: ------------------------------ 115ms Jul 16 12:01:57 1901-1 volumio[2335]: info: ------------------------------ 82ms Jul 16 12:01:57 1901-1 volumio[2335]: info: Jul 16 12:01:57 1901-1 volumio[2335]: ---------------------------- MPD announces system playlist update Jul 16 12:01:57 1901-1 volumio[2335]: info: Ignoring MPD Status Update Jul 16 12:01:57 1901-1 volumio[2335]: error: updateQueue error: null Jul 16 12:01:57 1901-1 volumio[2335]: error: updateQueue error: null Jul 16 12:01:57 1901-1 volumio[2335]: info: ------------------------------ 52ms Jul 16 12:01:57 1901-1 volumio[2335]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.23.23:50002/m/NDLNA/4545.m4a" Jul 16 12:01:57 1901-1 volumio[2335]: info: ------------------------------ 5ms Jul 16 12:01:57 1901-1 volumio[2335]: info: Jul 16 12:01:57 1901-1 volumio[2335]: ---------------------------- MPD announces system playlist update Jul 16 12:01:57 1901-1 volumio[2335]: info: Ignoring MPD Status Update Jul 16 12:01:57 1901-1 volumio[2335]: info: sendMpdCommand add "http://192.168.23.23:50002/m/NDLNA/4545.m4a" took 7 milliseconds Jul 16 12:01:57 1901-1 volumio[2335]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 16 12:01:57 1901-1 volumio[2335]: verbose: ControllerMpd::sendMpdCommand play Jul 16 12:01:57 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:57 1901-1 volumio[2335]: info: Jul 16 12:01:57 1901-1 volumio[2335]: ---------------------------- MPD announces system playlist update Jul 16 12:01:57 1901-1 volumio[2335]: info: Ignoring MPD Status Update Jul 16 12:01:57 1901-1 volumio[2335]: info: ------------------------------ 34ms Jul 16 12:01:57 1901-1 volumio[2335]: info: sendMpdCommand play took 33 milliseconds Jul 16 12:01:57 1901-1 rc.local[2232]: command_len 9 Jul 16 12:01:57 1901-1 rc.local[2232]: getQueue Jul 16 12:01:57 1901-1 rc.local[2232]: Jul 16 12:01:57 1901-1 volumio[2335]: info: ------------------------------ 35ms Jul 16 12:01:57 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetQueue Jul 16 12:01:57 1901-1 volumio[2335]: info: CoreStateMachine::getQueue Jul 16 12:01:57 1901-1 volumio[2335]: info: CorePlayQueue::getQueue Jul 16 12:01:57 1901-1 rc.local[2232]: socket send Jul 16 12:01:57 1901-1 volumio[2335]: error: Could not retrieve plugin audio_interface multiroom Jul 16 12:01:57 1901-1 volumio[2335]: error: Could not retrieve plugin audio_interface multiroom Jul 16 12:01:57 1901-1 volumio[2335]: error: Could not retrieve plugin audio_interface multiroom Jul 16 12:01:57 1901-1 systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 423. Jul 16 12:01:57 1901-1 systemd[1]: Stopped Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Jul 16 12:01:57 1901-1 systemd[1]: Starting Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator... Jul 16 12:01:58 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:58 1901-1 hostapd[10613]: Configuration file: /etc/hostapd/hostapd.conf Jul 16 12:01:58 1901-1 hostapd[10613]: Could not read interface wlan0 flags: No such device Jul 16 12:01:58 1901-1 hostapd[10613]: nl80211: Driver does not support authentication/association or connect commands Jul 16 12:01:58 1901-1 hostapd[10613]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Jul 16 12:01:58 1901-1 hostapd[10613]: Could not read interface wlan0 flags: No such device Jul 16 12:01:58 1901-1 hostapd[10613]: nl80211 driver initialization failed. Jul 16 12:01:58 1901-1 hostapd[10613]: wlan0: interface state UNINITIALIZED->DISABLED Jul 16 12:01:58 1901-1 hostapd[10613]: wlan0: AP-DISABLED Jul 16 12:01:58 1901-1 hostapd[10613]: wlan0: CTRL-EVENT-TERMINATING Jul 16 12:01:58 1901-1 hostapd[10613]: hostapd_free_hapd_data: Interface wlan0 wasn't started Jul 16 12:01:58 1901-1 systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Jul 16 12:01:58 1901-1 systemd[1]: hostapd.service: Failed with result 'exit-code'. Jul 16 12:01:58 1901-1 systemd[1]: Failed to start Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Jul 16 12:01:58 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:59 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:01:59 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:02:00 1901-1 systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 424. Jul 16 12:02:00 1901-1 systemd[1]: Stopped Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Jul 16 12:02:00 1901-1 systemd[1]: Starting Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator... Jul 16 12:02:00 1901-1 hostapd[10626]: Configuration file: /etc/hostapd/hostapd.conf Jul 16 12:02:00 1901-1 hostapd[10626]: Could not read interface wlan0 flags: No such device Jul 16 12:02:00 1901-1 hostapd[10626]: nl80211: Driver does not support authentication/association or connect commands Jul 16 12:02:00 1901-1 hostapd[10626]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Jul 16 12:02:00 1901-1 hostapd[10626]: Could not read interface wlan0 flags: No such device Jul 16 12:02:00 1901-1 hostapd[10626]: nl80211 driver initialization failed. Jul 16 12:02:00 1901-1 hostapd[10626]: wlan0: interface state UNINITIALIZED->DISABLED Jul 16 12:02:00 1901-1 hostapd[10626]: wlan0: AP-DISABLED Jul 16 12:02:00 1901-1 hostapd[10626]: wlan0: CTRL-EVENT-TERMINATING Jul 16 12:02:00 1901-1 hostapd[10626]: hostapd_free_hapd_data: Interface wlan0 wasn't started Jul 16 12:02:00 1901-1 systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Jul 16 12:02:00 1901-1 systemd[1]: hostapd.service: Failed with result 'exit-code'. Jul 16 12:02:00 1901-1 systemd[1]: Failed to start Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Jul 16 12:02:00 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:02:01 1901-1 volumio[2335]: info: CoreCommandRouter::volumioGetState Jul 16 12:02:01 1901-1 volumio[2335]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 16 12:02:01 1901-1 volumio[2335]: { Error: connect ETIMEDOUT 108.160.172.208:80 Jul 16 12:02:01 1901-1 volumio[2335]: at Object._errnoException (util.js:1022:11) Jul 16 12:02:01 1901-1 volumio[2335]: at _exceptionWithHostPort (util.js:1044:20) Jul 16 12:02:01 1901-1 volumio[2335]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Jul 16 12:02:01 1901-1 volumio[2335]: code: 'ETIMEDOUT', Jul 16 12:02:01 1901-1 volumio[2335]: errno: 'ETIMEDOUT', Jul 16 12:02:01 1901-1 volumio[2335]: syscall: 'connect', Jul 16 12:02:01 1901-1 volumio[2335]: address: '108.160.172.208', Jul 16 12:02:01 1901-1 volumio[2335]: port: 80 } Jul 16 12:02:01 1901-1 volumio[2335]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 16 12:02:02 1901-1 systemd[1]: hostapd.service: Scheduled restart job, restart counter is at 425. Jul 16 12:02:02 1901-1 systemd[1]: Stopped Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Jul 16 12:02:02 1901-1 systemd[1]: Starting Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator... Jul 16 12:02:02 1901-1 hostapd[10647]: Configuration file: /etc/hostapd/hostapd.conf Jul 16 12:02:02 1901-1 hostapd[10647]: Could not read interface wlan0 flags: No such device Jul 16 12:02:02 1901-1 hostapd[10647]: nl80211: Driver does not support authentication/association or connect commands Jul 16 12:02:02 1901-1 hostapd[10647]: nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Jul 16 12:02:02 1901-1 hostapd[10647]: Could not read interface wlan0 flags: No such device Jul 16 12:02:02 1901-1 hostapd[10647]: nl80211 driver initialization failed. Jul 16 12:02:02 1901-1 hostapd[10647]: wlan0: interface state UNINITIALIZED->DISABLED Jul 16 12:02:02 1901-1 hostapd[10647]: wlan0: AP-DISABLED Jul 16 12:02:02 1901-1 hostapd[10647]: wlan0: CTRL-EVENT-TERMINATING Jul 16 12:02:02 1901-1 hostapd[10647]: hostapd_free_hapd_data: Interface wlan0 wasn't started Jul 16 12:02:02 1901-1 systemd[1]: hostapd.service: Control process exited, code=exited, status=1/FAILURE Jul 16 12:02:02 1901-1 systemd[1]: hostapd.service: Failed with result 'exit-code'. Jul 16 12:02:02 1901-1 systemd[1]: Failed to start Advanced IEEE 802.11 AP and IEEE 802.1X/WPA/WPA2/EAP Authenticator. Jul 16 12:02:02 1901-1 sudo[10655]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-16 12:01 Jul 16 12:02:02 1901-1 sudo[10655]: pam_unix(sudo:session): session opened for user root by (uid=0) NAME="Ubuntu" VERSION="20.04.5 LTS (Focal Fossa)" ID=ubuntu ID_LIKE=debian PRETTY_NAME="Ubuntu 20.04.5 LTS" VERSION_ID="20.04" HOME_URL="https://www.ubuntu.com/" SUPPORT_URL="https://help.ubuntu.com/" BUG_REPORT_URL="https://bugs.launchpad.net/ubuntu/" PRIVACY_POLICY_URL="https://www.ubuntu.com/legal/terms-and-policies/privacy-policy" VERSION_CODENAME=focal UBUNTU_CODENAME=focal VOLUMIO_BUILD_VERSION="" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_BE_VERSION="3e944f35d34b575025d16b976b4cb4d9aed53b66" VOLUMIO_ARCH="armv7"