-- Logs begin at Thu 2023-11-09 09:28:50 UTC, end at Thu 2023-11-09 09:34:41 UTC. --
Nov 09 09:33:00 volumio sudo[7098]: pam_unix(sudo:session): session closed for user root
Nov 09 09:33:00 volumio kernel: in count:402656, out count:402652
Nov 09 09:33:00 volumio kernel: reduce cnt:173, mpll1_rate:48999976, mpll2 rate:49000489
Nov 09 09:33:00 volumio systemd[1]: volumio.service: main process exited, code=exited, status=1/FAILURE
Nov 09 09:33:00 volumio systemd[1]: Unit volumio.service entered failed state.
Nov 09 09:33:00 volumio systemd[1]: Starting dynamicswap service...
Nov 09 09:33:00 volumio systemd[1]: Started dynamicswap service.
Nov 09 09:33:00 volumio systemd[1]: volumio.service holdoff time over, scheduling restart.
Nov 09 09:33:00 volumio systemd[1]: Starting dynamicswap service...
Nov 09 09:33:00 volumio systemd[1]: Started dynamicswap service.
Nov 09 09:33:00 volumio systemd[1]: Stopping Volumio Backend Module...
Nov 09 09:33:00 volumio kernel: in count:402650, out count:402652
Nov 09 09:33:00 volumio kernel: add cnt:196, mpll1_rate:48999976 mpll2 rate:48999830
Nov 09 09:33:00 volumio wireless.js[6904]: trying...
Nov 09 09:33:00 volumio sudo[7125]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Nov 09 09:33:00 volumio sudo[7125]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 09 09:33:00 volumio sudo[7125]: pam_unix(sudo:session): session closed for user root
Nov 09 09:33:01 volumio kernel: in count:402655, out count:402651
Nov 09 09:33:01 volumio kernel: reduce cnt:174, mpll1_rate:48999976, mpll2 rate:49000416
Nov 09 09:33:01 volumio kernel: in count:402650, out count:402651
Nov 09 09:33:01 volumio kernel: add cnt:197, mpll1_rate:48999976 mpll2 rate:48999756
Nov 09 09:33:01 volumio wpa_supplicant[6984]: wlan0: Trying to associate with 30:c5:0f:a3:58:f4 (SSID='Base_Linux' freq=2462 MHz)
Nov 09 09:33:01 volumio kernel: Connecting with 30:c5:0f:a3:58:f4 ssid "Base_Linux", len (10) channel=11
Nov 09 09:33:01 volumio kernel: dhd_dbg_start_pkt_monitor, 1724
Nov 09 09:33:01 volumio wireless.js[6904]: trying...
Nov 09 09:33:01 volumio sudo[7128]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Nov 09 09:33:01 volumio sudo[7128]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 09 09:33:01 volumio sudo[7128]: pam_unix(sudo:session): session closed for user root
Nov 09 09:33:01 volumio kernel: in count:402655, out count:402651
Nov 09 09:33:01 volumio kernel: reduce cnt:175, mpll1_rate:48999976, mpll2 rate:49000343
Nov 09 09:33:02 volumio kernel: in count:402649, out count:402652
Nov 09 09:33:02 volumio kernel: add cnt:198, mpll1_rate:48999976 mpll2 rate:48999683
Nov 09 09:33:02 volumio kernel: in count:402654, out count:402651
Nov 09 09:33:02 volumio kernel: reduce cnt:176, mpll1_rate:48999976, mpll2 rate:49000269
Nov 09 09:33:02 volumio wireless.js[6904]: trying...
Nov 09 09:33:02 volumio sudo[7132]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Nov 09 09:33:02 volumio sudo[7132]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 09 09:33:02 volumio sudo[7132]: pam_unix(sudo:session): session closed for user root
Nov 09 09:33:02 volumio volumio-remote-updater[4055]: [2023-11-09 09:33:02] [info] asio async_connect error: system:111 (Connection refused)
Nov 09 09:33:02 volumio volumio-remote-updater[4055]: [2023-11-09 09:33:02] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Nov 09 09:33:02 volumio volumio-remote-updater[4055]: [2023-11-09 09:33:02] [error] handle_connect error: Underlying Transport Error
Nov 09 09:33:03 volumio kernel: in count:402649, out count:402652
Nov 09 09:33:03 volumio kernel: add cnt:199, mpll1_rate:48999976 mpll2 rate:48999610
Nov 09 09:33:03 volumio kernel: in count:402654, out count:402651
Nov 09 09:33:03 volumio kernel: reduce cnt:177, mpll1_rate:48999976, mpll2 rate:49000196
Nov 09 09:33:03 volumio wireless.js[6904]: trying...
Nov 09 09:33:03 volumio sudo[7135]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Nov 09 09:33:03 volumio sudo[7135]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 09 09:33:03 volumio sudo[7135]: pam_unix(sudo:session): session closed for user root
Nov 09 09:33:03 volumio kernel: in count:402648, out count:402651
Nov 09 09:33:03 volumio kernel: add cnt:200, mpll1_rate:48999976 mpll2 rate:48999537
Nov 09 09:33:04 volumio kernel: in count:402653, out count:402652
Nov 09 09:33:04 volumio kernel: reduce cnt:178, mpll1_rate:48999976, mpll2 rate:49000123
Nov 09 09:33:04 volumio kernel: in count:402648, out count:402652
Nov 09 09:33:04 volumio kernel: add cnt:201, mpll1_rate:48999976 mpll2 rate:48999463
Nov 09 09:33:04 volumio wireless.js[6904]: trying...
Nov 09 09:33:04 volumio sudo[7138]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Nov 09 09:33:04 volumio sudo[7138]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 09 09:33:04 volumio sudo[7138]: pam_unix(sudo:session): session closed for user root
Nov 09 09:33:05 volumio kernel: in count:402652, out count:402652
Nov 09 09:33:05 volumio kernel: in count:805306, out count:805304
Nov 09 09:33:05 volumio kernel: reduce cnt:179, mpll1_rate:48999976, mpll2 rate:49000050
Nov 09 09:33:05 volumio wireless.js[6904]: trying...
Nov 09 09:33:05 volumio sudo[7141]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Nov 09 09:33:05 volumio sudo[7141]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 09 09:33:05 volumio kernel: in count:402647, out count:402652
Nov 09 09:33:05 volumio kernel: add cnt:202, mpll1_rate:48999976 mpll2 rate:48999390
Nov 09 09:33:05 volumio sudo[7141]: pam_unix(sudo:session): session closed for user root
Nov 09 09:33:06 volumio kernel: in count:402652, out count:402652
Nov 09 09:33:06 volumio kernel: in count:805304, out count:805304
Nov 09 09:33:06 volumio wireless.js[6904]: trying...
Nov 09 09:33:06 volumio sudo[7144]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Nov 09 09:33:06 volumio sudo[7144]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 09 09:33:06 volumio sudo[7144]: pam_unix(sudo:session): session closed for user root
Nov 09 09:33:07 volumio kernel: in count:1207957, out count:1207957
Nov 09 09:33:07 volumio kernel: in count:1610609, out count:1610609
Nov 09 09:33:07 volumio kernel: in count:2013261, out count:2013261
Nov 09 09:33:07 volumio wireless.js[6904]: trying...
Nov 09 09:33:08 volumio sudo[7150]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Nov 09 09:33:08 volumio sudo[7150]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 09 09:33:08 volumio sudo[7150]: pam_unix(sudo:session): session closed for user root
Nov 09 09:33:08 volumio kernel: in count:2415914, out count:2415914
Nov 09 09:33:08 volumio kernel: in count:2818566, out count:2818566
Nov 09 09:33:09 volumio wireless.js[6904]: trying...
Nov 09 09:33:09 volumio sudo[7153]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Nov 09 09:33:09 volumio sudo[7153]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 09 09:33:09 volumio sudo[7153]: pam_unix(sudo:session): session closed for user root
Nov 09 09:33:09 volumio kernel: in count:3221219, out count:3221219
Nov 09 09:33:09 volumio kernel: in count:3623871, out count:3623871
Nov 09 09:33:09 volumio kernel: in count:4026523, out count:4026523
Nov 09 09:33:10 volumio wireless.js[6904]: trying...
Nov 09 09:33:10 volumio sudo[7156]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Nov 09 09:33:10 volumio sudo[7156]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 09 09:33:10 volumio sudo[7156]: pam_unix(sudo:session): session closed for user root
Nov 09 09:33:10 volumio kernel: in count:4429176, out count:4429176
Nov 09 09:33:10 volumio kernel: in count:4831828, out count:4831828
Nov 09 09:33:11 volumio wireless.js[6904]: trying...
Nov 09 09:33:11 volumio sudo[7159]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Nov 09 09:33:11 volumio sudo[7159]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 09 09:33:11 volumio sudo[7159]: pam_unix(sudo:session): session closed for user root
Nov 09 09:33:11 volumio kernel: in count:5234481, out count:5234480
Nov 09 09:33:11 volumio kernel: reduce cnt:180, mpll1_rate:48999976, mpll2 rate:48999976
Nov 09 09:33:11 volumio kernel: in count:402646, out count:402651
Nov 09 09:33:11 volumio kernel: add cnt:203, mpll1_rate:48999976 mpll2 rate:48999317
Nov 09 09:33:11 volumio wpa_supplicant[6984]: wlan0: Authentication with 30:c5:0f:a3:58:f4 timed out.
Nov 09 09:33:11 volumio wpa_supplicant[6984]: wlan0: CTRL-EVENT-DISCONNECTED bssid=30:c5:0f:a3:58:f4 reason=3 locally_generated=1
Nov 09 09:33:11 volumio kernel: CFG80211-ERROR) wl_cfg80211_check_in4way : wl_cfg80211_check_in4way: return -EBUSY cnt 1
Nov 09 09:33:11 volumio kernel: in count:402651, out count:402651
Nov 09 09:33:12 volumio wireless.js[6904]: trying...
Nov 09 09:33:12 volumio sudo[7162]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Nov 09 09:33:12 volumio sudo[7162]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 09 09:33:12 volumio sudo[7162]: pam_unix(sudo:session): session closed for user root
Nov 09 09:33:12 volumio kernel: in count:805304, out count:805304
Nov 09 09:33:12 volumio kernel: in count:1207956, out count:1207956
Nov 09 09:33:12 volumio volumio-remote-updater[4055]: [2023-11-09 09:33:12] [info] asio async_connect error: system:111 (Connection refused)
Nov 09 09:33:12 volumio volumio-remote-updater[4055]: [2023-11-09 09:33:12] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Nov 09 09:33:12 volumio volumio-remote-updater[4055]: [2023-11-09 09:33:12] [error] handle_connect error: Underlying Transport Error
Nov 09 09:33:13 volumio wireless.js[6904]: trying...
Nov 09 09:33:13 volumio kernel: in count:1610609, out count:1610608
Nov 09 09:33:13 volumio kernel: reduce cnt:181, mpll1_rate:48999976, mpll2 rate:48999903
Nov 09 09:33:13 volumio sudo[7165]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Nov 09 09:33:13 volumio sudo[7165]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 09 09:33:13 volumio sudo[7165]: pam_unix(sudo:session): session closed for user root
Nov 09 09:33:13 volumio kernel: in count:402645, out count:402651
Nov 09 09:33:13 volumio kernel: add cnt:204, mpll1_rate:48999976 mpll2 rate:48999244
Nov 09 09:33:13 volumio kernel: in count:402650, out count:402651
Nov 09 09:33:13 volumio kernel: add cnt:205, mpll1_rate:48999976 mpll2 rate:48999830
Nov 09 09:33:14 volumio wireless.js[6904]: trying...
Nov 09 09:33:14 volumio sudo[7168]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Nov 09 09:33:14 volumio sudo[7168]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 09 09:33:14 volumio sudo[7168]: pam_unix(sudo:session): session closed for user root
Nov 09 09:33:14 volumio kernel: in count:402655, out count:402652
Nov 09 09:33:14 volumio kernel: reduce cnt:182, mpll1_rate:48999976, mpll2 rate:49000416
Nov 09 09:33:14 volumio kernel: in count:402650, out count:402651
Nov 09 09:33:14 volumio kernel: add cnt:206, mpll1_rate:48999976 mpll2 rate:48999756
Nov 09 09:33:15 volumio kernel: in count:402655, out count:402652
Nov 09 09:33:15 volumio kernel: reduce cnt:183, mpll1_rate:48999976, mpll2 rate:49000343
Nov 09 09:33:15 volumio wireless.js[6904]: trying...
Nov 09 09:33:15 volumio sudo[7171]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Nov 09 09:33:15 volumio sudo[7171]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 09 09:33:15 volumio sudo[7171]: pam_unix(sudo:session): session closed for user root
Nov 09 09:33:15 volumio kernel: in count:402650, out count:402651
Nov 09 09:33:15 volumio kernel: add cnt:207, mpll1_rate:48999976 mpll2 rate:48999683
Nov 09 09:33:16 volumio kernel: in count:402654, out count:402651
Nov 09 09:33:16 volumio kernel: reduce cnt:184, mpll1_rate:48999976, mpll2 rate:49000269
Nov 09 09:33:16 volumio wireless.js[6904]: trying...
Nov 09 09:33:16 volumio sudo[7174]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Nov 09 09:33:16 volumio sudo[7174]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 09 09:33:16 volumio sudo[7174]: pam_unix(sudo:session): session closed for user root
Nov 09 09:33:16 volumio kernel: in count:402649, out count:402652
Nov 09 09:33:16 volumio kernel: add cnt:208, mpll1_rate:48999976 mpll2 rate:48999610
Nov 09 09:33:16 volumio kernel: in count:402653, out count:402651
Nov 09 09:33:16 volumio kernel: reduce cnt:185, mpll1_rate:48999976, mpll2 rate:49000196
Nov 09 09:33:17 volumio wpa_supplicant[6984]: wlan0: CTRL-EVENT-ASSOC-REJECT bssid=30:c5:0f:a3:58:f4 status_code=1
Nov 09 09:33:17 volumio kernel: connect failed event=0 e->status 1 e->reason 0
Nov 09 09:33:17 volumio kernel: CFG80211-ERROR) wl_bss_connect_done : Report connect result - connection failed
Nov 09 09:33:17 volumio kernel: in count:402648, out count:402652
Nov 09 09:33:17 volumio kernel: add cnt:209, mpll1_rate:48999976 mpll2 rate:48999537
Nov 09 09:33:17 volumio wireless.js[6904]: Overtime, starting plan B
Nov 09 09:33:17 volumio kernel: in count:402653, out count:402651
Nov 09 09:33:17 volumio kernel: reduce cnt:186, mpll1_rate:48999976, mpll2 rate:49000123
Nov 09 09:33:18 volumio kernel: in count:402648, out count:402652
Nov 09 09:33:18 volumio kernel: add cnt:210, mpll1_rate:48999976 mpll2 rate:48999463
Nov 09 09:33:18 volumio kernel: in count:402653, out count:402651
Nov 09 09:33:18 volumio kernel: reduce cnt:187, mpll1_rate:48999976, mpll2 rate:49000050
Nov 09 09:33:18 volumio kernel: in count:402647, out count:402651
Nov 09 09:33:18 volumio kernel: add cnt:211, mpll1_rate:48999976 mpll2 rate:48999390
Nov 09 09:33:19 volumio kernel: in count:402652, out count:402651
Nov 09 09:33:19 volumio kernel: reduce cnt:188, mpll1_rate:48999976, mpll2 rate:48999976
Nov 09 09:33:19 volumio kernel: in count:402646, out count:402652
Nov 09 09:33:19 volumio kernel: add cnt:212, mpll1_rate:48999976 mpll2 rate:48999317
Nov 09 09:33:20 volumio kernel: in count:402651, out count:402652
Nov 09 09:33:20 volumio kernel: add cnt:213, mpll1_rate:48999976 mpll2 rate:48999903
Nov 09 09:33:20 volumio kernel: in count:402656, out count:402652
Nov 09 09:33:20 volumio kernel: reduce cnt:189, mpll1_rate:48999976, mpll2 rate:49000489
Nov 09 09:33:20 volumio kernel: in count:402651, out count:402651
Nov 09 09:33:21 volumio kernel: in count:805302, out count:805304
Nov 09 09:33:21 volumio kernel: add cnt:214, mpll1_rate:48999976 mpll2 rate:48999830
Nov 09 09:33:21 volumio kernel: in count:402655, out count:402651
Nov 09 09:33:21 volumio kernel: reduce cnt:190, mpll1_rate:48999976, mpll2 rate:49000416
Nov 09 09:33:22 volumio nmbd[4326]: [2023/11/09 09:33:22.009823, 0] ../source3/libsmb/nmblib.c:873(send_udp)
Nov 09 09:33:22 volumio nmbd[4326]: Packet send failed to 192.168.10.255(138) ERRNO=Network is unreachable
Nov 09 09:33:22 volumio nmbd[4326]: [2023/11/09 09:33:22.020203, 0] ../source3/nmbd/nmbd.c:362(reload_interfaces)
Nov 09 09:33:22 volumio nmbd[4326]: reload_interfaces: No subnets to listen to. Waiting..
Nov 09 09:33:22 volumio kernel: in count:402651, out count:402651
Nov 09 09:33:22 volumio kernel: in count:805302, out count:805304
Nov 09 09:33:22 volumio kernel: add cnt:215, mpll1_rate:48999976 mpll2 rate:48999756
Nov 09 09:33:22 volumio kernel: in count:402655, out count:402652
Nov 09 09:33:22 volumio kernel: reduce cnt:191, mpll1_rate:48999976, mpll2 rate:49000343
Nov 09 09:33:22 volumio volumio-remote-updater[4055]: [2023-11-09 09:33:22] [info] asio async_connect error: system:111 (Connection refused)
Nov 09 09:33:22 volumio volumio-remote-updater[4055]: [2023-11-09 09:33:22] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Nov 09 09:33:22 volumio volumio-remote-updater[4055]: [2023-11-09 09:33:22] [error] handle_connect error: Underlying Transport Error
Nov 09 09:33:23 volumio kernel: in count:402649, out count:402652
Nov 09 09:33:23 volumio kernel: add cnt:216, mpll1_rate:48999976 mpll2 rate:48999683
Nov 09 09:33:23 volumio wpa_supplicant[6984]: wlan0: Trying to associate with 30:c5:0f:a3:58:f4 (SSID='Base_Linux' freq=2462 MHz)
Nov 09 09:33:23 volumio kernel: Connecting with 30:c5:0f:a3:58:f4 ssid "Base_Linux", len (10) channel=11
Nov 09 09:33:23 volumio kernel: dhd_dbg_start_pkt_monitor, 1724
Nov 09 09:33:23 volumio kernel: in count:402654, out count:402652
Nov 09 09:33:23 volumio kernel: reduce cnt:192, mpll1_rate:48999976, mpll2 rate:49000269
Nov 09 09:33:24 volumio kernel: in count:402649, out count:402651
Nov 09 09:33:24 volumio kernel: add cnt:217, mpll1_rate:48999976 mpll2 rate:48999610
Nov 09 09:33:24 volumio kernel: in count:402654, out count:402651
Nov 09 09:33:24 volumio kernel: reduce cnt:193, mpll1_rate:48999976, mpll2 rate:49000196
Nov 09 09:33:24 volumio kernel: in count:402648, out count:402652
Nov 09 09:33:24 volumio kernel: add cnt:218, mpll1_rate:48999976 mpll2 rate:48999537
Nov 09 09:33:25 volumio kernel: in count:402652, out count:402651
Nov 09 09:33:25 volumio kernel: reduce cnt:194, mpll1_rate:48999976, mpll2 rate:49000123
Nov 09 09:33:25 volumio kernel: in count:402648, out count:402651
Nov 09 09:33:25 volumio kernel: add cnt:219, mpll1_rate:48999976 mpll2 rate:48999463
Nov 09 09:33:26 volumio kernel: in count:402653, out count:402651
Nov 09 09:33:26 volumio kernel: reduce cnt:195, mpll1_rate:48999976, mpll2 rate:49000050
Nov 09 09:33:26 volumio kernel: in count:402647, out count:402651
Nov 09 09:33:26 volumio kernel: add cnt:220, mpll1_rate:48999976 mpll2 rate:48999390
Nov 09 09:33:26 volumio dhcpcd[6958]: timed out
Nov 09 09:33:26 volumio dhcpcd[6958]: allowing 8 seconds for IPv4LL timeout
Nov 09 09:33:26 volumio kernel: in count:402651, out count:402651
Nov 09 09:33:27 volumio kernel: in count:805304, out count:805304
Nov 09 09:33:27 volumio kernel: in count:1207956, out count:1207956
Nov 09 09:33:28 volumio kernel: in count:1610609, out count:1610609
Nov 09 09:33:28 volumio kernel: in count:2013261, out count:2013261
Nov 09 09:33:28 volumio kernel: in count:2415913, out count:2415913
Nov 09 09:33:29 volumio kernel: in count:2818566, out count:2818566
Nov 09 09:33:29 volumio kernel: in count:3221218, out count:3221218
Nov 09 09:33:30 volumio kernel: in count:3623871, out count:3623871
Nov 09 09:33:30 volumio kernel: in count:4026523, out count:4026523
Nov 09 09:33:30 volumio kernel: in count:4429175, out count:4429175
Nov 09 09:33:31 volumio kernel: in count:4831828, out count:4831828
Nov 09 09:33:31 volumio kernel: in count:5234480, out count:5234480
Nov 09 09:33:32 volumio kernel: in count:5637133, out count:5637133
Nov 09 09:33:32 volumio kernel: in count:6039785, out count:6039785
Nov 09 09:33:32 volumio kernel: in count:6442437, out count:6442437
Nov 09 09:33:32 volumio volumio-remote-updater[4055]: [2023-11-09 09:33:32] [info] asio async_connect error: system:111 (Connection refused)
Nov 09 09:33:32 volumio volumio-remote-updater[4055]: [2023-11-09 09:33:32] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Nov 09 09:33:32 volumio volumio-remote-updater[4055]: [2023-11-09 09:33:32] [error] handle_connect error: Underlying Transport Error
Nov 09 09:33:33 volumio kernel: in count:6845090, out count:6845090
Nov 09 09:33:33 volumio wpa_supplicant[6984]: wlan0: Authentication with 30:c5:0f:a3:58:f4 timed out.
Nov 09 09:33:33 volumio wpa_supplicant[6984]: wlan0: CTRL-EVENT-DISCONNECTED bssid=30:c5:0f:a3:58:f4 reason=3 locally_generated=1
Nov 09 09:33:33 volumio wpa_supplicant[6984]: wlan0: CTRL-EVENT-SSID-TEMP-DISABLED id=0 ssid="Base_Linux" auth_failures=1 duration=10 reason=CONN_FAILED
Nov 09 09:33:33 volumio kernel: CFG80211-ERROR) wl_cfg80211_check_in4way : wl_cfg80211_check_in4way: return -EBUSY cnt 1
Nov 09 09:33:33 volumio kernel: in count:7247742, out count:7247742
Nov 09 09:33:34 volumio kernel: in count:7650395, out count:7650394
Nov 09 09:33:34 volumio kernel: reduce cnt:196, mpll1_rate:48999976, mpll2 rate:48999976
Nov 09 09:33:34 volumio kernel: in count:402646, out count:402652
Nov 09 09:33:34 volumio kernel: add cnt:221, mpll1_rate:48999976 mpll2 rate:48999317
Nov 09 09:33:34 volumio dhcpcd[6958]: timed out
Nov 09 09:33:34 volumio dhcpcd[6958]: forked to background, child pid 7179
Nov 09 09:33:34 volumio sudo[6944]: pam_unix(sudo:session): session closed for user root
Nov 09 09:33:34 volumio systemd[1]: Started Wireless Services.
Nov 09 09:33:34 volumio systemd[1]: Starting Volumio Backend Module...
Nov 09 09:33:34 volumio systemd[1]: Started Volumio Backend Module.
Nov 09 09:33:34 volumio kernel: in count:402651, out count:402651
Nov 09 09:33:35 volumio kernel: in count:805304, out count:805303
Nov 09 09:33:35 volumio kernel: reduce cnt:197, mpll1_rate:48999976, mpll2 rate:48999903
Nov 09 09:33:35 volumio volumio[7181]: info: -------------------------------------------
Nov 09 09:33:35 volumio volumio[7181]: info: ----- Volumio2 ----
Nov 09 09:33:35 volumio volumio[7181]: info: -------------------------------------------
Nov 09 09:33:35 volumio volumio[7181]: info: ----- System startup ----
Nov 09 09:33:35 volumio volumio[7181]: info: -------------------------------------------
Nov 09 09:33:35 volumio volumio[7181]: info: MYVOLUMIO Environment detected
Nov 09 09:33:35 volumio kernel: in count:402645, out count:402651
Nov 09 09:33:35 volumio kernel: add cnt:222, mpll1_rate:48999976 mpll2 rate:48999244
Nov 09 09:33:35 volumio wpa_supplicant[6984]: wlan0: CTRL-EVENT-ASSOC-REJECT bssid=30:c5:0f:a3:58:f4 status_code=1
Nov 09 09:33:35 volumio kernel: connect failed event=0 e->status 4 e->reason 1
Nov 09 09:33:35 volumio kernel: CFG80211-ERROR) wl_bss_connect_done : Report connect result - connection failed
Nov 09 09:33:36 volumio volumio[7181]: info: Plugin folders cleanup
Nov 09 09:33:36 volumio volumio[7181]: info: Scanning into folder /volumio/app/plugins/
Nov 09 09:33:36 volumio volumio[7181]: info: Scanning category audio_interface
Nov 09 09:33:36 volumio volumio[7181]: info: Scanning category miscellanea
Nov 09 09:33:36 volumio volumio[7181]: info: Scanning category music_service
Nov 09 09:33:36 volumio kernel: in count:402650, out count:402651
Nov 09 09:33:36 volumio kernel: add cnt:223, mpll1_rate:48999976 mpll2 rate:48999830
Nov 09 09:33:36 volumio volumio[7181]: info: Scanning category plugins.json
Nov 09 09:33:36 volumio volumio[7181]: info: Scanning category system_controller
Nov 09 09:33:36 volumio volumio[7181]: info: Scanning category user_interface
Nov 09 09:33:36 volumio volumio[7181]: info: Scanning into folder /data/plugins/
Nov 09 09:33:36 volumio volumio[7181]: info: Scanning category accessory
Nov 09 09:33:36 volumio volumio[7181]: info: Scanning category audio_interface
Nov 09 09:33:36 volumio volumio[7181]: info: Scanning category music_service
Nov 09 09:33:36 volumio volumio[7181]: info: Scanning category system_controller
Nov 09 09:33:36 volumio volumio[7181]: info: Plugin folders cleanup completed
Nov 09 09:33:36 volumio volumio[7181]: info: -------------------------------------------
Nov 09 09:33:36 volumio volumio[7181]: info: ----- Core plugins startup ----
Nov 09 09:33:36 volumio volumio[7181]: info: -------------------------------------------
Nov 09 09:33:36 volumio volumio[7181]: info: Loading plugins from folder /volumio/app/plugins/
Nov 09 09:33:36 volumio volumio[7181]: info: Adding plugin upnp to MyMusic Plugins
Nov 09 09:33:36 volumio volumio[7181]: info: Adding plugin airplay_emulation to MyMusic Plugins
Nov 09 09:33:36 volumio volumio[7181]: info: Adding plugin upnp_browser to MyMusic Plugins
Nov 09 09:33:36 volumio volumio[7181]: info: Loading plugins from folder /data/plugins/
Nov 09 09:33:36 volumio volumio[7181]: info: Loading plugin "system"...
Nov 09 09:33:36 volumio volumio[7181]: info: Loading plugin "appearance"...
Nov 09 09:33:36 volumio kernel: in count:402655, out count:402652
Nov 09 09:33:36 volumio kernel: reduce cnt:198, mpll1_rate:48999976, mpll2 rate:49000416
Nov 09 09:33:36 volumio volumio[7181]: info: Loading plugin "network"...
Nov 09 09:33:36 volumio volumio[7181]: info: Loading plugin "services"...
Nov 09 09:33:36 volumio volumio[7181]: info: Loading plugin "alsa_controller"...
Nov 09 09:33:36 volumio volumio[7181]: info: Loading plugin "wizard"...
Nov 09 09:33:36 volumio volumio[7181]: info: Loading plugin "volumio_command_line_client"...
Nov 09 09:33:36 volumio volumio[7181]: info: Plugin upnp is not enabled
Nov 09 09:33:36 volumio volumio[7181]: info: Loading plugin "my_music"...
Nov 09 09:33:36 volumio volumio[7181]: info: Loading plugin "mpd"...
Nov 09 09:33:36 volumio kernel: in count:402651, out count:402651
Nov 09 09:33:36 volumio volumio[7181]: info: Plugin upnp_browser is not enabled
Nov 09 09:33:36 volumio volumio[7181]: info: Loading plugin "networkfs"...
Nov 09 09:33:37 volumio volumio[7181]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Nov 09 09:33:37 volumio volumio[7181]: info: Loading plugin "alarm-clock"...
Nov 09 09:33:37 volumio sudo[7204]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t nfs -o ro,soft,noauto,ro lena.baselinux.net:/DATA/mmedia/music /mnt/NAS/lena_music
Nov 09 09:33:37 volumio sudo[7204]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 09 09:33:37 volumio sudo[7204]: pam_unix(sudo:session): session closed for user root
Nov 09 09:33:37 volumio volumio[7181]: info: Plugin airplay_emulation is not enabled
Nov 09 09:33:37 volumio volumio[7181]: info: Loading plugin "last_100"...
Nov 09 09:33:37 volumio volumio[7181]: info: Loading plugin "webradio"...
Nov 09 09:33:37 volumio volumio[7181]: info: Loading plugin "i2s_dacs"...
Nov 09 09:33:37 volumio volumio[7181]: info: I2S DAC not set, start Auto-detection
Nov 09 09:33:37 volumio volumio[7181]: info: Loading plugin "volumiodiscovery"...
Nov 09 09:33:37 volumio volumio[7181]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Nov 09 09:33:37 volumio node[7181]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Nov 09 09:33:37 volumio node[7181]: *** WARNING *** Please fix your application to use the native API of Avahi!
Nov 09 09:33:37 volumio node[7181]: *** WARNING *** For more information see
Nov 09 09:33:37 volumio node[7181]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Nov 09 09:33:37 volumio node[7181]: *** WARNING *** Please fix your application to use the native API of Avahi!
Nov 09 09:33:37 volumio node[7181]: *** WARNING *** For more information see
Nov 09 09:33:37 volumio volumio[7181]: *** WARNING *** Please fix your application to use the native API of Avahi!
Nov 09 09:33:37 volumio volumio[7181]: *** WARNING *** For more information see
Nov 09 09:33:37 volumio volumio[7181]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Nov 09 09:33:37 volumio volumio[7181]: *** WARNING *** Please fix your application to use the native API of Avahi!
Nov 09 09:33:37 volumio volumio[7181]: *** WARNING *** For more information see
Nov 09 09:33:37 volumio volumio[7181]: info: Applying required configuration parameters for plugin volumiodiscovery
Nov 09 09:33:37 volumio volumio[7181]: Discovery: StartAdv! undefined
Nov 09 09:33:37 volumio volumio[7181]: Discovery: Started advertising... Volumio - undefined
Nov 09 09:33:37 volumio volumio[7181]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Nov 09 09:33:37 volumio volumio[7181]: info: Plugin volsimpleequal is not enabled
Nov 09 09:33:37 volumio volumio[7181]: info: Loading plugin "bandcamp"...
Nov 09 09:33:37 volumio kernel: in count:805302, out count:805304
Nov 09 09:33:37 volumio kernel: add cnt:224, mpll1_rate:48999976 mpll2 rate:48999756
Nov 09 09:33:37 volumio volumio[7181]: info: Loading plugin "youtube2"...
Nov 09 09:33:37 volumio kernel: in count:402655, out count:402652
Nov 09 09:33:37 volumio kernel: reduce cnt:199, mpll1_rate:48999976, mpll2 rate:49000343
Nov 09 09:33:38 volumio kernel: in count:402649, out count:402652
Nov 09 09:33:38 volumio kernel: add cnt:225, mpll1_rate:48999976 mpll2 rate:48999683
Nov 09 09:33:38 volumio kernel: in count:402653, out count:402652
Nov 09 09:33:38 volumio kernel: reduce cnt:200, mpll1_rate:48999976, mpll2 rate:49000269
Nov 09 09:33:38 volumio kernel: in count:402649, out count:402651
Nov 09 09:33:38 volumio kernel: add cnt:226, mpll1_rate:48999976 mpll2 rate:48999610
Nov 09 09:33:39 volumio kernel: in count:402653, out count:402652
Nov 09 09:33:39 volumio kernel: reduce cnt:201, mpll1_rate:48999976, mpll2 rate:49000196
Nov 09 09:33:39 volumio volumio[7181]: info: Loading plugin "outputs"...
Nov 09 09:33:39 volumio volumio[7181]: info: Loading plugin "albumart"...
Nov 09 09:33:39 volumio volumio[7181]: info: Plugin example_plugin is not enabled
Nov 09 09:33:39 volumio volumio[7181]: info: Loading plugin "inputs"...
Nov 09 09:33:39 volumio volumio[7181]: info: Loading plugin "updater_comm"...
Nov 09 09:33:39 volumio volumio[7181]: info: Plugin mpdemulation is not enabled
Nov 09 09:33:39 volumio volumio[7181]: info: Loading plugin "rest_api"...
Nov 09 09:33:39 volumio volumio[7181]: info: Loading plugin "websocket"...
Nov 09 09:33:39 volumio volumio[7181]: info: Loading plugin "ir_controller"...
Nov 09 09:33:39 volumio kernel: in count:402648, out count:402652
Nov 09 09:33:39 volumio kernel: add cnt:227, mpll1_rate:48999976 mpll2 rate:48999537
Nov 09 09:33:39 volumio volumio[7181]: Forking 5 albumart workers
Nov 09 09:33:39 volumio volumio[7181]: info: Applying required configuration parameters for plugin ir_controller
Nov 09 09:33:39 volumio volumio[7181]: info: Loading plugin "radio_paradise"...
Nov 09 09:33:40 volumio volumio[7181]: info: Applying required configuration parameters for plugin radio_paradise
Nov 09 09:33:40 volumio volumio[7181]: info: [1699522420054] [RadioParadise] API delay: 5
Nov 09 09:33:40 volumio volumio[7181]: info: Loading plugin "backup_restore"...
Nov 09 09:33:40 volumio kernel: in count:402652, out count:402652
Nov 09 09:33:40 volumio volumio[7181]: info: Loading plugin "wifireconnect"...
Nov 09 09:33:40 volumio volumio[7181]: Starting albumart workers
Nov 09 09:33:40 volumio volumio[7181]: Starting albumart workers
Nov 09 09:33:40 volumio volumio[7181]: info: ___________ START PLUGINS ___________
Nov 09 09:33:40 volumio volumio[7181]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Nov 09 09:33:40 volumio volumio[7181]: info: [1699522420398] CoreMusicLibrary::Adding element Last_100
Nov 09 09:33:40 volumio volumio[7181]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Nov 09 09:33:40 volumio volumio[7181]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Nov 09 09:33:40 volumio volumio[7181]: info: [1699522420406] CoreMusicLibrary::Adding element Webradio
Nov 09 09:33:40 volumio volumio[7181]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Nov 09 09:33:40 volumio volumio[7181]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Nov 09 09:33:40 volumio volumio[7181]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Nov 09 09:33:40 volumio volumio[7181]: info: [1699522420421] CoreMusicLibrary::Adding element Bandcamp Discover
Nov 09 09:33:40 volumio volumio[7181]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Nov 09 09:33:40 volumio volumio[7181]: info: [youtube2-auth] Starting auth flow...
Nov 09 09:33:40 volumio volumio[7181]: Starting albumart workers
Nov 09 09:33:40 volumio volumio[7181]: Starting albumart workers
Nov 09 09:33:40 volumio volumio[7181]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Nov 09 09:33:40 volumio volumio[7181]: info: [1699522420477] CoreMusicLibrary::Adding element YouTube2
Nov 09 09:33:40 volumio volumio[7181]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Nov 09 09:33:40 volumio volumio[7181]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Nov 09 09:33:40 volumio volumio[7181]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Nov 09 09:33:40 volumio sudo[7250]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/lirc/hardware.conf
Nov 09 09:33:40 volumio sudo[7250]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 09 09:33:40 volumio kernel: in count:805306, out count:805304
Nov 09 09:33:40 volumio kernel: reduce cnt:202, mpll1_rate:48999976, mpll2 rate:49000123
Nov 09 09:33:40 volumio sudo[7250]: pam_unix(sudo:session): session closed for user root
Nov 09 09:33:40 volumio volumio[7181]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Nov 09 09:33:40 volumio volumio[7181]: info: [1699522420573] CoreMusicLibrary::Adding element Radio Paradise
Nov 09 09:33:40 volumio volumio[7181]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Nov 09 09:33:40 volumio sudo[7261]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /etc/lirc/hardware.conf /etc/lirc/lircd.conf /etc/lirc/lircmd.conf /etc/lirc/lircrc
Nov 09 09:33:40 volumio sudo[7261]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 09 09:33:40 volumio sudo[7261]: pam_unix(sudo:session): session closed for user root
Nov 09 09:33:40 volumio volumio[7181]: info: -------------------------------------------
Nov 09 09:33:40 volumio volumio[7181]: info: ----- MyVolumio plugins startup ----
Nov 09 09:33:40 volumio volumio[7181]: info: -------------------------------------------
Nov 09 09:33:40 volumio volumio[7181]: info: [MyVolumio PluginManager] Fetching plans data....
Nov 09 09:33:40 volumio volumio[7181]: info: Loading i18n strings for locale es
Nov 09 09:33:40 volumio sudo[7264]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start wifireconnect.timer
Nov 09 09:33:40 volumio sudo[7264]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 09 09:33:40 volumio volumio[7181]: Updating browse sources language
Nov 09 09:33:40 volumio volumio[7181]: Cannot find translation for sourceBandcamp Discover
Nov 09 09:33:40 volumio volumio[7181]: Cannot find translation for sourceYouTube2
Nov 09 09:33:40 volumio volumio[7181]: Cannot find translation for sourceRadio Paradise
Nov 09 09:33:40 volumio volumio[7181]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Nov 09 09:33:40 volumio volumio[7181]: Starting albumart workers
Nov 09 09:33:40 volumio systemd[1]: Started Runs wifireconnect every 1min.
Nov 09 09:33:40 volumio sudo[7264]: pam_unix(sudo:session): session closed for user root
Nov 09 09:33:40 volumio volumio[7181]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Nov 09 09:33:40 volumio volumio[7181]: info: CoreCommandRouter::initPlayerControls
Nov 09 09:33:40 volumio volumio[7181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 09 09:33:40 volumio volumio[7181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards
Nov 09 09:33:40 volumio volumio[7181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 09 09:33:40 volumio volumio[7181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 09 09:33:40 volumio volumio[7181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 09 09:33:40 volumio volumio[7181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 09 09:33:40 volumio volumio[7181]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 09 09:33:40 volumio volumio[7181]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Nov 09 09:33:40 volumio volumio[7181]: info: BOOT COMPLETED
Nov 09 09:33:40 volumio volumio[7181]: [Metrics] CommandRouter: 5s 71.97ms
Nov 09 09:33:40 volumio volumio[7181]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Nov 09 09:33:40 volumio volumio[7181]: ALSA lib pcm_hw.c:1713:(_snd_pcm_hw_open) Invalid value for card
Nov 09 09:33:40 volumio volumio[7181]: aplay: main:722: audio open error: No such file or directory
Nov 09 09:33:40 volumio volumio[7181]: Cannot play startup sound
Nov 09 09:33:40 volumio volumio[7181]: info: CoreCommandRouter::Close All Modals sent
Nov 09 09:33:40 volumio volumio[7181]: info: CoreCommandRouter::Close All Modals sent
Nov 09 09:33:40 volumio volumio[7181]: Express server listening on port 3000
Nov 09 09:33:40 volumio volumio[7181]: [Metrics] WebUI: 5s 314.17ms
Nov 09 09:33:40 volumio volumio[7181]: Volumio Calling Home
Nov 09 09:33:40 volumio volumio[7181]: info: CoreStateMachine::resetVolumioState
Nov 09 09:33:40 volumio volumio[7181]: info: CoreStateMachine::getcurrentVolume
Nov 09 09:33:40 volumio volumio[7181]: info: CoreCommandRouter::volumioRetrievevolume
Nov 09 09:33:40 volumio volumio[7181]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt'
Nov 09 09:33:40 volumio volumio[7181]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Nov 09 09:33:40 volumio volumio[7181]: ReferenceError: deferred is not defined
Nov 09 09:33:40 volumio volumio[7181]: at ClientRequest.req.on (/data/plugins/music_service/youtube2/lib/core/gapi/auth.js:155:13)
Nov 09 09:33:40 volumio volumio[7181]: at emitOne (events.js:116:13)
Nov 09 09:33:40 volumio volumio[7181]: at ClientRequest.emit (events.js:211:7)
Nov 09 09:33:40 volumio volumio[7181]: at TLSSocket.socketErrorListener (_http_client.js:387:9)
Nov 09 09:33:40 volumio volumio[7181]: at emitOne (events.js:116:13)
Nov 09 09:33:40 volumio volumio[7181]: at TLSSocket.emit (events.js:211:7)
Nov 09 09:33:40 volumio volumio[7181]: at emitErrorNT (internal/streams/destroy.js:64:8)
Nov 09 09:33:40 volumio volumio[7181]: at _combinedTickCallback (internal/process/next_tick.js:138:11)
Nov 09 09:33:40 volumio volumio[7181]: at process._tickCallback (internal/process/next_tick.js:180:9)
Nov 09 09:33:40 volumio volumio[7181]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Nov 09 09:33:40 volumio kernel: in count:402648, out count:402651
Nov 09 09:33:40 volumio kernel: add cnt:228, mpll1_rate:48999976 mpll2 rate:48999463
Nov 09 09:33:41 volumio kernel: in count:402652, out count:402651
Nov 09 09:33:41 volumio kernel: reduce cnt:203, mpll1_rate:48999976, mpll2 rate:49000050
Nov 09 09:33:41 volumio sudo[7298]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2023-11-09 09:32
Nov 09 09:33:41 volumio sudo[7298]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 09 09:33:41 volumio sudo[7298]: pam_unix(sudo:session): session closed for user root
Nov 09 09:33:41 volumio kernel: in count:402647, out count:402651
Nov 09 09:33:41 volumio kernel: add cnt:229, mpll1_rate:48999976 mpll2 rate:48999390
Nov 09 09:33:41 volumio systemd[1]: volumio.service: main process exited, code=exited, status=1/FAILURE
Nov 09 09:33:41 volumio systemd[1]: Unit volumio.service entered failed state.
Nov 09 09:33:41 volumio systemd[1]: Starting dynamicswap service...
Nov 09 09:33:41 volumio systemd[1]: Started dynamicswap service.
Nov 09 09:33:42 volumio systemd[1]: volumio.service holdoff time over, scheduling restart.
Nov 09 09:33:42 volumio systemd[1]: Starting dynamicswap service...
Nov 09 09:33:42 volumio systemd[1]: Started dynamicswap service.
Nov 09 09:33:42 volumio systemd[1]: Stopping Volumio Backend Module...
Nov 09 09:33:42 volumio systemd[1]: Starting Volumio Backend Module...
Nov 09 09:33:42 volumio systemd[1]: Started Volumio Backend Module.
Nov 09 09:33:42 volumio kernel: in count:402651, out count:402652
Nov 09 09:33:42 volumio kernel: add cnt:230, mpll1_rate:48999976 mpll2 rate:48999976
Nov 09 09:33:42 volumio kernel: in count:402656, out count:402651
Nov 09 09:33:42 volumio kernel: reduce cnt:204, mpll1_rate:48999976, mpll2 rate:49000562
Nov 09 09:33:42 volumio volumio-remote-updater[4055]: [2023-11-09 09:33:42] [connect] Successful connection
Nov 09 09:33:42 volumio kernel: in count:402651, out count:402651
Nov 09 09:33:43 volumio volumio[7324]: info: -------------------------------------------
Nov 09 09:33:43 volumio volumio[7324]: info: ----- Volumio2 ----
Nov 09 09:33:43 volumio volumio[7324]: info: -------------------------------------------
Nov 09 09:33:43 volumio volumio[7324]: info: ----- System startup ----
Nov 09 09:33:43 volumio volumio[7324]: info: -------------------------------------------
Nov 09 09:33:43 volumio volumio[7324]: info: MYVOLUMIO Environment detected
Nov 09 09:33:43 volumio kernel: in count:805304, out count:805303
Nov 09 09:33:43 volumio kernel: reduce cnt:205, mpll1_rate:48999976, mpll2 rate:48999903
Nov 09 09:33:43 volumio volumio[7324]: info: Plugin folders cleanup
Nov 09 09:33:43 volumio volumio[7324]: info: Scanning into folder /volumio/app/plugins/
Nov 09 09:33:43 volumio volumio[7324]: info: Scanning category audio_interface
Nov 09 09:33:43 volumio volumio[7324]: info: Scanning category miscellanea
Nov 09 09:33:43 volumio volumio[7324]: info: Scanning category music_service
Nov 09 09:33:43 volumio volumio[7324]: info: Scanning category plugins.json
Nov 09 09:33:43 volumio volumio[7324]: info: Scanning category system_controller
Nov 09 09:33:43 volumio volumio[7324]: info: Scanning category user_interface
Nov 09 09:33:43 volumio volumio[7324]: info: Scanning into folder /data/plugins/
Nov 09 09:33:43 volumio volumio[7324]: info: Scanning category accessory
Nov 09 09:33:43 volumio volumio[7324]: info: Scanning category audio_interface
Nov 09 09:33:43 volumio volumio[7324]: info: Scanning category music_service
Nov 09 09:33:43 volumio volumio[7324]: info: Scanning category system_controller
Nov 09 09:33:43 volumio volumio[7324]: info: Plugin folders cleanup completed
Nov 09 09:33:43 volumio volumio[7324]: info: -------------------------------------------
Nov 09 09:33:43 volumio volumio[7324]: info: ----- Core plugins startup ----
Nov 09 09:33:43 volumio volumio[7324]: info: -------------------------------------------
Nov 09 09:33:43 volumio volumio[7324]: info: Loading plugins from folder /volumio/app/plugins/
Nov 09 09:33:43 volumio volumio[7324]: info: Adding plugin upnp to MyMusic Plugins
Nov 09 09:33:43 volumio volumio[7324]: info: Adding plugin airplay_emulation to MyMusic Plugins
Nov 09 09:33:43 volumio volumio[7324]: info: Adding plugin upnp_browser to MyMusic Plugins
Nov 09 09:33:43 volumio volumio[7324]: info: Loading plugins from folder /data/plugins/
Nov 09 09:33:43 volumio volumio[7324]: info: Loading plugin "system"...
Nov 09 09:33:43 volumio volumio[7324]: info: Loading plugin "appearance"...
Nov 09 09:33:43 volumio kernel: in count:402645, out count:402652
Nov 09 09:33:43 volumio kernel: add cnt:231, mpll1_rate:48999976 mpll2 rate:48999244
Nov 09 09:33:44 volumio volumio[7324]: info: Loading plugin "network"...
Nov 09 09:33:44 volumio volumio[7324]: info: Loading plugin "services"...
Nov 09 09:33:44 volumio volumio[7324]: info: Loading plugin "alsa_controller"...
Nov 09 09:33:44 volumio volumio[7324]: info: Loading plugin "wizard"...
Nov 09 09:33:44 volumio volumio[7324]: info: Loading plugin "volumio_command_line_client"...
Nov 09 09:33:44 volumio volumio[7324]: info: Plugin upnp is not enabled
Nov 09 09:33:44 volumio volumio[7324]: info: Loading plugin "my_music"...
Nov 09 09:33:44 volumio volumio[7324]: info: Loading plugin "mpd"...
Nov 09 09:33:44 volumio kernel: in count:402650, out count:402652
Nov 09 09:33:44 volumio kernel: add cnt:232, mpll1_rate:48999976 mpll2 rate:48999830
Nov 09 09:33:44 volumio volumio[7324]: info: Plugin upnp_browser is not enabled
Nov 09 09:33:44 volumio volumio[7324]: info: Loading plugin "networkfs"...
Nov 09 09:33:44 volumio volumio[7324]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Nov 09 09:33:44 volumio volumio[7324]: info: Loading plugin "alarm-clock"...
Nov 09 09:33:44 volumio sudo[7348]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t nfs -o ro,soft,noauto,ro lena.baselinux.net:/DATA/mmedia/music /mnt/NAS/lena_music
Nov 09 09:33:44 volumio sudo[7348]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 09 09:33:44 volumio kernel: in count:402655, out count:402651
Nov 09 09:33:44 volumio kernel: reduce cnt:206, mpll1_rate:48999976, mpll2 rate:49000416
Nov 09 09:33:44 volumio sudo[7348]: pam_unix(sudo:session): session closed for user root
Nov 09 09:33:44 volumio volumio[7324]: info: Plugin airplay_emulation is not enabled
Nov 09 09:33:44 volumio volumio[7324]: info: Loading plugin "last_100"...
Nov 09 09:33:44 volumio volumio[7324]: info: Loading plugin "webradio"...
Nov 09 09:33:44 volumio volumio[7324]: info: Loading plugin "i2s_dacs"...
Nov 09 09:33:44 volumio volumio[7324]: info: I2S DAC not set, start Auto-detection
Nov 09 09:33:44 volumio volumio[7324]: info: Loading plugin "volumiodiscovery"...
Nov 09 09:33:44 volumio volumio[7324]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Nov 09 09:33:44 volumio node[7324]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Nov 09 09:33:44 volumio node[7324]: *** WARNING *** Please fix your application to use the native API of Avahi!
Nov 09 09:33:44 volumio node[7324]: *** WARNING *** For more information see
Nov 09 09:33:44 volumio node[7324]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Nov 09 09:33:44 volumio node[7324]: *** WARNING *** Please fix your application to use the native API of Avahi!
Nov 09 09:33:44 volumio node[7324]: *** WARNING *** For more information see
Nov 09 09:33:44 volumio volumio[7324]: *** WARNING *** Please fix your application to use the native API of Avahi!
Nov 09 09:33:44 volumio volumio[7324]: *** WARNING *** For more information see
Nov 09 09:33:44 volumio volumio[7324]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Nov 09 09:33:44 volumio volumio[7324]: *** WARNING *** Please fix your application to use the native API of Avahi!
Nov 09 09:33:44 volumio volumio[7324]: *** WARNING *** For more information see
Nov 09 09:33:44 volumio volumio[7324]: info: Applying required configuration parameters for plugin volumiodiscovery
Nov 09 09:33:44 volumio volumio[7324]: Discovery: StartAdv! undefined
Nov 09 09:33:44 volumio volumio[7324]: Discovery: Started advertising... Volumio - undefined
Nov 09 09:33:44 volumio volumio[7324]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Nov 09 09:33:44 volumio volumio[7324]: info: Plugin volsimpleequal is not enabled
Nov 09 09:33:44 volumio volumio[7324]: info: Loading plugin "bandcamp"...
Nov 09 09:33:44 volumio volumio[7324]: info: Loading plugin "youtube2"...
Nov 09 09:33:44 volumio kernel: in count:402650, out count:402651
Nov 09 09:33:44 volumio kernel: add cnt:233, mpll1_rate:48999976 mpll2 rate:48999756
Nov 09 09:33:45 volumio kernel: in count:402655, out count:402651
Nov 09 09:33:45 volumio kernel: reduce cnt:207, mpll1_rate:48999976, mpll2 rate:49000343
Nov 09 09:33:45 volumio kernel: in count:402649, out count:402652
Nov 09 09:33:45 volumio kernel: add cnt:234, mpll1_rate:48999976 mpll2 rate:48999683
Nov 09 09:33:46 volumio kernel: in count:402653, out count:402651
Nov 09 09:33:46 volumio kernel: reduce cnt:208, mpll1_rate:48999976, mpll2 rate:49000269
Nov 09 09:33:46 volumio kernel: in count:402649, out count:402651
Nov 09 09:33:46 volumio kernel: add cnt:235, mpll1_rate:48999976 mpll2 rate:48999610
Nov 09 09:33:46 volumio volumio[7324]: info: Loading plugin "outputs"...
Nov 09 09:33:46 volumio volumio[7324]: info: Loading plugin "albumart"...
Nov 09 09:33:47 volumio kernel: in count:402654, out count:402651
Nov 09 09:33:47 volumio kernel: reduce cnt:209, mpll1_rate:48999976, mpll2 rate:49000196
Nov 09 09:33:47 volumio volumio[7324]: info: Plugin example_plugin is not enabled
Nov 09 09:33:47 volumio volumio[7324]: info: Loading plugin "inputs"...
Nov 09 09:33:47 volumio volumio[7324]: info: Loading plugin "updater_comm"...
Nov 09 09:33:47 volumio volumio[7324]: info: Plugin mpdemulation is not enabled
Nov 09 09:33:47 volumio volumio[7324]: info: Loading plugin "rest_api"...
Nov 09 09:33:47 volumio volumio[7324]: info: Loading plugin "websocket"...
Nov 09 09:33:47 volumio volumio[7324]: info: Loading plugin "ir_controller"...
Nov 09 09:33:47 volumio wpa_supplicant[6984]: wlan0: CTRL-EVENT-SSID-REENABLED id=0 ssid="Base_Linux"
Nov 09 09:33:47 volumio wpa_supplicant[6984]: wlan0: Trying to associate with 30:c5:0f:a3:58:f4 (SSID='Base_Linux' freq=2462 MHz)
Nov 09 09:33:47 volumio kernel: Connecting with 30:c5:0f:a3:58:f4 ssid "Base_Linux", len (10) channel=11
Nov 09 09:33:47 volumio kernel: dhd_dbg_start_pkt_monitor, 1724
Nov 09 09:33:47 volumio volumio[7324]: Forking 5 albumart workers
Nov 09 09:33:47 volumio volumio[7324]: info: Applying required configuration parameters for plugin ir_controller
Nov 09 09:33:47 volumio volumio[7324]: info: Loading plugin "radio_paradise"...
Nov 09 09:33:47 volumio kernel: in count:402648, out count:402652
Nov 09 09:33:47 volumio kernel: add cnt:236, mpll1_rate:48999976 mpll2 rate:48999537
Nov 09 09:33:47 volumio volumio[7324]: info: Applying required configuration parameters for plugin radio_paradise
Nov 09 09:33:47 volumio volumio[7324]: info: [1699522427493] [RadioParadise] API delay: 5
Nov 09 09:33:47 volumio volumio[7324]: info: Loading plugin "backup_restore"...
Nov 09 09:33:47 volumio volumio[7324]: info: Loading plugin "wifireconnect"...
Nov 09 09:33:47 volumio volumio[7324]: Starting albumart workers
Nov 09 09:33:47 volumio volumio[7324]: Starting albumart workers
Nov 09 09:33:47 volumio volumio[7324]: info: ___________ START PLUGINS ___________
Nov 09 09:33:47 volumio kernel: in count:402652, out count:402652
Nov 09 09:33:47 volumio volumio[7324]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Nov 09 09:33:47 volumio volumio[7324]: info: [1699522427820] CoreMusicLibrary::Adding element Last_100
Nov 09 09:33:47 volumio volumio[7324]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Nov 09 09:33:47 volumio volumio[7324]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Nov 09 09:33:47 volumio volumio[7324]: info: [1699522427828] CoreMusicLibrary::Adding element Webradio
Nov 09 09:33:47 volumio volumio[7324]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Nov 09 09:33:47 volumio volumio[7324]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Nov 09 09:33:47 volumio volumio[7324]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Nov 09 09:33:47 volumio volumio[7324]: info: [1699522427844] CoreMusicLibrary::Adding element Bandcamp Discover
Nov 09 09:33:47 volumio volumio[7324]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Nov 09 09:33:47 volumio volumio[7324]: info: [youtube2-auth] Starting auth flow...
Nov 09 09:33:47 volumio volumio[7324]: Starting albumart workers
Nov 09 09:33:47 volumio volumio[7324]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Nov 09 09:33:47 volumio volumio[7324]: info: [1699522427903] CoreMusicLibrary::Adding element YouTube2
Nov 09 09:33:47 volumio volumio[7324]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Nov 09 09:33:47 volumio volumio[7324]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Nov 09 09:33:47 volumio volumio[7324]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Nov 09 09:33:47 volumio volumio[7324]: Starting albumart workers
Nov 09 09:33:47 volumio volumio[7324]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Nov 09 09:33:47 volumio volumio[7324]: info: [1699522427944] CoreMusicLibrary::Adding element Radio Paradise
Nov 09 09:33:47 volumio volumio[7324]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Nov 09 09:33:47 volumio sudo[7397]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /etc/lirc/hardware.conf /etc/lirc/lircd.conf /etc/lirc/lircmd.conf /etc/lirc/lircrc
Nov 09 09:33:47 volumio sudo[7397]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 09 09:33:47 volumio sudo[7397]: pam_unix(sudo:session): session closed for user root
Nov 09 09:33:47 volumio sudo[7396]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/lirc/hardware.conf
Nov 09 09:33:47 volumio sudo[7396]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 09 09:33:47 volumio sudo[7396]: pam_unix(sudo:session): session closed for user root
Nov 09 09:33:47 volumio volumio[7324]: info: -------------------------------------------
Nov 09 09:33:48 volumio volumio[7324]: info: ----- MyVolumio plugins startup ----
Nov 09 09:33:48 volumio volumio[7324]: info: -------------------------------------------
Nov 09 09:33:48 volumio volumio[7324]: info: [MyVolumio PluginManager] Fetching plans data....
Nov 09 09:33:48 volumio sudo[7409]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start wifireconnect.timer
Nov 09 09:33:48 volumio sudo[7409]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 09 09:33:48 volumio systemd[1]: Started Runs wifireconnect every 1min.
Nov 09 09:33:48 volumio sudo[7409]: pam_unix(sudo:session): session closed for user root
Nov 09 09:33:48 volumio volumio[7324]: info: Loading i18n strings for locale es
Nov 09 09:33:48 volumio volumio[7324]: Updating browse sources language
Nov 09 09:33:48 volumio volumio[7324]: Cannot find translation for sourceBandcamp Discover
Nov 09 09:33:48 volumio volumio[7324]: Cannot find translation for sourceYouTube2
Nov 09 09:33:48 volumio volumio[7324]: Cannot find translation for sourceRadio Paradise
Nov 09 09:33:48 volumio volumio[7324]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Nov 09 09:33:48 volumio volumio[7324]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Nov 09 09:33:48 volumio volumio[7324]: info: CoreCommandRouter::initPlayerControls
Nov 09 09:33:48 volumio volumio[7324]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 09 09:33:48 volumio volumio[7324]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards
Nov 09 09:33:48 volumio volumio[7324]: Starting albumart workers
Nov 09 09:33:48 volumio volumio[7324]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 09 09:33:48 volumio volumio[7324]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 09 09:33:48 volumio volumio[7324]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 09 09:33:48 volumio volumio[7324]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 09 09:33:48 volumio volumio[7324]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 09 09:33:48 volumio volumio[7324]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Nov 09 09:33:48 volumio volumio[7324]: info: BOOT COMPLETED
Nov 09 09:33:48 volumio volumio[7324]: [Metrics] CommandRouter: 5s 60.66ms
Nov 09 09:33:48 volumio volumio[7324]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Nov 09 09:33:48 volumio volumio[7324]: ALSA lib pcm_hw.c:1713:(_snd_pcm_hw_open) Invalid value for card
Nov 09 09:33:48 volumio volumio[7324]: aplay: main:722: audio open error: No such file or directory
Nov 09 09:33:48 volumio volumio[7324]: Cannot play startup sound
Nov 09 09:33:48 volumio volumio[7324]: info: CoreCommandRouter::Close All Modals sent
Nov 09 09:33:48 volumio volumio[7324]: info: CoreCommandRouter::Close All Modals sent
Nov 09 09:33:48 volumio volumio[7324]: Express server listening on port 3000
Nov 09 09:33:48 volumio volumio[7324]: [Metrics] WebUI: 5s 303.04ms
Nov 09 09:33:48 volumio volumio[7324]: Volumio Calling Home
Nov 09 09:33:48 volumio kernel: in count:805306, out count:805304
Nov 09 09:33:48 volumio kernel: reduce cnt:210, mpll1_rate:48999976, mpll2 rate:49000123
Nov 09 09:33:48 volumio volumio[7324]: info: CoreStateMachine::resetVolumioState
Nov 09 09:33:48 volumio volumio[7324]: info: CoreStateMachine::getcurrentVolume
Nov 09 09:33:48 volumio volumio[7324]: info: CoreCommandRouter::volumioRetrievevolume
Nov 09 09:33:48 volumio volumio[7324]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt'
Nov 09 09:33:48 volumio volumio[7324]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Nov 09 09:33:48 volumio volumio[7324]: ReferenceError: deferred is not defined
Nov 09 09:33:48 volumio volumio[7324]: at ClientRequest.req.on (/data/plugins/music_service/youtube2/lib/core/gapi/auth.js:155:13)
Nov 09 09:33:48 volumio volumio[7324]: at emitOne (events.js:116:13)
Nov 09 09:33:48 volumio volumio[7324]: at ClientRequest.emit (events.js:211:7)
Nov 09 09:33:48 volumio volumio[7324]: at TLSSocket.socketErrorListener (_http_client.js:387:9)
Nov 09 09:33:48 volumio volumio[7324]: at emitOne (events.js:116:13)
Nov 09 09:33:48 volumio volumio[7324]: at TLSSocket.emit (events.js:211:7)
Nov 09 09:33:48 volumio volumio[7324]: at emitErrorNT (internal/streams/destroy.js:64:8)
Nov 09 09:33:48 volumio volumio[7324]: at _combinedTickCallback (internal/process/next_tick.js:138:11)
Nov 09 09:33:48 volumio volumio[7324]: at process._tickCallback (internal/process/next_tick.js:180:9)
Nov 09 09:33:48 volumio volumio[7324]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Nov 09 09:33:48 volumio kernel: in count:402648, out count:402652
Nov 09 09:33:48 volumio kernel: add cnt:237, mpll1_rate:48999976 mpll2 rate:48999463
Nov 09 09:33:48 volumio sudo[7443]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2023-11-09 09:32
Nov 09 09:33:48 volumio sudo[7443]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 09 09:33:49 volumio sudo[7443]: pam_unix(sudo:session): session closed for user root
Nov 09 09:33:49 volumio kernel: in count:402653, out count:402651
Nov 09 09:33:49 volumio kernel: reduce cnt:211, mpll1_rate:48999976, mpll2 rate:49000050
Nov 09 09:33:49 volumio systemd[1]: volumio.service: main process exited, code=exited, status=1/FAILURE
Nov 09 09:33:49 volumio systemd[1]: Unit volumio.service entered failed state.
Nov 09 09:33:49 volumio systemd[1]: Starting dynamicswap service...
Nov 09 09:33:49 volumio systemd[1]: Started dynamicswap service.
Nov 09 09:33:49 volumio systemd[1]: volumio.service holdoff time over, scheduling restart.
Nov 09 09:33:49 volumio systemd[1]: Starting dynamicswap service...
Nov 09 09:33:49 volumio systemd[1]: Started dynamicswap service.
Nov 09 09:33:49 volumio systemd[1]: Stopping Volumio Backend Module...
Nov 09 09:33:49 volumio systemd[1]: Starting Volumio Backend Module...
Nov 09 09:33:49 volumio systemd[1]: Started Volumio Backend Module.
Nov 09 09:33:49 volumio kernel: in count:402647, out count:402651
Nov 09 09:33:49 volumio kernel: add cnt:238, mpll1_rate:48999976 mpll2 rate:48999390
Nov 09 09:33:49 volumio wpa_supplicant[6984]: wlan0: CTRL-EVENT-ASSOC-REJECT bssid=30:c5:0f:a3:58:f4 status_code=1
Nov 09 09:33:49 volumio wpa_supplicant[6984]: wlan0: CTRL-EVENT-SSID-TEMP-DISABLED id=0 ssid="Base_Linux" auth_failures=2 duration=23 reason=CONN_FAILED
Nov 09 09:33:49 volumio kernel: connect failed event=0 e->status 4 e->reason 1
Nov 09 09:33:49 volumio kernel: CFG80211-ERROR) wl_bss_connect_done : Report connect result - connection failed
Nov 09 09:33:49 volumio kernel: in count:402652, out count:402651
Nov 09 09:33:49 volumio kernel: reduce cnt:212, mpll1_rate:48999976, mpll2 rate:48999976
Nov 09 09:33:50 volumio kernel: in count:402647, out count:402652
Nov 09 09:33:50 volumio kernel: add cnt:239, mpll1_rate:48999976 mpll2 rate:48999317
Nov 09 09:33:50 volumio volumio[7468]: info: -------------------------------------------
Nov 09 09:33:50 volumio volumio[7468]: info: ----- Volumio2 ----
Nov 09 09:33:50 volumio volumio[7468]: info: -------------------------------------------
Nov 09 09:33:50 volumio volumio[7468]: info: ----- System startup ----
Nov 09 09:33:50 volumio volumio[7468]: info: -------------------------------------------
Nov 09 09:33:50 volumio volumio[7468]: info: MYVOLUMIO Environment detected
Nov 09 09:33:50 volumio kernel: in count:402651, out count:402651
Nov 09 09:33:50 volumio volumio[7468]: info: Plugin folders cleanup
Nov 09 09:33:50 volumio volumio[7468]: info: Scanning into folder /volumio/app/plugins/
Nov 09 09:33:50 volumio volumio[7468]: info: Scanning category audio_interface
Nov 09 09:33:50 volumio volumio[7468]: info: Scanning category miscellanea
Nov 09 09:33:50 volumio volumio[7468]: info: Scanning category music_service
Nov 09 09:33:50 volumio volumio[7468]: info: Scanning category plugins.json
Nov 09 09:33:50 volumio volumio[7468]: info: Scanning category system_controller
Nov 09 09:33:50 volumio volumio[7468]: info: Scanning category user_interface
Nov 09 09:33:50 volumio volumio[7468]: info: Scanning into folder /data/plugins/
Nov 09 09:33:50 volumio volumio[7468]: info: Scanning category accessory
Nov 09 09:33:50 volumio volumio[7468]: info: Scanning category audio_interface
Nov 09 09:33:50 volumio volumio[7468]: info: Scanning category music_service
Nov 09 09:33:50 volumio volumio[7468]: info: Scanning category system_controller
Nov 09 09:33:50 volumio volumio[7468]: info: Plugin folders cleanup completed
Nov 09 09:33:50 volumio volumio[7468]: info: -------------------------------------------
Nov 09 09:33:50 volumio volumio[7468]: info: ----- Core plugins startup ----
Nov 09 09:33:50 volumio volumio[7468]: info: -------------------------------------------
Nov 09 09:33:50 volumio volumio[7468]: info: Loading plugins from folder /volumio/app/plugins/
Nov 09 09:33:50 volumio volumio[7468]: info: Adding plugin upnp to MyMusic Plugins
Nov 09 09:33:50 volumio volumio[7468]: info: Adding plugin airplay_emulation to MyMusic Plugins
Nov 09 09:33:50 volumio volumio[7468]: info: Adding plugin upnp_browser to MyMusic Plugins
Nov 09 09:33:50 volumio volumio[7468]: info: Loading plugins from folder /data/plugins/
Nov 09 09:33:50 volumio volumio[7468]: info: Loading plugin "system"...
Nov 09 09:33:50 volumio volumio[7468]: info: Loading plugin "appearance"...
Nov 09 09:33:51 volumio kernel: in count:805304, out count:805304
Nov 09 09:33:51 volumio volumio[7468]: info: Loading plugin "network"...
Nov 09 09:33:51 volumio volumio[7468]: info: Loading plugin "services"...
Nov 09 09:33:51 volumio volumio[7468]: info: Loading plugin "alsa_controller"...
Nov 09 09:33:51 volumio volumio[7468]: info: Loading plugin "wizard"...
Nov 09 09:33:51 volumio volumio[7468]: info: Loading plugin "volumio_command_line_client"...
Nov 09 09:33:51 volumio volumio[7468]: info: Plugin upnp is not enabled
Nov 09 09:33:51 volumio volumio[7468]: info: Loading plugin "my_music"...
Nov 09 09:33:51 volumio volumio[7468]: info: Loading plugin "mpd"...
Nov 09 09:33:51 volumio kernel: in count:1207956, out count:1207956
Nov 09 09:33:51 volumio volumio[7468]: info: Plugin upnp_browser is not enabled
Nov 09 09:33:51 volumio volumio[7468]: info: Loading plugin "networkfs"...
Nov 09 09:33:51 volumio volumio[7468]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Nov 09 09:33:51 volumio volumio[7468]: info: Loading plugin "alarm-clock"...
Nov 09 09:33:51 volumio sudo[7493]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t nfs -o ro,soft,noauto,ro lena.baselinux.net:/DATA/mmedia/music /mnt/NAS/lena_music
Nov 09 09:33:51 volumio sudo[7493]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 09 09:33:51 volumio kernel: in count:1610608, out count:1610609
Nov 09 09:33:51 volumio kernel: add cnt:240, mpll1_rate:48999976 mpll2 rate:48999903
Nov 09 09:33:51 volumio sudo[7493]: pam_unix(sudo:session): session closed for user root
Nov 09 09:33:51 volumio volumio[7468]: info: Plugin airplay_emulation is not enabled
Nov 09 09:33:51 volumio volumio[7468]: info: Loading plugin "last_100"...
Nov 09 09:33:51 volumio volumio[7468]: info: Loading plugin "webradio"...
Nov 09 09:33:51 volumio volumio[7468]: info: Loading plugin "i2s_dacs"...
Nov 09 09:33:51 volumio volumio[7468]: info: I2S DAC not set, start Auto-detection
Nov 09 09:33:51 volumio volumio[7468]: info: Loading plugin "volumiodiscovery"...
Nov 09 09:33:51 volumio volumio[7468]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Nov 09 09:33:51 volumio node[7468]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Nov 09 09:33:51 volumio node[7468]: *** WARNING *** Please fix your application to use the native API of Avahi!
Nov 09 09:33:51 volumio node[7468]: *** WARNING *** For more information see
Nov 09 09:33:51 volumio node[7468]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Nov 09 09:33:51 volumio node[7468]: *** WARNING *** Please fix your application to use the native API of Avahi!
Nov 09 09:33:51 volumio node[7468]: *** WARNING *** For more information see
Nov 09 09:33:51 volumio volumio[7468]: *** WARNING *** Please fix your application to use the native API of Avahi!
Nov 09 09:33:51 volumio volumio[7468]: *** WARNING *** For more information see
Nov 09 09:33:51 volumio volumio[7468]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Nov 09 09:33:51 volumio volumio[7468]: *** WARNING *** Please fix your application to use the native API of Avahi!
Nov 09 09:33:51 volumio volumio[7468]: *** WARNING *** For more information see
Nov 09 09:33:51 volumio volumio[7468]: info: Applying required configuration parameters for plugin volumiodiscovery
Nov 09 09:33:51 volumio volumio[7468]: Discovery: StartAdv! undefined
Nov 09 09:33:51 volumio volumio[7468]: Discovery: Started advertising... Volumio - undefined
Nov 09 09:33:52 volumio volumio[7468]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Nov 09 09:33:52 volumio volumio[7468]: info: Plugin volsimpleequal is not enabled
Nov 09 09:33:52 volumio volumio[7468]: info: Loading plugin "bandcamp"...
Nov 09 09:33:52 volumio volumio[7468]: info: Loading plugin "youtube2"...
Nov 09 09:33:52 volumio kernel: in count:402656, out count:402651
Nov 09 09:33:52 volumio kernel: reduce cnt:213, mpll1_rate:48999976, mpll2 rate:49000489
Nov 09 09:33:52 volumio kernel: in count:402650, out count:402652
Nov 09 09:33:52 volumio kernel: add cnt:241, mpll1_rate:48999976 mpll2 rate:48999830
Nov 09 09:33:53 volumio kernel: in count:402655, out count:402651
Nov 09 09:33:53 volumio kernel: reduce cnt:214, mpll1_rate:48999976, mpll2 rate:49000416
Nov 09 09:33:53 volumio kernel: in count:402650, out count:402651
Nov 09 09:33:53 volumio kernel: add cnt:242, mpll1_rate:48999976 mpll2 rate:48999756
Nov 09 09:33:53 volumio kernel: in count:402655, out count:402652
Nov 09 09:33:53 volumio kernel: reduce cnt:215, mpll1_rate:48999976, mpll2 rate:49000343
Nov 09 09:33:54 volumio volumio[7468]: info: Loading plugin "outputs"...
Nov 09 09:33:54 volumio volumio[7468]: info: Loading plugin "albumart"...
Nov 09 09:33:54 volumio kernel: in count:402649, out count:402651
Nov 09 09:33:54 volumio kernel: add cnt:243, mpll1_rate:48999976 mpll2 rate:48999683
Nov 09 09:33:54 volumio volumio[7468]: info: Plugin example_plugin is not enabled
Nov 09 09:33:54 volumio volumio[7468]: info: Loading plugin "inputs"...
Nov 09 09:33:54 volumio volumio[7468]: info: Loading plugin "updater_comm"...
Nov 09 09:33:54 volumio volumio[7468]: info: Plugin mpdemulation is not enabled
Nov 09 09:33:54 volumio volumio[7468]: info: Loading plugin "rest_api"...
Nov 09 09:33:54 volumio systemd[1]: Starting Wifireconnect service...
Nov 09 09:33:54 volumio systemd[1]: Started Wifireconnect service.
Nov 09 09:33:54 volumio volumio[7525]: connect: Network is unreachable
Nov 09 09:33:54 volumio systemd[1]: Stopping Wireless Services...
Nov 09 09:33:54 volumio volumio[7468]: info: Loading plugin "websocket"...
Nov 09 09:33:54 volumio volumio[7468]: info: Loading plugin "ir_controller"...
Nov 09 09:33:54 volumio volumio[7468]: Forking 5 albumart workers
Nov 09 09:33:54 volumio systemd[1]: Starting Wireless Services...
Nov 09 09:33:54 volumio volumio[7468]: info: Applying required configuration parameters for plugin ir_controller
Nov 09 09:33:54 volumio sudo[7533]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 set power_save off
Nov 09 09:33:54 volumio sudo[7533]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 09 09:33:54 volumio sudo[7533]: pam_unix(sudo:session): session closed for user root
Nov 09 09:33:54 volumio volumio[7468]: info: Loading plugin "radio_paradise"...
Nov 09 09:33:54 volumio kernel: in count:402654, out count:402651
Nov 09 09:33:54 volumio kernel: reduce cnt:216, mpll1_rate:48999976, mpll2 rate:49000269
Nov 09 09:33:54 volumio volumio[7468]: info: Applying required configuration parameters for plugin radio_paradise
Nov 09 09:33:54 volumio volumio[7468]: info: [1699522434760] [RadioParadise] API delay: 5
Nov 09 09:33:54 volumio volumio[7468]: info: Loading plugin "backup_restore"...
Nov 09 09:33:54 volumio wireless.js[7554]: Cleaning previous...
Nov 09 09:33:54 volumio systemd[1]: Stopped hotspot.service.
Nov 09 09:33:54 volumio volumio[7468]: info: Loading plugin "wifireconnect"...
Nov 09 09:33:54 volumio sudo[7575]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0
Nov 09 09:33:54 volumio sudo[7575]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 09 09:33:54 volumio sudo[7575]: pam_unix(sudo:session): session closed for user root
Nov 09 09:33:54 volumio sudo[7577]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down
Nov 09 09:33:54 volumio sudo[7577]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 09 09:33:54 volumio kernel: dhd_stop: Enter ffffffc0971fb000
Nov 09 09:33:54 volumio kernel: CFGP2P-ERROR) wl_cfgp2p_disable_discovery : do nothing, not initialized
Nov 09 09:33:54 volumio kernel: CFGP2P-ERROR) wl_cfgp2p_deinit_priv : In
Nov 09 09:33:54 volumio kernel: dhd_tcpack_suppress_set: TCP ACK Suppress mode 1 -> mode 0
Nov 09 09:33:54 volumio kernel: wl_android_wifi_off in 1
Nov 09 09:33:54 volumio kernel: wl_android_wifi_off in 2: g_wifi_on=1, on_failure=1
Nov 09 09:33:54 volumio kernel: dhd_dbg_detach_pkt_monitor, 2204
Nov 09 09:33:54 volumio kernel: dhd_bus_devreset: == Power OFF ==
Nov 09 09:33:54 volumio kernel: bcmsdh_oob_intr_unregister: Enter
Nov 09 09:33:54 volumio kernel: dhd_txglom_enable: enable 0
Nov 09 09:33:54 volumio kernel: dhd_conf_set_txglom_params: txglom_mode=copy
Nov 09 09:33:54 volumio kernel: dhd_conf_set_txglom_params: txglomsize=0, deferred_tx_len=0
Nov 09 09:33:54 volumio kernel: dhd_conf_set_txglom_params: txinrx_thres=128, dhd_txminmax=-1
Nov 09 09:33:54 volumio kernel: dhd_conf_set_txglom_params: tx_max_offset=0, txctl_tmo_fix=300
Nov 09 09:33:54 volumio kernel: dhd_bus_devreset: WLAN OFF DONE
Nov 09 09:33:54 volumio kernel: wifi_platform_set_power = 0
Nov 09 09:33:54 volumio kernel: ======== PULL WL_REG_ON(-1) LOW! ========
Nov 09 09:33:54 volumio kernel: aml_wifi wifi: [extern_wifi_set_enable] WIFI Disable! 482
Nov 09 09:33:55 volumio volumio[7468]: Starting albumart workers
Nov 09 09:33:55 volumio kernel: in count:402649, out count:402652
Nov 09 09:33:55 volumio kernel: add cnt:244, mpll1_rate:48999976 mpll2 rate:48999610
Nov 09 09:33:55 volumio volumio[7468]: info: ___________ START PLUGINS ___________
Nov 09 09:33:55 volumio volumio[7468]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Nov 09 09:33:55 volumio volumio[7468]: info: [1699522435090] CoreMusicLibrary::Adding element Last_100
Nov 09 09:33:55 volumio volumio[7468]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Nov 09 09:33:55 volumio volumio[7468]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Nov 09 09:33:55 volumio volumio[7468]: info: [1699522435106] CoreMusicLibrary::Adding element Webradio
Nov 09 09:33:55 volumio volumio[7468]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Nov 09 09:33:55 volumio volumio[7468]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Nov 09 09:33:55 volumio volumio[7468]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Nov 09 09:33:55 volumio volumio[7468]: info: [1699522435121] CoreMusicLibrary::Adding element Bandcamp Discover
Nov 09 09:33:55 volumio volumio[7468]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Nov 09 09:33:55 volumio volumio[7468]: info: [youtube2-auth] Starting auth flow...
Nov 09 09:33:55 volumio volumio[7468]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Nov 09 09:33:55 volumio volumio[7468]: info: [1699522435173] CoreMusicLibrary::Adding element YouTube2
Nov 09 09:33:55 volumio volumio[7468]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Nov 09 09:33:55 volumio volumio[7468]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Nov 09 09:33:55 volumio volumio[7468]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Nov 09 09:33:55 volumio volumio[7468]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Nov 09 09:33:55 volumio volumio[7468]: info: [1699522435223] CoreMusicLibrary::Adding element Radio Paradise
Nov 09 09:33:55 volumio volumio[7468]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Nov 09 09:33:55 volumio volumio[7468]: info: -------------------------------------------
Nov 09 09:33:55 volumio volumio[7468]: info: ----- MyVolumio plugins startup ----
Nov 09 09:33:55 volumio volumio[7468]: info: -------------------------------------------
Nov 09 09:33:55 volumio volumio[7468]: info: [MyVolumio PluginManager] Fetching plans data....
Nov 09 09:33:55 volumio volumio[7468]: info: Loading i18n strings for locale es
Nov 09 09:33:55 volumio kernel: wl_android_wifi_off out
Nov 09 09:33:55 volumio kernel: wl_ext_iapsta_dettach_netdev: Enter
Nov 09 09:33:55 volumio kernel: dhd_stop: Exit
Nov 09 09:33:55 volumio sudo[7577]: pam_unix(sudo:session): session closed for user root
Nov 09 09:33:55 volumio sudo[7584]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start wifireconnect.timer
Nov 09 09:33:55 volumio sudo[7584]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 09 09:33:55 volumio sudo[7581]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/lirc/hardware.conf
Nov 09 09:33:55 volumio sudo[7581]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 09 09:33:55 volumio sudo[7581]: pam_unix(sudo:session): session closed for user root
Nov 09 09:33:55 volumio sudo[7582]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /etc/lirc/hardware.conf /etc/lirc/lircd.conf /etc/lirc/lircmd.conf /etc/lirc/lircrc
Nov 09 09:33:55 volumio sudo[7582]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 09 09:33:55 volumio volumio[7468]: Starting albumart workers
Nov 09 09:33:55 volumio systemd[1]: Started Runs wifireconnect every 1min.
Nov 09 09:33:55 volumio volumio[7468]: Starting albumart workers
Nov 09 09:33:55 volumio sudo[7582]: pam_unix(sudo:session): session closed for user root
Nov 09 09:33:55 volumio sudo[7584]: pam_unix(sudo:session): session closed for user root
Nov 09 09:33:55 volumio volumio[7468]: Updating browse sources language
Nov 09 09:33:55 volumio volumio[7468]: Cannot find translation for sourceBandcamp Discover
Nov 09 09:33:55 volumio volumio[7468]: Cannot find translation for sourceYouTube2
Nov 09 09:33:55 volumio volumio[7468]: Cannot find translation for sourceRadio Paradise
Nov 09 09:33:55 volumio volumio[7468]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Nov 09 09:33:55 volumio volumio[7468]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Nov 09 09:33:55 volumio volumio[7468]: info: CoreCommandRouter::initPlayerControls
Nov 09 09:33:55 volumio volumio[7468]: Starting albumart workers
Nov 09 09:33:55 volumio volumio[7468]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 09 09:33:55 volumio volumio[7468]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards
Nov 09 09:33:55 volumio volumio[7468]: Starting albumart workers
Nov 09 09:33:55 volumio wireless.js[7554]: Stopped aP
Nov 09 09:33:55 volumio wireless.js[7554]: Start wireless flow
Nov 09 09:33:55 volumio wireless.js[7554]: Stopped hotspot (if there)..
Nov 09 09:33:55 volumio volumio[7468]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 09 09:33:55 volumio kernel: in count:402654, out count:402651
Nov 09 09:33:55 volumio kernel: reduce cnt:217, mpll1_rate:48999976, mpll2 rate:49000196
Nov 09 09:33:55 volumio volumio[7468]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 09 09:33:55 volumio volumio[7468]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 09 09:33:55 volumio volumio[7468]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 09 09:33:55 volumio volumio[7468]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 09 09:33:55 volumio volumio[7468]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Nov 09 09:33:55 volumio volumio[7468]: info: BOOT COMPLETED
Nov 09 09:33:55 volumio volumio[7468]: [Metrics] CommandRouter: 5s 150.11ms
Nov 09 09:33:55 volumio volumio[7468]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Nov 09 09:33:55 volumio sudo[7599]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0
Nov 09 09:33:55 volumio sudo[7599]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 09 09:33:55 volumio sudo[7599]: pam_unix(sudo:session): session closed for user root
Nov 09 09:33:55 volumio sudo[7602]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down
Nov 09 09:33:55 volumio sudo[7602]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 09 09:33:55 volumio sudo[7602]: pam_unix(sudo:session): session closed for user root
Nov 09 09:33:55 volumio volumio[7468]: ALSA lib pcm_hw.c:1713:(_snd_pcm_hw_open) Invalid value for card
Nov 09 09:33:55 volumio volumio[7468]: aplay: main:722: audio open error: No such file or directory
Nov 09 09:33:55 volumio volumio[7468]: Cannot play startup sound
Nov 09 09:33:55 volumio volumio[7468]: info: CoreCommandRouter::Close All Modals sent
Nov 09 09:33:55 volumio volumio[7468]: info: CoreCommandRouter::Close All Modals sent
Nov 09 09:33:55 volumio volumio[7468]: Express server listening on port 3000
Nov 09 09:33:55 volumio wireless.js[7554]: DHCP IP
Nov 09 09:33:55 volumio volumio[7468]: [Metrics] WebUI: 5s 410.24ms
Nov 09 09:33:55 volumio wpa_supplicant[7610]: Successfully initialized wpa_supplicant
Nov 09 09:33:55 volumio wireless.js[7554]: Start ap
Nov 09 09:33:55 volumio kernel: dhd_open: Enter ffffffc0971fb000
Nov 09 09:33:55 volumio kernel: dhd_open : no mutex held. set lock
Nov 09 09:33:55 volumio kernel:
Dongle Host Driver, version 1.579.77.41.10 (r)
Nov 09 09:33:55 volumio kernel: wl_ext_iapsta_attach_netdev: ifidx=0, bssidx=0
Nov 09 09:33:55 volumio kernel: wl_android_wifi_on in 1
Nov 09 09:33:55 volumio kernel: wl_android_wifi_on in 2: g_wifi_on=0
Nov 09 09:33:55 volumio kernel: wifi_platform_set_power = 1
Nov 09 09:33:55 volumio kernel: ======== PULL WL_REG_ON(-1) HIGH! ========
Nov 09 09:33:55 volumio kernel: aml_wifi wifi: [extern_wifi_set_enable] WIFI Disable! 482
Nov 09 09:33:55 volumio volumio[7468]: Volumio Calling Home
Nov 09 09:33:55 volumio volumio[7468]: info: CoreStateMachine::resetVolumioState
Nov 09 09:33:55 volumio volumio[7468]: info: CoreStateMachine::getcurrentVolume
Nov 09 09:33:55 volumio volumio[7468]: info: CoreCommandRouter::volumioRetrievevolume
Nov 09 09:33:55 volumio volumio[7468]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt'
Nov 09 09:33:55 volumio volumio[7468]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Nov 09 09:33:55 volumio volumio[7468]: ReferenceError: deferred is not defined
Nov 09 09:33:55 volumio volumio[7468]: at ClientRequest.req.on (/data/plugins/music_service/youtube2/lib/core/gapi/auth.js:155:13)
Nov 09 09:33:55 volumio volumio[7468]: at emitOne (events.js:116:13)
Nov 09 09:33:55 volumio volumio[7468]: at ClientRequest.emit (events.js:211:7)
Nov 09 09:33:55 volumio volumio[7468]: at TLSSocket.socketErrorListener (_http_client.js:387:9)
Nov 09 09:33:55 volumio volumio[7468]: at emitOne (events.js:116:13)
Nov 09 09:33:55 volumio volumio[7468]: at TLSSocket.emit (events.js:211:7)
Nov 09 09:33:55 volumio volumio[7468]: at emitErrorNT (internal/streams/destroy.js:64:8)
Nov 09 09:33:55 volumio volumio[7468]: at _combinedTickCallback (internal/process/next_tick.js:138:11)
Nov 09 09:33:55 volumio volumio[7468]: at process._tickCallback (internal/process/next_tick.js:180:9)
Nov 09 09:33:55 volumio volumio[7468]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Nov 09 09:33:55 volumio kernel: aml_wifi wifi: [extern_wifi_set_enable] WIFI Enable! 482
Nov 09 09:33:55 volumio kernel: in count:402648, out count:402652
Nov 09 09:33:55 volumio kernel: add cnt:245, mpll1_rate:48999976 mpll2 rate:48999537
Nov 09 09:33:56 volumio kernel: sdio_reset_comm():
Nov 09 09:33:56 volumio kernel: meson-mmc: actual_clock :400000, HHI_nand: 0x80
Nov 09 09:33:56 volumio kernel: meson-mmc: [meson_mmc_clk_set_rate_v3] after clock: 0x1000023c
Nov 09 09:33:56 volumio kernel: in count:402652, out count:402651
Nov 09 09:33:56 volumio kernel: reduce cnt:218, mpll1_rate:48999976, mpll2 rate:49000123
Nov 09 09:33:56 volumio kernel: meson-mmc: actual_clock :0, HHI_nand: 0x80
Nov 09 09:33:56 volumio kernel: meson-mmc: [meson_mmc_clk_set_rate_v3] after clock: 0x1000023c
Nov 09 09:33:56 volumio kernel: meson-mmc: actual_clock :400000, HHI_nand: 0x80
Nov 09 09:33:56 volumio kernel: meson-mmc: [meson_mmc_clk_set_rate_v3] after clock: 0x1000023c
Nov 09 09:33:56 volumio kernel: sdio: queuing unknown CIS tuple 0x80 (2 bytes)
Nov 09 09:33:56 volumio kernel: sdio: queuing unknown CIS tuple 0x80 (3 bytes)
Nov 09 09:33:56 volumio kernel: sdio: queuing unknown CIS tuple 0x80 (3 bytes)
Nov 09 09:33:56 volumio kernel: sdio: queuing unknown CIS tuple 0x80 (7 bytes)
Nov 09 09:33:56 volumio kernel: sdio: queuing unknown CIS tuple 0x81 (9 bytes)
Nov 09 09:33:56 volumio kernel: meson-aml-mmc ffe03000.sdio: divider requested rate 200000000 != actual rate 199999997: ret=0
Nov 09 09:33:56 volumio kernel: meson-mmc: actual_clock :199999997, HHI_nand: 0x80
Nov 09 09:33:56 volumio kernel: meson-mmc: [meson_mmc_clk_set_rate_v3] after clock: 0x10000245
Nov 09 09:33:56 volumio kernel: meson-mmc: Data 1 aligned delay is 0
Nov 09 09:33:56 volumio kernel: meson-mmc: sdio: clk 199999997 tuning start
Nov 09 09:33:56 volumio kernel: meson-mmc: sdio: rx_tuning_result[0] = 40
Nov 09 09:33:56 volumio kernel: meson-mmc: sdio: rx_tuning_result[1] = 40
Nov 09 09:33:56 volumio kernel: meson-mmc: sdio: rx_tuning_result[2] = 40
Nov 09 09:33:56 volumio kernel: meson-mmc: sdio: rx_tuning_result[3] = 40
Nov 09 09:33:56 volumio kernel: meson-mmc: sdio: rx_tuning_result[4] = 40
Nov 09 09:33:56 volumio kernel: meson-mmc: _aml_sd_emmc_execute_tuning() d1_dly 0, window start 0, size 5
Nov 09 09:33:56 volumio kernel: meson-mmc: sdio: clk 199999997 tuning start
Nov 09 09:33:56 volumio kernel: meson-mmc: sdio: rx_tuning_result[0] = 40
Nov 09 09:33:56 volumio kernel: meson-mmc: sdio: rx_tuning_result[1] = 40
Nov 09 09:33:56 volumio kernel: meson-mmc: sdio: rx_tuning_result[2] = 40
Nov 09 09:33:56 volumio kernel: meson-mmc: sdio: rx_tuning_result[3] = 40
Nov 09 09:33:56 volumio kernel: meson-mmc: sdio: rx_tuning_result[4] = 40
Nov 09 09:33:56 volumio kernel: meson-mmc: _aml_sd_emmc_execute_tuning() d1_dly 1, window start 0, size 5
Nov 09 09:33:56 volumio kernel: meson-mmc: sdio: clk 199999997 tuning start
Nov 09 09:33:56 volumio kernel: meson-mmc: sdio: rx_tuning_result[0] = 40
Nov 09 09:33:56 volumio kernel: meson-mmc: sdio: rx_tuning_result[1] = 40
Nov 09 09:33:56 volumio kernel: meson-mmc: sdio: rx_tuning_result[2] = 40
Nov 09 09:33:56 volumio kernel: meson-mmc: sdio: rx_tuning_result[3] = 40
Nov 09 09:33:56 volumio kernel: meson-mmc: sdio: rx_tuning_result[4] = 40
Nov 09 09:33:56 volumio kernel: meson-mmc: _aml_sd_emmc_execute_tuning() d1_dly 2, window start 0, size 5
Nov 09 09:33:56 volumio kernel: meson-mmc: sdio: clk 199999997 tuning start
Nov 09 09:33:56 volumio kernel: meson-mmc: sdio: rx_tuning_result[0] = 40
Nov 09 09:33:56 volumio kernel: meson-mmc: sdio: rx_tuning_result[1] = 40
Nov 09 09:33:56 volumio kernel: meson-mmc: sdio: rx_tuning_result[2] = 40
Nov 09 09:33:56 volumio kernel: meson-mmc: sdio: rx_tuning_result[3] = 40
Nov 09 09:33:56 volumio kernel: meson-mmc: sdio: rx_tuning_result[4] = 40
Nov 09 09:33:56 volumio kernel: meson-mmc: _aml_sd_emmc_execute_tuning() d1_dly 3, window start 0, size 5
Nov 09 09:33:56 volumio kernel: meson-mmc: sdio: clk 199999997 tuning start
Nov 09 09:33:56 volumio kernel: meson-mmc: sdio: rx_tuning_result[0] = 40
Nov 09 09:33:56 volumio kernel: meson-mmc: sdio: rx_tuning_result[1] = 40
Nov 09 09:33:56 volumio kernel: meson-mmc: sdio: rx_tuning_result[2] = 40
Nov 09 09:33:56 volumio kernel: meson-mmc: sdio: rx_tuning_result[3] = 40
Nov 09 09:33:56 volumio kernel: meson-mmc: sdio: rx_tuning_result[4] = 40
Nov 09 09:33:56 volumio kernel: meson-mmc: _aml_sd_emmc_execute_tuning() d1_dly 4, window start 0, size 5
Nov 09 09:33:56 volumio kernel: meson-mmc: sdio: clk 199999997 tuning start
Nov 09 09:33:56 volumio kernel: meson-mmc: sdio: rx_tuning_result[0] = 40
Nov 09 09:33:56 volumio kernel: meson-mmc: sdio: rx_tuning_result[1] = 40
Nov 09 09:33:56 volumio kernel: meson-mmc: sdio: rx_tuning_result[2] = 40
Nov 09 09:33:56 volumio kernel: meson-mmc: sdio: rx_tuning_result[3] = 40
Nov 09 09:33:56 volumio kernel: meson-mmc: sdio: rx_tuning_result[4] = 40
Nov 09 09:33:56 volumio kernel: meson-mmc: _aml_sd_emmc_execute_tuning() d1_dly 5, window start 0, size 5
Nov 09 09:33:56 volumio kernel: meson-mmc: sdio: clk 199999997 tuning start
Nov 09 09:33:56 volumio kernel: meson-mmc: sdio: rx_tuning_result[0] = 40
Nov 09 09:33:56 volumio kernel: meson-mmc: sdio: rx_tuning_result[1] = 40
Nov 09 09:33:56 volumio kernel: meson-mmc: sdio: rx_tuning_result[2] = 40
Nov 09 09:33:56 volumio kernel: meson-mmc: sdio: rx_tuning_result[3] = 40
Nov 09 09:33:56 volumio kernel: meson-mmc: sdio: rx_tuning_result[4] = 40
Nov 09 09:33:56 volumio kernel: meson-mmc: _aml_sd_emmc_execute_tuning() d1_dly 6, window start 0, size 5
Nov 09 09:33:56 volumio kernel: meson-mmc: sdio: clk 199999997 tuning start
Nov 09 09:33:56 volumio kernel: meson-mmc: sdio: rx_tuning_result[0] = 40
Nov 09 09:33:56 volumio kernel: meson-mmc: sdio: rx_tuning_result[1] = 40
Nov 09 09:33:56 volumio kernel: meson-mmc: sdio: rx_tuning_result[2] = 40
Nov 09 09:33:56 volumio kernel: meson-mmc: sdio: rx_tuning_result[3] = 40
Nov 09 09:33:56 volumio kernel: meson-mmc: sdio: rx_tuning_result[4] = 40
Nov 09 09:33:56 volumio kernel: meson-mmc: _aml_sd_emmc_execute_tuning() d1_dly 7, window start 0, size 5
Nov 09 09:33:56 volumio kernel: meson-mmc: sdio: clk 199999997 tuning start
Nov 09 09:33:56 volumio kernel: meson-mmc: sdio: rx_tuning_result[0] = 40
Nov 09 09:33:56 volumio kernel: meson-mmc: sdio: rx_tuning_result[1] = 40
Nov 09 09:33:56 volumio kernel: meson-mmc: sdio: rx_tuning_result[2] = 40
Nov 09 09:33:56 volumio kernel: meson-mmc: sdio: rx_tuning_result[3] = 40
Nov 09 09:33:56 volumio kernel: meson-mmc: sdio: rx_tuning_result[4] = 40
Nov 09 09:33:56 volumio kernel: meson-mmc: _aml_sd_emmc_execute_tuning() d1_dly 8, window start 0, size 5
Nov 09 09:33:56 volumio kernel: meson-mmc: sdio: clk 199999997 tuning start
Nov 09 09:33:56 volumio kernel: meson-mmc: sdio: rx_tuning_result[0] = 40
Nov 09 09:33:56 volumio kernel: meson-mmc: sdio: rx_tuning_result[1] = 40
Nov 09 09:33:56 volumio kernel: meson-mmc: sdio: rx_tuning_result[2] = 40
Nov 09 09:33:56 volumio kernel: meson-mmc: sdio: rx_tuning_result[3] = 40
Nov 09 09:33:56 volumio kernel: meson-mmc: sdio: rx_tuning_result[4] = 40
Nov 09 09:33:56 volumio kernel: meson-mmc: _aml_sd_emmc_execute_tuning() d1_dly 9, window start 0, size 5
Nov 09 09:33:56 volumio kernel: meson-mmc: sdio: clk 199999997 tuning start
Nov 09 09:33:56 volumio kernel: meson-mmc: sdio: rx_tuning_result[0] = 40
Nov 09 09:33:56 volumio kernel: meson-mmc: Tuning transfer error: nmatch=0 tuning_err:0xffffffac
Nov 09 09:33:56 volumio kernel: meson-mmc: sdio: rx_tuning_result[2] = 40
Nov 09 09:33:56 volumio kernel: meson-mmc: sdio: rx_tuning_result[3] = 40
Nov 09 09:33:56 volumio kernel: meson-mmc: sdio: rx_tuning_result[4] = 40
Nov 09 09:33:56 volumio kernel: meson-mmc: sdio: best_win_start =2, best_win_size =4
Nov 09 09:33:56 volumio kernel: meson-mmc: sdio: sd_emmc_regs->gclock=0x10000245,sd_emmc_regs->gadjust=0x42000
Nov 09 09:33:56 volumio kernel: meson-mmc: delay1:0x0, delay2:0x0
Nov 09 09:33:56 volumio kernel: sdioh_start: set sd_f2_blocksize 256
Nov 09 09:33:56 volumio kernel:
dhd_bus_devreset: == WLAN ON ==
Nov 09 09:33:56 volumio kernel: F1 signature read @0x18000000=0x17294359
Nov 09 09:33:56 volumio kernel: F1 signature OK, socitype:0x1 chip:0x4359 rev:0x9 pkg:0x2
Nov 09 09:33:56 volumio kernel: DHD: dongle ram size is set to 917504(orig 917504) at 0x160000
Nov 09 09:33:56 volumio kernel: dhd_bus_set_default_min_res_mask: Unhandled chip id
Nov 09 09:33:56 volumio kernel: dhd_os_open_image: /lib/firmware/brcm/config.txt (184 bytes) open success
Nov 09 09:33:56 volumio kernel: dhd_conf_read_sdio_params: dhd_slpauto = 0
Nov 09 09:33:56 volumio kernel: dhd_conf_read_others: ccode = CN
Nov 09 09:33:56 volumio kernel: dhd_conf_read_others: regrev = 38
Nov 09 09:33:56 volumio kernel: dhd_conf_read_nv_by_chip: nv_by_chip_count=5
Nov 09 09:33:56 volumio kernel: dhd_conf_read_nv_by_chip: chip=0xa9a6, chiprev=0, name=nvram_ap6212.txt
Nov 09 09:33:56 volumio kernel: dhd_conf_read_nv_by_chip: chip=0xa9a6, chiprev=1, name=nvram_ap6212a.txt
Nov 09 09:33:56 volumio kernel: dhd_conf_read_nv_by_chip: chip=0x4345, chiprev=6, name=nvram_ap6255.txt
Nov 09 09:33:56 volumio kernel: dhd_conf_read_nv_by_chip: chip=0x4354, chiprev=2, name=nvram_ap6356.txt
Nov 09 09:33:56 volumio kernel: dhd_conf_read_nv_by_chip: chip=0x4359, chiprev=9, name=nvram_ap6359sa.txt
Nov 09 09:33:56 volumio kernel: Final fw_path=/lib/firmware/brcm/fw_bcm4359c0_ag.bin
Nov 09 09:33:56 volumio kernel: Final nv_path=/lib/firmware/brcm/nvram_ap6359sa.txt
Nov 09 09:33:56 volumio kernel: Final clm_path=/lib/firmware/brcm/clm.blob
Nov 09 09:33:56 volumio kernel: Final conf_path=/lib/firmware/brcm/config.txt
Nov 09 09:33:56 volumio kernel: dhd_os_open_image: /lib/firmware/brcm/fw_bcm4359c0_ag.bin (595758 bytes) open success
Nov 09 09:33:56 volumio wireless.js[7554]: trying...
Nov 09 09:33:56 volumio kernel: dhd_os_open_image: /lib/firmware/brcm/nvram_ap6359sa.txt (5861 bytes) open success
Nov 09 09:33:56 volumio kernel: [43B blob data]
Nov 09 09:33:56 volumio kernel: dhdsdio_write_vars: Download, Upload and compare of NVRAM succeeded.
Nov 09 09:33:56 volumio kernel: in count:402648, out count:402651
Nov 09 09:33:56 volumio kernel: add cnt:246, mpll1_rate:48999976 mpll2 rate:48999463
Nov 09 09:33:56 volumio kernel: dhd_bus_init: enable 0x06, ready 0x06 (waited 0us)
Nov 09 09:33:56 volumio kernel: si_get_pmu_reg_addr: addrRET: 18000670
Nov 09 09:33:56 volumio kernel: bcmsdh_oob_intr_register: HW_OOB irq=69 flags=0x8
Nov 09 09:33:56 volumio kernel: dhd_get_memdump_info: File [/data/misc/wifi/.memdump.info] doesn't exist
Nov 09 09:33:56 volumio kernel: dhd_get_memdump_info: MEMDUMP ENABLED = 2
Nov 09 09:33:56 volumio kernel: dhd_tcpack_suppress_set: TCP ACK Suppress mode 0 -> mode 1
Nov 09 09:33:56 volumio kernel: dhd_apply_default_clm: Ignore clm file /lib/firmware/brcm/clm.blob
Nov 09 09:33:56 volumio kernel: Firmware up: op_mode=0x0405, MAC=18:93:7f:67:48:c4
Nov 09 09:33:56 volumio kernel: Driver: 1.579.77.41.10 (r)
Firmware: wl0: Jan 19 2018 12:14:30 version 9.87.51.11.8 (a85e25e@shgit) (r) FWID 01-cb5aa0a5
CLM: 9.7.5
Nov 09 09:33:56 volumio kernel: dhd_txglom_enable: enable 1
Nov 09 09:33:56 volumio kernel: dhd_conf_set_txglom_params: txglom_mode=copy
Nov 09 09:33:56 volumio kernel: dhd_conf_set_txglom_params: txglomsize=36, deferred_tx_len=0
Nov 09 09:33:56 volumio kernel: dhd_conf_set_txglom_params: txinrx_thres=128, dhd_txminmax=-1
Nov 09 09:33:56 volumio kernel: dhd_conf_set_txglom_params: tx_max_offset=0, txctl_tmo_fix=300
Nov 09 09:33:56 volumio kernel: dhd_conf_get_disable_proptx: fw_proptx=0, disable_proptx=1
Nov 09 09:33:56 volumio kernel: dhd_pno_init: Support Android Location Service
Nov 09 09:33:56 volumio kernel: rtt_do_get_ioctl: failed to send getbuf proxd iovar (CMD ID : 1), status=-23
Nov 09 09:33:56 volumio kernel: dhd_rtt_init : FTM is not supported
Nov 09 09:33:56 volumio kernel: dhd_preinit_ioctls: SensorHub diabled 0
Nov 09 09:33:56 volumio kernel: dhd_preinit_ioctls failed to set ShubHub disable
Nov 09 09:33:56 volumio kernel: failed to set WNM capabilities
Nov 09 09:33:56 volumio kernel: dhd_conf_set_country: set country CN, revision 38
Nov 09 09:33:56 volumio kernel: Country code: CN (CN/38)
Nov 09 09:33:56 volumio kernel: CONFIG-ERROR) dhd_conf_set_intiovar: txbf setting failed -23
Nov 09 09:33:56 volumio kernel: wl_android_wifi_on: Success
Nov 09 09:33:56 volumio kernel: dhd_open : the lock is released.
Nov 09 09:33:56 volumio kernel: dhd_open: Exit ret=0
Nov 09 09:33:56 volumio sudo[7639]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2023-11-09 09:32
Nov 09 09:33:56 volumio sudo[7639]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 09 09:33:56 volumio sudo[7614]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd
Nov 09 09:33:56 volumio sudo[7614]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 09 09:33:56 volumio sudo[7641]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Nov 09 09:33:56 volumio dhcpcd[7644]: version 6.0.5 starting
Nov 09 09:33:56 volumio sudo[7641]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 09 09:33:56 volumio sudo[7641]: pam_unix(sudo:session): session closed for user root
Nov 09 09:33:57 volumio dhcpcd[7644]: dummy0: soliciting a DHCP lease
Nov 09 09:33:57 volumio dhcpcd[7644]: eth0: waiting for carrier
Nov 09 09:33:57 volumio dhcpcd[7644]: wlan0: waiting for carrier
Nov 09 09:33:57 volumio kernel: in count:402653, out count:402651
Nov 09 09:33:57 volumio kernel: reduce cnt:219, mpll1_rate:48999976, mpll2 rate:49000050
Nov 09 09:33:57 volumio sudo[7639]: pam_unix(sudo:session): session closed for user root
Nov 09 09:33:57 volumio systemd[1]: volumio.service: main process exited, code=exited, status=1/FAILURE
Nov 09 09:33:57 volumio systemd[1]: Unit volumio.service entered failed state.
Nov 09 09:33:57 volumio systemd[1]: Starting dynamicswap service...
Nov 09 09:33:57 volumio systemd[1]: Started dynamicswap service.
Nov 09 09:33:57 volumio kernel: in count:402647, out count:402651
Nov 09 09:33:57 volumio kernel: add cnt:247, mpll1_rate:48999976 mpll2 rate:48999390
Nov 09 09:33:57 volumio systemd[1]: volumio.service holdoff time over, scheduling restart.
Nov 09 09:33:57 volumio systemd[1]: Starting dynamicswap service...
Nov 09 09:33:57 volumio systemd[1]: Started dynamicswap service.
Nov 09 09:33:57 volumio systemd[1]: Stopping Volumio Backend Module...
Nov 09 09:33:57 volumio kernel: in count:402651, out count:402651
Nov 09 09:33:57 volumio wireless.js[7554]: trying...
Nov 09 09:33:57 volumio volumio-remote-updater[4055]: [2023-11-09 09:33:57] [info] asio async_connect error: system:111 (Connection refused)
Nov 09 09:33:57 volumio volumio-remote-updater[4055]: [2023-11-09 09:33:57] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Nov 09 09:33:57 volumio volumio-remote-updater[4055]: [2023-11-09 09:33:57] [error] handle_connect error: Underlying Transport Error
Nov 09 09:33:57 volumio sudo[7713]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Nov 09 09:33:57 volumio sudo[7713]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 09 09:33:57 volumio sudo[7713]: pam_unix(sudo:session): session closed for user root
Nov 09 09:33:58 volumio wpa_supplicant[7646]: wlan0: Trying to associate with 30:c5:0f:a3:58:f4 (SSID='Base_Linux' freq=2462 MHz)
Nov 09 09:33:58 volumio kernel: Connecting with 30:c5:0f:a3:58:f4 ssid "Base_Linux", len (10) channel=11
Nov 09 09:33:58 volumio kernel: dhd_dbg_start_pkt_monitor, 1724
Nov 09 09:33:58 volumio kernel: in count:805304, out count:805304
Nov 09 09:33:58 volumio kernel: in count:1207956, out count:1207956
Nov 09 09:33:58 volumio wireless.js[7554]: trying...
Nov 09 09:33:59 volumio sudo[7716]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Nov 09 09:33:59 volumio sudo[7716]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 09 09:33:59 volumio sudo[7716]: pam_unix(sudo:session): session closed for user root
Nov 09 09:33:59 volumio kernel: in count:1610608, out count:1610609
Nov 09 09:33:59 volumio kernel: add cnt:248, mpll1_rate:48999976 mpll2 rate:48999976
Nov 09 09:33:59 volumio kernel: in count:402657, out count:402651
Nov 09 09:33:59 volumio kernel: reduce cnt:220, mpll1_rate:48999976, mpll2 rate:49000562
Nov 09 09:33:59 volumio kernel: in count:402651, out count:402652
Nov 09 09:33:59 volumio kernel: add cnt:249, mpll1_rate:48999976 mpll2 rate:48999903
Nov 09 09:34:00 volumio wireless.js[7554]: trying...
Nov 09 09:34:00 volumio sudo[7719]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Nov 09 09:34:00 volumio sudo[7719]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 09 09:34:00 volumio sudo[7719]: pam_unix(sudo:session): session closed for user root
Nov 09 09:34:00 volumio kernel: in count:402656, out count:402652
Nov 09 09:34:00 volumio kernel: reduce cnt:221, mpll1_rate:48999976, mpll2 rate:49000489
Nov 09 09:34:00 volumio kernel: in count:402650, out count:402652
Nov 09 09:34:00 volumio kernel: add cnt:250, mpll1_rate:48999976 mpll2 rate:48999830
Nov 09 09:34:01 volumio wireless.js[7554]: trying...
Nov 09 09:34:01 volumio sudo[7722]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Nov 09 09:34:01 volumio sudo[7722]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 09 09:34:01 volumio sudo[7722]: pam_unix(sudo:session): session closed for user root
Nov 09 09:34:01 volumio kernel: in count:402655, out count:402651
Nov 09 09:34:01 volumio kernel: reduce cnt:222, mpll1_rate:48999976, mpll2 rate:49000416
Nov 09 09:34:01 volumio kernel: in count:402650, out count:402652
Nov 09 09:34:01 volumio kernel: add cnt:251, mpll1_rate:48999976 mpll2 rate:48999756
Nov 09 09:34:01 volumio kernel: in count:402655, out count:402651
Nov 09 09:34:01 volumio kernel: reduce cnt:223, mpll1_rate:48999976, mpll2 rate:49000343
Nov 09 09:34:02 volumio wireless.js[7554]: trying...
Nov 09 09:34:02 volumio sudo[7725]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Nov 09 09:34:02 volumio sudo[7725]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 09 09:34:02 volumio sudo[7725]: pam_unix(sudo:session): session closed for user root
Nov 09 09:34:02 volumio kernel: in count:402649, out count:402652
Nov 09 09:34:02 volumio kernel: add cnt:252, mpll1_rate:48999976 mpll2 rate:48999683
Nov 09 09:34:02 volumio kernel: in count:402654, out count:402652
Nov 09 09:34:02 volumio kernel: reduce cnt:224, mpll1_rate:48999976, mpll2 rate:49000269
Nov 09 09:34:03 volumio kernel: in count:402649, out count:402651
Nov 09 09:34:03 volumio kernel: add cnt:253, mpll1_rate:48999976 mpll2 rate:48999610
Nov 09 09:34:03 volumio wireless.js[7554]: trying...
Nov 09 09:34:03 volumio sudo[7730]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Nov 09 09:34:03 volumio sudo[7730]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 09 09:34:03 volumio sudo[7730]: pam_unix(sudo:session): session closed for user root
Nov 09 09:34:03 volumio kernel: in count:402654, out count:402652
Nov 09 09:34:03 volumio kernel: reduce cnt:225, mpll1_rate:48999976, mpll2 rate:49000196
Nov 09 09:34:03 volumio kernel: wl_iw_event: Link UP with 30:c5:0f:a3:58:f4
Nov 09 09:34:03 volumio kernel: wl_bss_connect_done succeeded with 30:c5:0f:a3:58:f4
Nov 09 09:34:03 volumio kernel: CFG80211-ERROR) wl_cfg80211_scan_abort : scan abort failed
Nov 09 09:34:03 volumio wpa_supplicant[7646]: wlan0: Associated with 30:c5:0f:a3:58:f4
Nov 09 09:34:03 volumio wpa_supplicant[7646]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=RO
Nov 09 09:34:03 volumio kernel: wl_bss_connect_done succeeded with 30:c5:0f:a3:58:f4 vndr_oui: AC-85-3D 00-E0-FC
Nov 09 09:34:03 volumio kernel: in count:402648, out count:402651
Nov 09 09:34:03 volumio kernel: add cnt:254, mpll1_rate:48999976 mpll2 rate:48999537
Nov 09 09:34:04 volumio wireless.js[7554]: trying...
Nov 09 09:34:04 volumio sudo[7736]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Nov 09 09:34:04 volumio sudo[7736]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 09 09:34:04 volumio sudo[7736]: pam_unix(sudo:session): session closed for user root
Nov 09 09:34:04 volumio kernel: in count:402653, out count:402652
Nov 09 09:34:04 volumio kernel: reduce cnt:226, mpll1_rate:48999976, mpll2 rate:49000123
Nov 09 09:34:04 volumio kernel: in count:402648, out count:402651
Nov 09 09:34:04 volumio kernel: add cnt:255, mpll1_rate:48999976 mpll2 rate:48999463
Nov 09 09:34:05 volumio kernel: in count:402652, out count:402652
Nov 09 09:34:05 volumio wireless.js[7554]: trying...
Nov 09 09:34:05 volumio sudo[7739]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Nov 09 09:34:05 volumio sudo[7739]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 09 09:34:05 volumio sudo[7739]: pam_unix(sudo:session): session closed for user root
Nov 09 09:34:05 volumio kernel: in count:805306, out count:805304
Nov 09 09:34:05 volumio kernel: reduce cnt:227, mpll1_rate:48999976, mpll2 rate:49000050
Nov 09 09:34:05 volumio kernel: in count:402646, out count:402651
Nov 09 09:34:05 volumio kernel: add cnt:256, mpll1_rate:48999976 mpll2 rate:48999390
Nov 09 09:34:06 volumio wireless.js[7554]: trying...
Nov 09 09:34:06 volumio sudo[7742]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Nov 09 09:34:06 volumio sudo[7742]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 09 09:34:06 volumio sudo[7742]: pam_unix(sudo:session): session closed for user root
Nov 09 09:34:06 volumio kernel: in count:402652, out count:402652
Nov 09 09:34:06 volumio kernel: in count:805304, out count:805304
Nov 09 09:34:07 volumio kernel: in count:1207956, out count:1207957
Nov 09 09:34:07 volumio kernel: add cnt:257, mpll1_rate:48999976 mpll2 rate:48999976
Nov 09 09:34:07 volumio wireless.js[7554]: trying...
Nov 09 09:34:07 volumio sudo[7745]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Nov 09 09:34:07 volumio sudo[7745]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 09 09:34:07 volumio sudo[7745]: pam_unix(sudo:session): session closed for user root
Nov 09 09:34:07 volumio kernel: in count:402656, out count:402651
Nov 09 09:34:07 volumio kernel: reduce cnt:228, mpll1_rate:48999976, mpll2 rate:49000562
Nov 09 09:34:07 volumio kernel: in count:402651, out count:402651
Nov 09 09:34:07 volumio volumio-remote-updater[4055]: [2023-11-09 09:34:07] [info] asio async_connect error: system:111 (Connection refused)
Nov 09 09:34:07 volumio volumio-remote-updater[4055]: [2023-11-09 09:34:07] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Nov 09 09:34:07 volumio volumio-remote-updater[4055]: [2023-11-09 09:34:07] [error] handle_connect error: Underlying Transport Error
Nov 09 09:34:08 volumio wireless.js[7554]: trying...
Nov 09 09:34:08 volumio sudo[7748]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Nov 09 09:34:08 volumio sudo[7748]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 09 09:34:08 volumio sudo[7748]: pam_unix(sudo:session): session closed for user root
Nov 09 09:34:08 volumio kernel: in count:805303, out count:805304
Nov 09 09:34:08 volumio kernel: add cnt:258, mpll1_rate:48999976 mpll2 rate:48999903
Nov 09 09:34:08 volumio kernel: in count:402656, out count:402651
Nov 09 09:34:08 volumio kernel: reduce cnt:229, mpll1_rate:48999976, mpll2 rate:49000489
Nov 09 09:34:09 volumio kernel: in count:402651, out count:402651
Nov 09 09:34:09 volumio wireless.js[7554]: trying...
Nov 09 09:34:09 volumio sudo[7751]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Nov 09 09:34:09 volumio sudo[7751]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 09 09:34:09 volumio sudo[7751]: pam_unix(sudo:session): session closed for user root
Nov 09 09:34:09 volumio kernel: in count:805302, out count:805304
Nov 09 09:34:09 volumio kernel: add cnt:259, mpll1_rate:48999976 mpll2 rate:48999830
Nov 09 09:34:09 volumio kernel: in count:402655, out count:402652
Nov 09 09:34:09 volumio kernel: reduce cnt:230, mpll1_rate:48999976, mpll2 rate:49000416
Nov 09 09:34:10 volumio kernel: in count:402650, out count:402652
Nov 09 09:34:10 volumio kernel: add cnt:260, mpll1_rate:48999976 mpll2 rate:48999756
Nov 09 09:34:10 volumio wireless.js[7554]: trying...
Nov 09 09:34:10 volumio sudo[7754]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Nov 09 09:34:10 volumio sudo[7754]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 09 09:34:10 volumio sudo[7754]: pam_unix(sudo:session): session closed for user root
Nov 09 09:34:10 volumio kernel: in count:402655, out count:402652
Nov 09 09:34:10 volumio kernel: reduce cnt:231, mpll1_rate:48999976, mpll2 rate:49000343
Nov 09 09:34:11 volumio kernel: in count:402649, out count:402651
Nov 09 09:34:11 volumio kernel: add cnt:261, mpll1_rate:48999976 mpll2 rate:48999683
Nov 09 09:34:11 volumio wireless.js[7554]: trying...
Nov 09 09:34:11 volumio sudo[7757]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Nov 09 09:34:11 volumio sudo[7757]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 09 09:34:11 volumio sudo[7757]: pam_unix(sudo:session): session closed for user root
Nov 09 09:34:11 volumio kernel: in count:402654, out count:402652
Nov 09 09:34:11 volumio kernel: reduce cnt:232, mpll1_rate:48999976, mpll2 rate:49000269
Nov 09 09:34:11 volumio kernel: CFG80211-ERROR) wl_is_linkdown : Link down Reason : WLC_E_DISASSOC_IND
Nov 09 09:34:11 volumio kernel: link down if wlan0 may call cfg80211_disconnected. event : 12, reason=2 from 30:c5:0f:a3:58:f4
Nov 09 09:34:11 volumio kernel: dhd_dbg_stop_pkt_monitor, 1963
Nov 09 09:34:11 volumio kernel: wl_iw_event: Link Down with 30:c5:0f:a3:58:f4, reason=2
Nov 09 09:34:11 volumio kernel: CFG80211-ERROR) wl_cfg80211_tdls_config : No change in tdls state. Do nothing. tdls_enable:1
Nov 09 09:34:11 volumio kernel: CFG80211-ERROR) wl_is_linkdown : Link down Reason : WLC_E_LINK
Nov 09 09:34:11 volumio kernel: CFG80211-ERROR) wl_cfg80211_tdls_config : No change in tdls state. Do nothing. tdls_enable:1
Nov 09 09:34:11 volumio wpa_supplicant[7646]: wlan0: CTRL-EVENT-DISCONNECTED bssid=30:c5:0f:a3:58:f4 reason=2
Nov 09 09:34:11 volumio wpa_supplicant[7646]: wlan0: WPA: 4-Way Handshake failed - pre-shared key may be incorrect
Nov 09 09:34:11 volumio wpa_supplicant[7646]: wlan0: CTRL-EVENT-SSID-TEMP-DISABLED id=0 ssid="Base_Linux" auth_failures=1 duration=10 reason=WRONG_KEY
Nov 09 09:34:11 volumio wpa_supplicant[7646]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=CORE type=WORLD
Nov 09 09:34:11 volumio kernel: in count:402649, out count:402651
Nov 09 09:34:11 volumio kernel: add cnt:262, mpll1_rate:48999976 mpll2 rate:48999610
Nov 09 09:34:12 volumio kernel: in count:402654, out count:402651
Nov 09 09:34:12 volumio kernel: reduce cnt:233, mpll1_rate:48999976, mpll2 rate:49000196
Nov 09 09:34:12 volumio wireless.js[7554]: trying...
Nov 09 09:34:12 volumio sudo[7763]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Nov 09 09:34:12 volumio sudo[7763]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 09 09:34:12 volumio sudo[7763]: pam_unix(sudo:session): session closed for user root
Nov 09 09:34:12 volumio kernel: in count:402648, out count:402651
Nov 09 09:34:12 volumio kernel: add cnt:263, mpll1_rate:48999976 mpll2 rate:48999537
Nov 09 09:34:13 volumio kernel: in count:402652, out count:402652
Nov 09 09:34:13 volumio wireless.js[7554]: trying...
Nov 09 09:34:13 volumio sudo[7766]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Nov 09 09:34:13 volumio sudo[7766]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 09 09:34:13 volumio sudo[7766]: pam_unix(sudo:session): session closed for user root
Nov 09 09:34:13 volumio kernel: in count:805306, out count:805304
Nov 09 09:34:13 volumio kernel: reduce cnt:234, mpll1_rate:48999976, mpll2 rate:49000123
Nov 09 09:34:13 volumio kernel: in count:402648, out count:402652
Nov 09 09:34:13 volumio kernel: add cnt:264, mpll1_rate:48999976 mpll2 rate:48999463
Nov 09 09:34:14 volumio kernel: in count:402652, out count:402652
Nov 09 09:34:14 volumio wireless.js[7554]: trying...
Nov 09 09:34:14 volumio sudo[7769]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Nov 09 09:34:14 volumio sudo[7769]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 09 09:34:14 volumio sudo[7769]: pam_unix(sudo:session): session closed for user root
Nov 09 09:34:14 volumio kernel: in count:805306, out count:805304
Nov 09 09:34:14 volumio kernel: reduce cnt:235, mpll1_rate:48999976, mpll2 rate:49000050
Nov 09 09:34:15 volumio kernel: in count:402646, out count:402652
Nov 09 09:34:15 volumio kernel: add cnt:265, mpll1_rate:48999976 mpll2 rate:48999390
Nov 09 09:34:15 volumio wireless.js[7554]: trying...
Nov 09 09:34:15 volumio sudo[7772]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Nov 09 09:34:15 volumio sudo[7772]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 09 09:34:15 volumio sudo[7772]: pam_unix(sudo:session): session closed for user root
Nov 09 09:34:15 volumio kernel: in count:402651, out count:402651
Nov 09 09:34:16 volumio kernel: in count:805303, out count:805303
Nov 09 09:34:16 volumio kernel: in count:1207956, out count:1207956
Nov 09 09:34:16 volumio wireless.js[7554]: trying...
Nov 09 09:34:16 volumio sudo[7775]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Nov 09 09:34:16 volumio sudo[7775]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 09 09:34:16 volumio sudo[7775]: pam_unix(sudo:session): session closed for user root
Nov 09 09:34:16 volumio kernel: in count:1610608, out count:1610608
Nov 09 09:34:17 volumio kernel: in count:2013261, out count:2013261
Nov 09 09:34:17 volumio kernel: in count:2415913, out count:2415913
Nov 09 09:34:17 volumio wireless.js[7554]: Overtime, starting plan B
Nov 09 09:34:17 volumio volumio-remote-updater[4055]: [2023-11-09 09:34:17] [info] asio async_connect error: system:111 (Connection refused)
Nov 09 09:34:17 volumio volumio-remote-updater[4055]: [2023-11-09 09:34:17] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Nov 09 09:34:17 volumio volumio-remote-updater[4055]: [2023-11-09 09:34:17] [error] handle_connect error: Underlying Transport Error
Nov 09 09:34:18 volumio kernel: in count:2818565, out count:2818565
Nov 09 09:34:18 volumio kernel: in count:3221218, out count:3221218
Nov 09 09:34:18 volumio kernel: in count:3623870, out count:3623870
Nov 09 09:34:19 volumio kernel: in count:4026523, out count:4026523
Nov 09 09:34:19 volumio kernel: in count:4429175, out count:4429175
Nov 09 09:34:20 volumio kernel: in count:4831827, out count:4831827
Nov 09 09:34:20 volumio kernel: in count:5234480, out count:5234480
Nov 09 09:34:20 volumio kernel: in count:5637132, out count:5637132
Nov 09 09:34:21 volumio kernel: in count:6039785, out count:6039785
Nov 09 09:34:21 volumio kernel: in count:6442437, out count:6442437
Nov 09 09:34:22 volumio kernel: in count:6845089, out count:6845089
Nov 09 09:34:22 volumio kernel: in count:7247742, out count:7247742
Nov 09 09:34:22 volumio kernel: in count:7650394, out count:7650394
Nov 09 09:34:23 volumio kernel: in count:8053047, out count:8053047
Nov 09 09:34:23 volumio kernel: in count:8455699, out count:8455699
Nov 09 09:34:24 volumio kernel: in count:8858351, out count:8858351
Nov 09 09:34:24 volumio kernel: in count:9261004, out count:9261004
Nov 09 09:34:24 volumio kernel: in count:9663656, out count:9663656
Nov 09 09:34:25 volumio kernel: in count:10066309, out count:10066309
Nov 09 09:34:25 volumio kernel: in count:10468961, out count:10468961
Nov 09 09:34:26 volumio kernel: in count:10871613, out count:10871613
Nov 09 09:34:26 volumio kernel: in count:11274266, out count:11274266
Nov 09 09:34:26 volumio wpa_supplicant[7646]: wlan0: CTRL-EVENT-SSID-REENABLED id=0 ssid="Base_Linux"
Nov 09 09:34:26 volumio wpa_supplicant[7646]: wlan0: Trying to associate with 30:c5:0f:a3:58:f4 (SSID='Base_Linux' freq=2462 MHz)
Nov 09 09:34:26 volumio kernel: Connecting with 30:c5:0f:a3:58:f4 ssid "Base_Linux", len (10) channel=11
Nov 09 09:34:26 volumio kernel: dhd_dbg_start_pkt_monitor, 1724
Nov 09 09:34:26 volumio kernel: in count:11676918, out count:11676918
Nov 09 09:34:27 volumio dhcpcd[7644]: timed out
Nov 09 09:34:27 volumio dhcpcd[7644]: allowing 8 seconds for IPv4LL timeout
Nov 09 09:34:27 volumio kernel: in count:12079571, out count:12079571
Nov 09 09:34:27 volumio kernel: in count:12482223, out count:12482223
Nov 09 09:34:27 volumio volumio-remote-updater[4055]: [2023-11-09 09:34:27] [info] asio async_connect error: system:111 (Connection refused)
Nov 09 09:34:27 volumio volumio-remote-updater[4055]: [2023-11-09 09:34:27] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Nov 09 09:34:27 volumio volumio-remote-updater[4055]: [2023-11-09 09:34:27] [error] handle_connect error: Underlying Transport Error
Nov 09 09:34:28 volumio kernel: in count:12884875, out count:12884875
Nov 09 09:34:28 volumio kernel: in count:13287528, out count:13287528
Nov 09 09:34:28 volumio kernel: in count:13690180, out count:13690180
Nov 09 09:34:29 volumio kernel: in count:14092832, out count:14092833
Nov 09 09:34:29 volumio kernel: add cnt:266, mpll1_rate:48999976 mpll2 rate:48999976
Nov 09 09:34:29 volumio kernel: in count:402656, out count:402651
Nov 09 09:34:29 volumio kernel: reduce cnt:236, mpll1_rate:48999976, mpll2 rate:49000562
Nov 09 09:34:30 volumio kernel: in count:402652, out count:402651
Nov 09 09:34:30 volumio kernel: reduce cnt:237, mpll1_rate:48999976, mpll2 rate:48999903
Nov 09 09:34:30 volumio kernel: in count:402646, out count:402651
Nov 09 09:34:30 volumio kernel: add cnt:267, mpll1_rate:48999976 mpll2 rate:48999244
Nov 09 09:34:30 volumio wpa_supplicant[7646]: wlan0: CTRL-EVENT-ASSOC-REJECT bssid=30:c5:0f:a3:58:f4 status_code=1
Nov 09 09:34:30 volumio kernel: connect failed event=0 e->status 4 e->reason 1
Nov 09 09:34:30 volumio kernel: CFG80211-ERROR) wl_bss_connect_done : Report connect result - connection failed
Nov 09 09:34:30 volumio kernel: in count:402650, out count:402652
Nov 09 09:34:30 volumio kernel: add cnt:268, mpll1_rate:48999976 mpll2 rate:48999830
Nov 09 09:34:31 volumio kernel: in count:402655, out count:402652
Nov 09 09:34:31 volumio kernel: reduce cnt:238, mpll1_rate:48999976, mpll2 rate:49000416
Nov 09 09:34:31 volumio kernel: in count:402650, out count:402651
Nov 09 09:34:31 volumio kernel: add cnt:269, mpll1_rate:48999976 mpll2 rate:48999756
Nov 09 09:34:32 volumio kernel: in count:402655, out count:402652
Nov 09 09:34:32 volumio kernel: reduce cnt:239, mpll1_rate:48999976, mpll2 rate:49000343
Nov 09 09:34:32 volumio kernel: in count:402649, out count:402652
Nov 09 09:34:32 volumio kernel: add cnt:270, mpll1_rate:48999976 mpll2 rate:48999683
Nov 09 09:34:32 volumio kernel: in count:402654, out count:402652
Nov 09 09:34:32 volumio kernel: reduce cnt:240, mpll1_rate:48999976, mpll2 rate:49000269
Nov 09 09:34:33 volumio kernel: in count:402649, out count:402651
Nov 09 09:34:33 volumio kernel: add cnt:271, mpll1_rate:48999976 mpll2 rate:48999610
Nov 09 09:34:33 volumio kernel: in count:402654, out count:402652
Nov 09 09:34:33 volumio kernel: reduce cnt:241, mpll1_rate:48999976, mpll2 rate:49000196
Nov 09 09:34:33 volumio wpa_supplicant[7646]: wlan0: Trying to associate with 30:c5:0f:a3:58:f4 (SSID='Base_Linux' freq=2462 MHz)
Nov 09 09:34:33 volumio kernel: Connecting with 30:c5:0f:a3:58:f4 ssid "Base_Linux", len (10) channel=11
Nov 09 09:34:33 volumio kernel: dhd_dbg_start_pkt_monitor, 1724
Nov 09 09:34:34 volumio kernel: in count:402648, out count:402651
Nov 09 09:34:34 volumio kernel: add cnt:272, mpll1_rate:48999976 mpll2 rate:48999537
Nov 09 09:34:34 volumio kernel: in count:402653, out count:402651
Nov 09 09:34:34 volumio kernel: reduce cnt:242, mpll1_rate:48999976, mpll2 rate:49000123
Nov 09 09:34:34 volumio kernel: in count:402648, out count:402652
Nov 09 09:34:34 volumio kernel: add cnt:273, mpll1_rate:48999976 mpll2 rate:48999463
Nov 09 09:34:35 volumio dhcpcd[7644]: timed out
Nov 09 09:34:35 volumio dhcpcd[7644]: forked to background, child pid 7779
Nov 09 09:34:35 volumio sudo[7614]: pam_unix(sudo:session): session closed for user root
Nov 09 09:34:35 volumio systemd[1]: Started Wireless Services.
Nov 09 09:34:35 volumio systemd[1]: Starting Volumio Backend Module...
Nov 09 09:34:35 volumio systemd[1]: Started Volumio Backend Module.
Nov 09 09:34:35 volumio kernel: in count:402653, out count:402651
Nov 09 09:34:35 volumio kernel: reduce cnt:243, mpll1_rate:48999976, mpll2 rate:49000050
Nov 09 09:34:35 volumio kernel: in count:402646, out count:402652
Nov 09 09:34:35 volumio kernel: add cnt:274, mpll1_rate:48999976 mpll2 rate:48999390
Nov 09 09:34:35 volumio volumio[7781]: info: -------------------------------------------
Nov 09 09:34:35 volumio volumio[7781]: info: ----- Volumio2 ----
Nov 09 09:34:35 volumio volumio[7781]: info: -------------------------------------------
Nov 09 09:34:35 volumio volumio[7781]: info: ----- System startup ----
Nov 09 09:34:35 volumio volumio[7781]: info: -------------------------------------------
Nov 09 09:34:36 volumio volumio[7781]: info: MYVOLUMIO Environment detected
Nov 09 09:34:36 volumio kernel: in count:402652, out count:402651
Nov 09 09:34:36 volumio kernel: reduce cnt:244, mpll1_rate:48999976, mpll2 rate:48999976
Nov 09 09:34:36 volumio volumio[7781]: info: Plugin folders cleanup
Nov 09 09:34:36 volumio volumio[7781]: info: Scanning into folder /volumio/app/plugins/
Nov 09 09:34:36 volumio volumio[7781]: info: Scanning category audio_interface
Nov 09 09:34:36 volumio volumio[7781]: info: Scanning category miscellanea
Nov 09 09:34:36 volumio volumio[7781]: info: Scanning category music_service
Nov 09 09:34:36 volumio volumio[7781]: info: Scanning category plugins.json
Nov 09 09:34:36 volumio volumio[7781]: info: Scanning category system_controller
Nov 09 09:34:36 volumio volumio[7781]: info: Scanning category user_interface
Nov 09 09:34:36 volumio volumio[7781]: info: Scanning into folder /data/plugins/
Nov 09 09:34:36 volumio volumio[7781]: info: Scanning category accessory
Nov 09 09:34:36 volumio volumio[7781]: info: Scanning category audio_interface
Nov 09 09:34:36 volumio volumio[7781]: info: Scanning category music_service
Nov 09 09:34:36 volumio volumio[7781]: info: Scanning category system_controller
Nov 09 09:34:36 volumio volumio[7781]: info: Plugin folders cleanup completed
Nov 09 09:34:36 volumio volumio[7781]: info: -------------------------------------------
Nov 09 09:34:36 volumio volumio[7781]: info: ----- Core plugins startup ----
Nov 09 09:34:36 volumio volumio[7781]: info: -------------------------------------------
Nov 09 09:34:36 volumio volumio[7781]: info: Loading plugins from folder /volumio/app/plugins/
Nov 09 09:34:36 volumio volumio[7781]: info: Adding plugin upnp to MyMusic Plugins
Nov 09 09:34:36 volumio volumio[7781]: info: Adding plugin airplay_emulation to MyMusic Plugins
Nov 09 09:34:36 volumio volumio[7781]: info: Adding plugin upnp_browser to MyMusic Plugins
Nov 09 09:34:36 volumio volumio[7781]: info: Loading plugins from folder /data/plugins/
Nov 09 09:34:36 volumio volumio[7781]: info: Loading plugin "system"...
Nov 09 09:34:36 volumio volumio[7781]: info: Loading plugin "appearance"...
Nov 09 09:34:36 volumio kernel: in count:402646, out count:402651
Nov 09 09:34:36 volumio kernel: add cnt:275, mpll1_rate:48999976 mpll2 rate:48999317
Nov 09 09:34:36 volumio wpa_supplicant[7646]: wlan0: CTRL-EVENT-ASSOC-REJECT bssid=30:c5:0f:a3:58:f4 status_code=1
Nov 09 09:34:36 volumio kernel: connect failed event=0 e->status 4 e->reason 1
Nov 09 09:34:36 volumio kernel: CFG80211-ERROR) wl_bss_connect_done : Report connect result - connection failed
Nov 09 09:34:36 volumio volumio[7781]: info: Loading plugin "network"...
Nov 09 09:34:36 volumio kernel: in count:402651, out count:402651
Nov 09 09:34:36 volumio volumio[7781]: info: Loading plugin "services"...
Nov 09 09:34:36 volumio volumio[7781]: info: Loading plugin "alsa_controller"...
Nov 09 09:34:36 volumio volumio[7781]: info: Loading plugin "wizard"...
Nov 09 09:34:37 volumio volumio[7781]: info: Loading plugin "volumio_command_line_client"...
Nov 09 09:34:37 volumio volumio[7781]: info: Plugin upnp is not enabled
Nov 09 09:34:37 volumio volumio[7781]: info: Loading plugin "my_music"...
Nov 09 09:34:37 volumio volumio[7781]: info: Loading plugin "mpd"...
Nov 09 09:34:37 volumio volumio[7781]: info: Plugin upnp_browser is not enabled
Nov 09 09:34:37 volumio volumio[7781]: info: Loading plugin "networkfs"...
Nov 09 09:34:37 volumio kernel: in count:805304, out count:805303
Nov 09 09:34:37 volumio kernel: reduce cnt:245, mpll1_rate:48999976, mpll2 rate:48999903
Nov 09 09:34:37 volumio volumio[7781]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Nov 09 09:34:37 volumio volumio[7781]: info: Loading plugin "alarm-clock"...
Nov 09 09:34:37 volumio sudo[7805]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t nfs -o ro,soft,noauto,ro lena.baselinux.net:/DATA/mmedia/music /mnt/NAS/lena_music
Nov 09 09:34:37 volumio sudo[7805]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 09 09:34:37 volumio sudo[7805]: pam_unix(sudo:session): session closed for user root
Nov 09 09:34:37 volumio volumio[7781]: info: Plugin airplay_emulation is not enabled
Nov 09 09:34:37 volumio volumio[7781]: info: Loading plugin "last_100"...
Nov 09 09:34:37 volumio volumio[7781]: info: Loading plugin "webradio"...
Nov 09 09:34:37 volumio volumio[7781]: info: Loading plugin "i2s_dacs"...
Nov 09 09:34:37 volumio volumio[7781]: info: I2S DAC not set, start Auto-detection
Nov 09 09:34:37 volumio volumio[7781]: info: Loading plugin "volumiodiscovery"...
Nov 09 09:34:37 volumio volumio[7781]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Nov 09 09:34:37 volumio node[7781]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Nov 09 09:34:37 volumio node[7781]: *** WARNING *** Please fix your application to use the native API of Avahi!
Nov 09 09:34:37 volumio node[7781]: *** WARNING *** For more information see
Nov 09 09:34:37 volumio node[7781]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Nov 09 09:34:37 volumio node[7781]: *** WARNING *** Please fix your application to use the native API of Avahi!
Nov 09 09:34:37 volumio node[7781]: *** WARNING *** For more information see
Nov 09 09:34:37 volumio volumio[7781]: *** WARNING *** Please fix your application to use the native API of Avahi!
Nov 09 09:34:37 volumio volumio[7781]: *** WARNING *** For more information see
Nov 09 09:34:37 volumio volumio[7781]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Nov 09 09:34:37 volumio volumio[7781]: *** WARNING *** Please fix your application to use the native API of Avahi!
Nov 09 09:34:37 volumio volumio[7781]: *** WARNING *** For more information see
Nov 09 09:34:37 volumio volumio[7781]: info: Applying required configuration parameters for plugin volumiodiscovery
Nov 09 09:34:37 volumio volumio[7781]: Discovery: StartAdv! undefined
Nov 09 09:34:37 volumio volumio[7781]: Discovery: Started advertising... Volumio - undefined
Nov 09 09:34:37 volumio volumio[7781]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Nov 09 09:34:37 volumio volumio[7781]: info: Plugin volsimpleequal is not enabled
Nov 09 09:34:37 volumio volumio[7781]: info: Loading plugin "bandcamp"...
Nov 09 09:34:37 volumio kernel: in count:402645, out count:402651
Nov 09 09:34:37 volumio kernel: add cnt:276, mpll1_rate:48999976 mpll2 rate:48999244
Nov 09 09:34:37 volumio volumio[7781]: info: Loading plugin "youtube2"...
Nov 09 09:34:37 volumio volumio-remote-updater[4055]: [2023-11-09 09:34:37] [connect] Successful connection
Nov 09 09:34:38 volumio kernel: in count:402651, out count:402652
Nov 09 09:34:38 volumio kernel: add cnt:277, mpll1_rate:48999976 mpll2 rate:48999830
Nov 09 09:34:38 volumio kernel: in count:402655, out count:402652
Nov 09 09:34:38 volumio kernel: reduce cnt:246, mpll1_rate:48999976, mpll2 rate:49000416
Nov 09 09:34:38 volumio kernel: in count:402650, out count:402651
Nov 09 09:34:38 volumio kernel: add cnt:278, mpll1_rate:48999976 mpll2 rate:48999756
Nov 09 09:34:39 volumio wpa_supplicant[7646]: wlan0: Trying to associate with 30:c5:0f:a3:58:f4 (SSID='Base_Linux' freq=2462 MHz)
Nov 09 09:34:39 volumio kernel: Connecting with 30:c5:0f:a3:58:f4 ssid "Base_Linux", len (10) channel=11
Nov 09 09:34:39 volumio kernel: dhd_dbg_start_pkt_monitor, 1724
Nov 09 09:34:39 volumio kernel: in count:402656, out count:402652
Nov 09 09:34:39 volumio kernel: reduce cnt:247, mpll1_rate:48999976, mpll2 rate:49000343
Nov 09 09:34:39 volumio kernel: in count:402649, out count:402651
Nov 09 09:34:39 volumio kernel: add cnt:279, mpll1_rate:48999976 mpll2 rate:48999683
Nov 09 09:34:39 volumio volumio[7781]: info: Loading plugin "outputs"...
Nov 09 09:34:39 volumio volumio[7781]: info: Loading plugin "albumart"...
Nov 09 09:34:39 volumio volumio[7781]: info: Plugin example_plugin is not enabled
Nov 09 09:34:39 volumio volumio[7781]: info: Loading plugin "inputs"...
Nov 09 09:34:39 volumio volumio[7781]: info: Loading plugin "updater_comm"...
Nov 09 09:34:40 volumio volumio[7781]: info: Plugin mpdemulation is not enabled
Nov 09 09:34:40 volumio volumio[7781]: info: Loading plugin "rest_api"...
Nov 09 09:34:40 volumio volumio[7781]: info: Loading plugin "websocket"...
Nov 09 09:34:40 volumio volumio[7781]: info: Loading plugin "ir_controller"...
Nov 09 09:34:40 volumio volumio[7781]: Forking 5 albumart workers
Nov 09 09:34:40 volumio volumio[7781]: info: Applying required configuration parameters for plugin ir_controller
Nov 09 09:34:40 volumio kernel: in count:402654, out count:402652
Nov 09 09:34:40 volumio kernel: reduce cnt:248, mpll1_rate:48999976, mpll2 rate:49000269
Nov 09 09:34:40 volumio volumio[7781]: info: Loading plugin "radio_paradise"...
Nov 09 09:34:40 volumio volumio[7781]: info: Applying required configuration parameters for plugin radio_paradise
Nov 09 09:34:40 volumio volumio[7781]: info: [1699522480396] [RadioParadise] API delay: 5
Nov 09 09:34:40 volumio volumio[7781]: info: Loading plugin "backup_restore"...
Nov 09 09:34:40 volumio volumio[7781]: info: Loading plugin "wifireconnect"...
Nov 09 09:34:40 volumio kernel: in count:402649, out count:402651
Nov 09 09:34:40 volumio kernel: add cnt:280, mpll1_rate:48999976 mpll2 rate:48999610
Nov 09 09:34:40 volumio volumio[7781]: Starting albumart workers
Nov 09 09:34:40 volumio volumio[7781]: Starting albumart workers
Nov 09 09:34:40 volumio volumio[7781]: info: ___________ START PLUGINS ___________
Nov 09 09:34:40 volumio volumio[7781]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Nov 09 09:34:40 volumio volumio[7781]: info: [1699522480710] CoreMusicLibrary::Adding element Last_100
Nov 09 09:34:40 volumio volumio[7781]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Nov 09 09:34:40 volumio volumio[7781]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Nov 09 09:34:40 volumio volumio[7781]: info: [1699522480720] CoreMusicLibrary::Adding element Webradio
Nov 09 09:34:40 volumio volumio[7781]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Nov 09 09:34:40 volumio volumio[7781]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Nov 09 09:34:40 volumio volumio[7781]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Nov 09 09:34:40 volumio volumio[7781]: info: [1699522480740] CoreMusicLibrary::Adding element Bandcamp Discover
Nov 09 09:34:40 volumio volumio[7781]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Nov 09 09:34:40 volumio volumio[7781]: info: [youtube2-auth] Starting auth flow...
Nov 09 09:34:40 volumio volumio[7781]: Starting albumart workers
Nov 09 09:34:40 volumio volumio[7781]: Starting albumart workers
Nov 09 09:34:40 volumio volumio[7781]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Nov 09 09:34:40 volumio volumio[7781]: info: [1699522480824] CoreMusicLibrary::Adding element YouTube2
Nov 09 09:34:40 volumio volumio[7781]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Nov 09 09:34:40 volumio volumio[7781]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Nov 09 09:34:40 volumio volumio[7781]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Nov 09 09:34:40 volumio sudo[7852]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/lirc/hardware.conf
Nov 09 09:34:40 volumio sudo[7852]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 09 09:34:40 volumio volumio[7781]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Nov 09 09:34:40 volumio volumio[7781]: info: [1699522480887] CoreMusicLibrary::Adding element Radio Paradise
Nov 09 09:34:40 volumio volumio[7781]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Nov 09 09:34:40 volumio sudo[7852]: pam_unix(sudo:session): session closed for user root
Nov 09 09:34:40 volumio sudo[7861]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /etc/lirc/hardware.conf /etc/lirc/lircd.conf /etc/lirc/lircmd.conf /etc/lirc/lircrc
Nov 09 09:34:40 volumio sudo[7861]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 09 09:34:40 volumio sudo[7861]: pam_unix(sudo:session): session closed for user root
Nov 09 09:34:40 volumio volumio[7781]: info: -------------------------------------------
Nov 09 09:34:40 volumio volumio[7781]: info: ----- MyVolumio plugins startup ----
Nov 09 09:34:40 volumio volumio[7781]: info: -------------------------------------------
Nov 09 09:34:40 volumio volumio[7781]: info: [MyVolumio PluginManager] Fetching plans data....
Nov 09 09:34:40 volumio volumio[7781]: info: Loading i18n strings for locale es
Nov 09 09:34:40 volumio sudo[7865]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start wifireconnect.timer
Nov 09 09:34:40 volumio volumio[7781]: Updating browse sources language
Nov 09 09:34:40 volumio volumio[7781]: Cannot find translation for sourceBandcamp Discover
Nov 09 09:34:40 volumio sudo[7865]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 09 09:34:40 volumio volumio[7781]: Cannot find translation for sourceYouTube2
Nov 09 09:34:40 volumio volumio[7781]: Cannot find translation for sourceRadio Paradise
Nov 09 09:34:40 volumio volumio[7781]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Nov 09 09:34:40 volumio systemd[1]: Started Runs wifireconnect every 1min.
Nov 09 09:34:40 volumio sudo[7865]: pam_unix(sudo:session): session closed for user root
Nov 09 09:34:40 volumio kernel: in count:402654, out count:402651
Nov 09 09:34:40 volumio kernel: reduce cnt:249, mpll1_rate:48999976, mpll2 rate:49000196
Nov 09 09:34:40 volumio volumio[7781]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Nov 09 09:34:40 volumio volumio[7781]: info: CoreCommandRouter::initPlayerControls
Nov 09 09:34:41 volumio volumio[7781]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 09 09:34:41 volumio volumio[7781]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards
Nov 09 09:34:41 volumio volumio[7781]: Starting albumart workers
Nov 09 09:34:41 volumio volumio[7781]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 09 09:34:41 volumio volumio[7781]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 09 09:34:41 volumio volumio[7781]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 09 09:34:41 volumio volumio[7781]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 09 09:34:41 volumio volumio[7781]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 09 09:34:41 volumio volumio[7781]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Nov 09 09:34:41 volumio volumio[7781]: info: BOOT COMPLETED
Nov 09 09:34:41 volumio volumio[7781]: [Metrics] CommandRouter: 5s 68.51ms
Nov 09 09:34:41 volumio volumio[7781]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Nov 09 09:34:41 volumio volumio[7781]: ALSA lib pcm_hw.c:1713:(_snd_pcm_hw_open) Invalid value for card
Nov 09 09:34:41 volumio volumio[7781]: aplay: main:722: audio open error: No such file or directory
Nov 09 09:34:41 volumio volumio[7781]: Cannot play startup sound
Nov 09 09:34:41 volumio volumio[7781]: info: CoreCommandRouter::Close All Modals sent
Nov 09 09:34:41 volumio volumio[7781]: info: CoreCommandRouter::Close All Modals sent
Nov 09 09:34:41 volumio volumio[7781]: Express server listening on port 3000
Nov 09 09:34:41 volumio volumio[7781]: [Metrics] WebUI: 5s 311.89ms
Nov 09 09:34:41 volumio volumio[7781]: Volumio Calling Home
Nov 09 09:34:41 volumio kernel: wl_iw_event: Link UP with 30:c5:0f:a3:58:f4
Nov 09 09:34:41 volumio kernel: wl_bss_connect_done succeeded with 30:c5:0f:a3:58:f4
Nov 09 09:34:41 volumio kernel: CFG80211-ERROR) wl_cfg80211_scan_abort : scan abort failed
Nov 09 09:34:41 volumio wpa_supplicant[7646]: wlan0: Associated with 30:c5:0f:a3:58:f4
Nov 09 09:34:41 volumio volumio[7781]: info: CoreStateMachine::resetVolumioState
Nov 09 09:34:41 volumio volumio[7781]: info: CoreStateMachine::getcurrentVolume
Nov 09 09:34:41 volumio volumio[7781]: info: CoreCommandRouter::volumioRetrievevolume
Nov 09 09:34:41 volumio wpa_supplicant[7646]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=RO
Nov 09 09:34:41 volumio volumio[7781]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt'
Nov 09 09:34:41 volumio volumio[7781]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Nov 09 09:34:41 volumio volumio[7781]: ReferenceError: deferred is not defined
Nov 09 09:34:41 volumio volumio[7781]: at ClientRequest.req.on (/data/plugins/music_service/youtube2/lib/core/gapi/auth.js:155:13)
Nov 09 09:34:41 volumio volumio[7781]: at emitOne (events.js:116:13)
Nov 09 09:34:41 volumio volumio[7781]: at ClientRequest.emit (events.js:211:7)
Nov 09 09:34:41 volumio volumio[7781]: at TLSSocket.socketErrorListener (_http_client.js:387:9)
Nov 09 09:34:41 volumio volumio[7781]: at emitOne (events.js:116:13)
Nov 09 09:34:41 volumio volumio[7781]: at TLSSocket.emit (events.js:211:7)
Nov 09 09:34:41 volumio volumio[7781]: at emitErrorNT (internal/streams/destroy.js:64:8)
Nov 09 09:34:41 volumio volumio[7781]: at _combinedTickCallback (internal/process/next_tick.js:138:11)
Nov 09 09:34:41 volumio volumio[7781]: at process._tickCallback (internal/process/next_tick.js:180:9)
Nov 09 09:34:41 volumio volumio[7781]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Nov 09 09:34:41 volumio kernel: wl_bss_connect_done succeeded with 30:c5:0f:a3:58:f4 vndr_oui: AC-85-3D 00-E0-FC
Nov 09 09:34:41 volumio wpa_supplicant[7646]: wlan0: WPA: Key negotiation completed with 30:c5:0f:a3:58:f4 [PTK=CCMP GTK=TKIP]
Nov 09 09:34:41 volumio wpa_supplicant[7646]: wlan0: CTRL-EVENT-CONNECTED - Connection to 30:c5:0f:a3:58:f4 completed [id=0 id_str=]
Nov 09 09:34:41 volumio dhcpcd[7779]: wlan0: carrier acquired
Nov 09 09:34:41 volumio dhcpcd[7779]: wlan0: soliciting an IPv6 router
Nov 09 09:34:41 volumio dhcpcd[7779]: wlan0: using static address 192.168.10.105
Nov 09 09:34:41 volumio avahi-daemon[4083]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.10.105.
Nov 09 09:34:41 volumio dhcpcd[7779]: wlan0: adding host route to 192.168.10.105 via 127.0.0.1
Nov 09 09:34:41 volumio avahi-daemon[4083]: New relevant interface wlan0.IPv4 for mDNS.
Nov 09 09:34:41 volumio avahi-daemon[4083]: Registering new address record for 192.168.10.105 on wlan0.IPv4.
Nov 09 09:34:41 volumio dhcpcd[7779]: wlan0: adding route to 192.168.10.0/24
Nov 09 09:34:41 volumio dhcpcd[7779]: wlan0: adding default route via 192.168.10.100
Nov 09 09:34:41 volumio kernel: in count:402648, out count:402651
Nov 09 09:34:41 volumio kernel: add cnt:281, mpll1_rate:48999976 mpll2 rate:48999537
Nov 09 09:34:41 volumio sudo[7933]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2023-11-09 09:33
Nov 09 09:34:41 volumio sudo[7933]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 09 09:34:41 volumio kernel: in count:402653, out count:402652
Nov 09 09:34:41 volumio kernel: reduce cnt:250, mpll1_rate:48999976, mpll2 rate:49000123
PRETTY_NAME="Debian GNU/Linux 8 (jessie)"
NAME="Debian GNU/Linux"
VERSION_ID="8"
VERSION="8 (jessie)"
ID=debian
HOME_URL="http://www.debian.org/"
SUPPORT_URL="http://www.debian.org/support"
BUG_REPORT_URL="https://bugs.debian.org/"
VOLUMIO_BUILD_VERSION="b932dfa86bb2a8751f6a33e2d2c53a3d4f39440a"
VOLUMIO_FE_VERSION=""
VOLUMIO_BE_VERSION="9baf06b722503c872bcb7e7c52470e6abc938a93"
VOLUMIO_ARCH="armv7"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Mon Apr 13 21:46:37 CEST 2020"
VOLUMIO_VERSION="2.748"
VOLUMIO_HARDWARE="kvim3l"
VOLUMIO_HASH="f4565b0bce263ead83772de5f9ce903d"