-- Logs begin at Thu 2019-02-14 19:12:00 JST, end at Thu 2024-02-22 05:44:04 JST. --
Feb 22 05:43:00 volumio ntpd[585]: error resolving pool 1.debian.pool.ntp.org: System error (-11)
Feb 22 05:43:00 volumio wireless.js[447]: Cleaning previous...
Feb 22 05:43:00 volumio sudo[631]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0
Feb 22 05:43:00 volumio sudo[631]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 22 05:43:00 volumio sudo[631]: pam_unix(sudo:session): session closed for user root
Feb 22 05:43:00 volumio sudo[633]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down
Feb 22 05:43:00 volumio sudo[633]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 22 05:43:01 volumio sudo[633]: pam_unix(sudo:session): session closed for user root
Feb 22 05:43:01 volumio wireless.js[447]: Stopped aP
Feb 22 05:43:01 volumio sudo[640]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up
Feb 22 05:43:01 volumio sudo[640]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 22 05:43:01 volumio kernel: rtl8192cu: MAC auto ON okay!
Feb 22 05:43:01 volumio ntpd[585]: error resolving pool 2.debian.pool.ntp.org: System error (-11)
Feb 22 05:43:01 volumio kernel: rtl8192cu: Tx queue select: 0x05
Feb 22 05:43:02 volumio sh[358]: eth0: leased 192.168.0.202 for infinity
Feb 22 05:43:02 volumio dhcpcd[406]: eth0: leased 192.168.0.202 for infinity
Feb 22 05:43:02 volumio avahi-daemon[444]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.0.202.
Feb 22 05:43:02 volumio sh[358]: eth0: adding route to 192.168.0.0/24
Feb 22 05:43:02 volumio sh[358]: eth0: adding default route via 192.168.0.1
Feb 22 05:43:02 volumio volumio-remote-updater[472]: [2024-02-22 05:43:02] [info] asio async_connect error: system:111 (Connection refused)
Feb 22 05:43:02 volumio volumio-remote-updater[472]: [2024-02-22 05:43:02] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Feb 22 05:43:02 volumio volumio-remote-updater[472]: [2024-02-22 05:43:02] [error] handle_connect error: Underlying Transport Error
Feb 22 05:43:02 volumio avahi-daemon[444]: New relevant interface eth0.IPv4 for mDNS.
Feb 22 05:43:02 volumio avahi-daemon[444]: Registering new address record for 192.168.0.202 on eth0.IPv4.
Feb 22 05:43:02 volumio dhcpcd[406]: eth0: adding route to 192.168.0.0/24
Feb 22 05:43:02 volumio ntpd[585]: Listen normally on 3 eth0 192.168.0.202:123
Feb 22 05:43:02 volumio dhcpcd[406]: eth0: adding default route via 192.168.0.1
Feb 22 05:43:02 volumio ntpd[585]: new interface(s) found: waking up resolver
Feb 22 05:43:02 volumio ntpd[585]: error resolving pool 3.debian.pool.ntp.org: System error (-11)
Feb 22 05:43:02 volumio sudo[640]: pam_unix(sudo:session): session closed for user root
Feb 22 05:43:03 volumio sudo[643]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get
Feb 22 05:43:03 volumio sudo[643]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 22 05:43:03 volumio sudo[643]: pam_unix(sudo:session): session closed for user root
Feb 22 05:43:03 volumio sh[358]: forked to background, child pid 670
Feb 22 05:43:03 volumio dhcpcd[406]: forked to background, child pid 670
Feb 22 05:43:03 volumio sudo[667]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up
Feb 22 05:43:03 volumio sudo[667]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 22 05:43:03 volumio sudo[667]: pam_unix(sudo:session): session closed for user root
Feb 22 05:43:03 volumio sudo[672]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan
Feb 22 05:43:03 volumio sudo[672]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 22 05:43:03 volumio ifplugd(eth0)[605]: client: ifup: interface eth0 already configured
Feb 22 05:43:03 volumio sh[358]: eth0=eth0
Feb 22 05:43:03 volumio ifplugd(eth0)[605]: Program executed successfully.
Feb 22 05:43:03 volumio ifplugd[535]: Network Interface Plugging Daemon...start eth0...done.
Feb 22 05:43:03 volumio systemd[1]: Started LSB: Brings up/down network automatically.
Feb 22 05:43:04 volumio sudo[672]: pam_unix(sudo:session): session closed for user root
Feb 22 05:43:04 volumio wireless.js[447]: SETTING APPROPRIATE REG DOMAIN: JP
Feb 22 05:43:04 volumio sudo[702]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up
Feb 22 05:43:04 volumio sudo[702]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 22 05:43:04 volumio sudo[702]: pam_unix(sudo:session): session closed for user root
Feb 22 05:43:04 volumio sudo[704]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw reg set JP
Feb 22 05:43:04 volumio sudo[704]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 22 05:43:04 volumio sudo[704]: pam_unix(sudo:session): session closed for user root
Feb 22 05:43:04 volumio wireless.js[447]: SUCCESSFULLY SET NEW REGDOMAIN: JP
Feb 22 05:43:04 volumio wireless.js[447]: Start wireless flow
Feb 22 05:43:04 volumio wireless.js[447]: Stopped hotspot (if there)..
Feb 22 05:43:04 volumio sudo[709]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0
Feb 22 05:43:04 volumio sudo[709]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 22 05:43:04 volumio sudo[709]: pam_unix(sudo:session): session closed for user root
Feb 22 05:43:04 volumio nmbd[560]: [2024/02/22 05:43:04.720801, 0] ../lib/util/become_daemon.c:138(daemon_ready)
Feb 22 05:43:04 volumio systemd[1]: Started Samba NMB Daemon.
Feb 22 05:43:04 volumio nmbd[560]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections
Feb 22 05:43:04 volumio sudo[711]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down
Feb 22 05:43:04 volumio sudo[711]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 22 05:43:04 volumio systemd[1]: Starting Samba Winbind Daemon...
Feb 22 05:43:04 volumio sudo[711]: pam_unix(sudo:session): session closed for user root
Feb 22 05:43:04 volumio wireless.js[447]: DHCP IP
Feb 22 05:43:04 volumio wireless.js[447]: Start ap
Feb 22 05:43:04 volumio wpa_supplicant[715]: Successfully initialized wpa_supplicant
Feb 22 05:43:04 volumio kernel: rtl8192cu: MAC auto ON okay!
Feb 22 05:43:04 volumio sudo[716]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd
Feb 22 05:43:04 volumio sudo[716]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 22 05:43:04 volumio dhcpcd[717]: dev: loaded udev
Feb 22 05:43:04 volumio kernel: rtl8192cu: Tx queue select: 0x05
Feb 22 05:43:05 volumio wireless.js[447]: trying...
Feb 22 05:43:06 volumio sudo[719]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Feb 22 05:43:06 volumio sudo[719]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 22 05:43:06 volumio winbindd[712]: [2024/02/22 05:43:06.614080, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache)
Feb 22 05:43:06 volumio winbindd[712]: initialize_winbindd_cache: clearing cache and re-creating with version number 2
Feb 22 05:43:06 volumio sudo[719]: pam_unix(sudo:session): session closed for user root
Feb 22 05:43:06 volumio winbindd[712]: [2024/02/22 05:43:06.679179, 0] ../lib/util/become_daemon.c:138(daemon_ready)
Feb 22 05:43:06 volumio winbindd[712]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections
Feb 22 05:43:06 volumio systemd[1]: Started Samba Winbind Daemon.
Feb 22 05:43:06 volumio dhcpcd[717]: wlan0: connected to Access Point `'
Feb 22 05:43:06 volumio systemd[1]: Starting Samba SMB Daemon...
Feb 22 05:43:06 volumio wireless.js[447]: trying...
Feb 22 05:43:06 volumio dhcpcd[717]: DUID 00:01:00:01:2d:69:1c:d0:b8:27:eb:2d:a1:ec
Feb 22 05:43:06 volumio dhcpcd[717]: eth0: IAID eb:2d:a1:ec
Feb 22 05:43:06 volumio dhcpcd[717]: eth0: adding address fe80::fee0:fa83:4d19:a2a3
Feb 22 05:43:06 volumio dhcpcd[717]: ipv6_addaddr1: Permission denied
Feb 22 05:43:06 volumio dhcpcd[717]: wlan0: waiting for carrier
Feb 22 05:43:06 volumio sudo[751]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Feb 22 05:43:06 volumio sudo[751]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 22 05:43:06 volumio sudo[751]: pam_unix(sudo:session): session closed for user root
Feb 22 05:43:06 volumio dhcpcd[717]: eth0: soliciting an IPv6 router
Feb 22 05:43:07 volumio systemd[1]: Started Samba SMB Daemon.
Feb 22 05:43:07 volumio smbd[741]: [2024/02/22 05:43:07.680189, 0] ../lib/util/become_daemon.c:138(daemon_ready)
Feb 22 05:43:07 volumio smbd[741]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections
Feb 22 05:43:07 volumio dhcpcd[717]: eth0: rebinding lease of 192.168.0.202
Feb 22 05:43:07 volumio wireless.js[447]: trying...
Feb 22 05:43:07 volumio sudo[761]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Feb 22 05:43:07 volumio sudo[761]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 22 05:43:07 volumio sudo[761]: pam_unix(sudo:session): session closed for user root
Feb 22 05:43:07 volumio dhcpcd[717]: eth0: leased 192.168.0.202 for infinity
Feb 22 05:43:07 volumio dhcpcd[717]: eth0: adding route to 192.168.0.0/24
Feb 22 05:43:07 volumio dhcpcd[717]: eth0: adding default route via 192.168.0.1
Feb 22 05:43:08 volumio wpa_supplicant[732]: wlan0: SME: Trying to authenticate with 6c:5a:b0:1d:bf:70 (SSID='4CE676C43020_A' freq=2417 MHz)
Feb 22 05:43:08 volumio kernel: wlan0: authenticate with 6c:5a:b0:1d:bf:70
Feb 22 05:43:08 volumio kernel: wlan0: 80 MHz not supported, disabling VHT
Feb 22 05:43:08 volumio kernel: wlan0: send auth to 6c:5a:b0:1d:bf:70 (try 1/3)
Feb 22 05:43:08 volumio dhcpcd[717]: forked to background, child pid 783
Feb 22 05:43:08 volumio kernel: wlan0: authenticated
Feb 22 05:43:08 volumio wpa_supplicant[732]: wlan0: Trying to associate with 6c:5a:b0:1d:bf:70 (SSID='4CE676C43020_A' freq=2417 MHz)
Feb 22 05:43:08 volumio kernel: wlan0: associate with 6c:5a:b0:1d:bf:70 (try 1/3)
Feb 22 05:43:08 volumio sudo[716]: pam_unix(sudo:session): session closed for user root
Feb 22 05:43:08 volumio kernel: wlan0: RX AssocResp from 6c:5a:b0:1d:bf:70 (capab=0x1411 status=0 aid=6)
Feb 22 05:43:08 volumio wpa_supplicant[732]: wlan0: Associated with 6c:5a:b0:1d:bf:70
Feb 22 05:43:08 volumio wpa_supplicant[732]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0
Feb 22 05:43:08 volumio wpa_supplicant[732]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=JP
Feb 22 05:43:08 volumio kernel: wlan0: associated
Feb 22 05:43:08 volumio kernel: wlan0: Limiting TX power to 30 (30 - 0) dBm as advertised by 6c:5a:b0:1d:bf:70
Feb 22 05:43:08 volumio kernel: cryptd: max_cpu_qlen set to 1000
Feb 22 05:43:08 volumio wpa_supplicant[732]: wlan0: WPA: Key negotiation completed with 6c:5a:b0:1d:bf:70 [PTK=CCMP GTK=CCMP]
Feb 22 05:43:08 volumio wpa_supplicant[732]: wlan0: CTRL-EVENT-CONNECTED - Connection to 6c:5a:b0:1d:bf:70 completed [id=0 id_str=]
Feb 22 05:43:08 volumio dhcpcd[783]: wlan0: carrier acquired
Feb 22 05:43:08 volumio dhcpcd[783]: wlan0: connected to Access Point `4CE676C43020_A'
Feb 22 05:43:08 volumio dhcpcd[783]: wlan0: IAID cf:f6:4e:60
Feb 22 05:43:08 volumio dhcpcd[783]: wlan0: adding address fe80::a6e7:b1e:60ab:86ef
Feb 22 05:43:08 volumio dhcpcd[783]: ipv6_addaddr1: Permission denied
Feb 22 05:43:08 volumio wireless.js[447]: trying...
Feb 22 05:43:08 volumio sudo[811]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Feb 22 05:43:08 volumio sudo[811]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 22 05:43:08 volumio sudo[811]: pam_unix(sudo:session): session closed for user root
Feb 22 05:43:08 volumio dhcpcd[783]: wlan0: soliciting a DHCP lease
Feb 22 05:43:09 volumio dhcpcd[783]: wlan0: soliciting an IPv6 router
Feb 22 05:43:09 volumio wireless.js[447]: trying...
Feb 22 05:43:09 volumio sudo[814]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Feb 22 05:43:09 volumio sudo[814]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 22 05:43:09 volumio sudo[814]: pam_unix(sudo:session): session closed for user root
Feb 22 05:43:10 volumio volumio-remote-updater[472]: [2024-02-22 05:43:10] [info] asio async_connect error: system:111 (Connection refused)
Feb 22 05:43:10 volumio volumio-remote-updater[472]: [2024-02-22 05:43:10] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Feb 22 05:43:10 volumio volumio-remote-updater[472]: [2024-02-22 05:43:10] [error] handle_connect error: Underlying Transport Error
Feb 22 05:43:10 volumio wireless.js[447]: trying...
Feb 22 05:43:10 volumio sudo[817]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Feb 22 05:43:10 volumio sudo[817]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 22 05:43:10 volumio sudo[817]: pam_unix(sudo:session): session closed for user root
Feb 22 05:43:11 volumio wireless.js[447]: trying...
Feb 22 05:43:11 volumio sudo[820]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Feb 22 05:43:11 volumio sudo[820]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 22 05:43:11 volumio sudo[820]: pam_unix(sudo:session): session closed for user root
Feb 22 05:43:12 volumio wireless.js[447]: trying...
Feb 22 05:43:12 volumio sudo[823]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Feb 22 05:43:12 volumio sudo[823]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 22 05:43:12 volumio sudo[823]: pam_unix(sudo:session): session closed for user root
Feb 22 05:43:13 volumio wireless.js[447]: trying...
Feb 22 05:43:13 volumio sudo[826]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Feb 22 05:43:13 volumio sudo[826]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 22 05:43:13 volumio sudo[826]: pam_unix(sudo:session): session closed for user root
Feb 22 05:43:13 volumio dhcpcd[783]: wlan0: probing for an IPv4LL address
Feb 22 05:43:14 volumio wireless.js[447]: trying...
Feb 22 05:43:14 volumio sudo[829]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Feb 22 05:43:14 volumio sudo[829]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 22 05:43:14 volumio sudo[829]: pam_unix(sudo:session): session closed for user root
Feb 22 05:43:15 volumio wireless.js[447]: trying...
Feb 22 05:43:15 volumio sudo[832]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Feb 22 05:43:15 volumio sudo[832]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 22 05:43:15 volumio sudo[832]: pam_unix(sudo:session): session closed for user root
Feb 22 05:43:16 volumio wireless.js[447]: trying...
Feb 22 05:43:16 volumio sudo[835]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Feb 22 05:43:16 volumio sudo[835]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 22 05:43:16 volumio sudo[835]: pam_unix(sudo:session): session closed for user root
Feb 22 05:43:17 volumio wireless.js[447]: trying...
Feb 22 05:43:17 volumio sudo[838]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Feb 22 05:43:17 volumio sudo[838]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 22 05:43:17 volumio sudo[838]: pam_unix(sudo:session): session closed for user root
Feb 22 05:43:18 volumio wireless.js[447]: trying...
Feb 22 05:43:18 volumio dhcpcd[783]: wlan0: using IPv4LL address 169.254.31.109
Feb 22 05:43:18 volumio dhcpcd[783]: wlan0: adding route to 169.254.0.0/16
Feb 22 05:43:18 volumio avahi-daemon[444]: Joining mDNS multicast group on interface wlan0.IPv4 with address 169.254.31.109.
Feb 22 05:43:18 volumio avahi-daemon[444]: New relevant interface wlan0.IPv4 for mDNS.
Feb 22 05:43:18 volumio avahi-daemon[444]: Registering new address record for 169.254.31.109 on wlan0.IPv4.
Feb 22 05:43:18 volumio sudo[842]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Feb 22 05:43:18 volumio sudo[842]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 22 05:43:18 volumio sudo[842]: pam_unix(sudo:session): session closed for user root
Feb 22 05:43:18 volumio wireless.js[447]: Connected to: ----4CE676C43020_A
Feb 22 05:43:18 volumio wireless.js[447]: ----
Feb 22 05:43:18 volumio sudo[857]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Feb 22 05:43:19 volumio sudo[857]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 22 05:43:19 volumio sudo[857]: pam_unix(sudo:session): session closed for user root
Feb 22 05:43:19 volumio wireless.js[447]: ... joined AP, wlan0 IPv4 is 169.254.31.109, ipV6 is undefined
Feb 22 05:43:19 volumio wireless.js[447]: It's done! AP
Feb 22 05:43:19 volumio iwconfig[866]: Error for wireless request "Set Power Management" (8B2C) :
Feb 22 05:43:19 volumio iwconfig[866]: SET failed on device wlan0 ; Operation not supported.
Feb 22 05:43:19 volumio systemd[1]: Started Wireless Services.
Feb 22 05:43:19 volumio systemd[1]: Started Volumio Backend Module.
Feb 22 05:43:19 volumio systemd[1]: Started Volumio Cpu Tweaker.
Feb 22 05:43:19 volumio systemd[1]: Reached target Multi-User System.
Feb 22 05:43:19 volumio systemd[1]: Reached target Graphical Interface.
Feb 22 05:43:19 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes...
Feb 22 05:43:19 volumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded.
Feb 22 05:43:19 volumio systemd[1]: Started Update UTMP about System Runlevel Changes.
Feb 22 05:43:19 volumio volumio-cpu-tweak[868]: Setting RT Priority for mpd
Feb 22 05:43:19 volumio systemd[1]: Startup finished in 11.157s (kernel) + 34.990s (userspace) = 46.148s.
Feb 22 05:43:19 volumio volumio-cpu-tweak[868]: pid 35's current scheduling policy: SCHED_OTHER
Feb 22 05:43:19 volumio volumio-cpu-tweak[868]: pid 35's current scheduling priority: 0
Feb 22 05:43:19 volumio volumio-cpu-tweak[868]: Setting MPD Affinity
Feb 22 05:43:19 volumio volumio-cpu-tweak[868]: pid 3's current affinity mask: f
Feb 22 05:43:19 volumio volumio-cpu-tweak[868]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input
Feb 22 05:43:19 volumio volumio-cpu-tweak[868]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance
Feb 22 05:43:19 volumio systemd[1]: volumio_cpu_tweak.service: Succeeded.
Feb 22 05:43:20 volumio ntpd[585]: Listen normally on 4 wlan0 169.254.31.109:123
Feb 22 05:43:20 volumio ntpd[585]: new interface(s) found: waking up resolver
Feb 22 05:43:20 volumio volumio-remote-updater[472]: [2024-02-22 05:43:20] [info] asio async_connect error: system:111 (Connection refused)
Feb 22 05:43:20 volumio volumio-remote-updater[472]: [2024-02-22 05:43:20] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Feb 22 05:43:20 volumio volumio-remote-updater[472]: [2024-02-22 05:43:20] [error] handle_connect error: Underlying Transport Error
Feb 22 05:43:23 volumio systemd[1]: systemd-fsckd.service: Succeeded.
Feb 22 05:43:28 volumio volumio[867]: info: -------------------------------------------
Feb 22 05:43:28 volumio volumio[867]: info: ----- Volumio3 ----
Feb 22 05:43:28 volumio volumio[867]: info: -------------------------------------------
Feb 22 05:43:28 volumio volumio[867]: info: ----- System startup ----
Feb 22 05:43:28 volumio volumio[867]: info: -------------------------------------------
Feb 22 05:43:30 volumio volumio[867]: info: MYVOLUMIO Environment detected
Feb 22 05:43:30 volumio volumio[867]: info: Plugin folders cleanup
Feb 22 05:43:30 volumio volumio[867]: info: Scanning into folder /volumio/app/plugins/
Feb 22 05:43:30 volumio volumio[867]: info: Scanning category audio_interface
Feb 22 05:43:30 volumio volumio[867]: info: Scanning category miscellanea
Feb 22 05:43:30 volumio volumio[867]: info: Scanning category music_service
Feb 22 05:43:30 volumio volumio[867]: info: Scanning category plugins.json
Feb 22 05:43:30 volumio volumio[867]: info: Scanning category system_controller
Feb 22 05:43:30 volumio volumio[867]: info: Scanning category user_interface
Feb 22 05:43:30 volumio volumio[867]: info: Scanning into folder /data/plugins/
Feb 22 05:43:30 volumio volumio[867]: info: Plugin folders cleanup completed
Feb 22 05:43:30 volumio volumio[867]: info: -------------------------------------------
Feb 22 05:43:30 volumio volumio[867]: info: ----- Core plugins startup ----
Feb 22 05:43:30 volumio volumio[867]: info: -------------------------------------------
Feb 22 05:43:30 volumio volumio[867]: info: Loading plugins from folder /volumio/app/plugins/
Feb 22 05:43:30 volumio volumio[867]: info: Adding plugin upnp to MyMusic Plugins
Feb 22 05:43:30 volumio volumio[867]: info: Adding plugin airplay_emulation to MyMusic Plugins
Feb 22 05:43:30 volumio volumio[867]: info: Adding plugin upnp_browser to MyMusic Plugins
Feb 22 05:43:30 volumio volumio[867]: info: Loading plugins from folder /data/plugins/
Feb 22 05:43:30 volumio volumio[867]: info: Loading plugin "system"...
Feb 22 05:43:30 volumio volumio-remote-updater[472]: [2024-02-22 05:43:30] [connect] Successful connection
Feb 22 05:43:30 volumio volumio[867]: info: Loading plugin "appearance"...
Feb 22 05:43:33 volumio volumio[867]: info: Loading plugin "network"...
Feb 22 05:43:33 volumio volumio[867]: info: Refreshing Cached IP Addresses
Feb 22 05:43:33 volumio sudo[899]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Feb 22 05:43:33 volumio sudo[899]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 22 05:43:33 volumio sudo[899]: pam_unix(sudo:session): session closed for user root
Feb 22 05:43:33 volumio volumio[867]: info: Loading plugin "services"...
Feb 22 05:43:33 volumio sudo[901]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Feb 22 05:43:33 volumio sudo[901]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 22 05:43:33 volumio volumio[867]: info: Loading plugin "alsa_controller"...
Feb 22 05:43:33 volumio sudo[901]: pam_unix(sudo:session): session closed for user root
Feb 22 05:43:33 volumio sudo[904]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Feb 22 05:43:33 volumio sudo[904]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 22 05:43:33 volumio volumio[867]: warn: Unable to locate the audio output device HiFiBerry DAC+ Pro. Please configure a valid output device.
Feb 22 05:43:33 volumio volumio[867]: Invalid card number.
Feb 22 05:43:33 volumio volumio[867]: info: Hardware Mixer selected but no Hardware mixer available, detecting default mixer
Feb 22 05:43:33 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Feb 22 05:43:33 volumio volumio[867]: Invalid card number.
Feb 22 05:43:33 volumio volumio[867]: info: CoreCommandRouter::volumioUpdateVolumeSettings
Feb 22 05:43:33 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Feb 22 05:43:33 volumio volumio[867]: info: Loading plugin "wizard"...
Feb 22 05:43:33 volumio volumio[867]: info: Loading plugin "networkfs"...
Feb 22 05:43:34 volumio volumio[867]: info: Starting Udev Watcher for removable devices
Feb 22 05:43:34 volumio volumio[867]: info: Ignoring mount for partition: boot
Feb 22 05:43:34 volumio volumio[867]: info: Ignoring mount for partition: volumio
Feb 22 05:43:34 volumio volumio[867]: info: Ignoring mount for partition: volumio_data
Feb 22 05:43:34 volumio volumio[867]: info: Mounting Device クラシック・ジャズ・ハイレゾ・落語
Feb 22 05:43:34 volumio sudo[921]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sdb1 /mnt/USB/クラシック・ジャズ・ハイレゾ・落語 -o noatime,dmask=0000,fmask=0000,iocharset=utf8
Feb 22 05:43:34 volumio sudo[921]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 22 05:43:34 volumio kernel: fuse: init (API version 7.37)
Feb 22 05:43:34 volumio systemd[1]: Mounting FUSE Control File System...
Feb 22 05:43:34 volumio systemd[1]: Mounted FUSE Control File System.
Feb 22 05:43:34 volumio ntfs-3g[928]: Version 2017.3.23AR.3 integrated FUSE 28
Feb 22 05:43:34 volumio ntfs-3g[928]: Mounted /dev/sdb1 (Read-Write, label "クラシック・ジャズ・ハイレゾ・落語", NTFS 3.1)
Feb 22 05:43:34 volumio ntfs-3g[928]: Cmdline options: rw,noatime,dmask=0000,fmask=0000,iocharset=utf8
Feb 22 05:43:34 volumio ntfs-3g[928]: Mount options: iocharset=utf8,allow_other,nonempty,noatime,rw,default_permissions,fsname=/dev/sdb1,blkdev,blksize=4096
Feb 22 05:43:34 volumio ntfs-3g[928]: Global ownership and permissions enforced, configuration type 7
Feb 22 05:43:34 volumio sudo[921]: pam_unix(sudo:session): session closed for user root
Feb 22 05:43:34 volumio volumio[867]: info: Mounting Device Music
Feb 22 05:43:34 volumio sudo[933]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/Music -o noatime,dmask=0000,fmask=0000,iocharset=utf8
Feb 22 05:43:34 volumio sudo[933]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 22 05:43:35 volumio ntfs-3g[936]: Version 2017.3.23AR.3 integrated FUSE 28
Feb 22 05:43:35 volumio ntfs-3g[936]: Mounted /dev/sda1 (Read-Write, label "Music", NTFS 3.1)
Feb 22 05:43:35 volumio ntfs-3g[936]: Cmdline options: rw,noatime,dmask=0000,fmask=0000,iocharset=utf8
Feb 22 05:43:35 volumio ntfs-3g[936]: Mount options: iocharset=utf8,allow_other,nonempty,noatime,rw,default_permissions,fsname=/dev/sda1,blkdev,blksize=4096
Feb 22 05:43:35 volumio ntfs-3g[936]: Global ownership and permissions enforced, configuration type 7
Feb 22 05:43:35 volumio sudo[933]: pam_unix(sudo:session): session closed for user root
Feb 22 05:43:35 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Feb 22 05:43:35 volumio volumio[867]: info: Loading plugin "volumio_command_line_client"...
Feb 22 05:43:35 volumio volumio[867]: info: Loading plugin "upnp"...
Feb 22 05:43:35 volumio volumio[867]: info: [1708548215844] Starting Upmpd Daemon
Feb 22 05:43:35 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Feb 22 05:43:35 volumio volumio[867]: info: Loading plugin "my_music"...
Feb 22 05:43:35 volumio volumio[867]: info: Loading plugin "mpd"...
Feb 22 05:43:36 volumio volumio[867]: info: Loading plugin "upnp_browser"...
Feb 22 05:43:37 volumio sudo[904]: pam_unix(sudo:session): session closed for user root
Feb 22 05:43:37 volumio volumio[867]: info: Loading plugin "alarm-clock"...
Feb 22 05:43:38 volumio volumio[867]: info: Loading plugin "airplay_emulation"...
Feb 22 05:43:38 volumio volumio[867]: info: Starting Shairport Sync
Feb 22 05:43:38 volumio volumio[867]: info: Loading plugin "last_100"...
Feb 22 05:43:38 volumio volumio[867]: info: Loading plugin "webradio"...
Feb 22 05:43:38 volumio volumio[867]: info: Loading plugin "i2s_dacs"...
Feb 22 05:43:38 volumio volumio[867]: info: Loading plugin "volumiodiscovery"...
Feb 22 05:43:38 volumio volumio[867]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Feb 22 05:43:38 volumio volumio[867]: *** WARNING *** Please fix your application to use the native API of Avahi!
Feb 22 05:43:38 volumio node[867]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Feb 22 05:43:38 volumio volumio[867]: *** WARNING *** For more information see
Feb 22 05:43:38 volumio volumio[867]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Feb 22 05:43:38 volumio volumio[867]: *** WARNING *** Please fix your application to use the native API of Avahi!
Feb 22 05:43:38 volumio volumio[867]: *** WARNING *** For more information see
Feb 22 05:43:38 volumio node[867]: *** WARNING *** Please fix your application to use the native API of Avahi!
Feb 22 05:43:38 volumio node[867]: *** WARNING *** For more information see
Feb 22 05:43:38 volumio node[867]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Feb 22 05:43:38 volumio node[867]: *** WARNING *** Please fix your application to use the native API of Avahi!
Feb 22 05:43:38 volumio node[867]: *** WARNING *** For more information see
Feb 22 05:43:38 volumio volumio[867]: info: Applying required configuration parameters for plugin volumiodiscovery
Feb 22 05:43:38 volumio volumio[867]: info: Discovery: Started advertising with name: Volumio
Feb 22 05:43:38 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Feb 22 05:43:38 volumio volumio[867]: info: Loading plugin "outputs"...
Feb 22 05:43:38 volumio volumio[867]: info: Loading plugin "albumart"...
Feb 22 05:43:38 volumio volumio[867]: info: Plugin example_plugin is not enabled
Feb 22 05:43:38 volumio volumio[867]: info: Loading plugin "inputs"...
Feb 22 05:43:38 volumio volumio[867]: info: Loading plugin "updater_comm"...
Feb 22 05:43:39 volumio volumio[867]: info: Plugin mpdemulation is not enabled
Feb 22 05:43:39 volumio volumio[867]: info: Loading plugin "rest_api"...
Feb 22 05:43:39 volumio volumio[867]: info: Loading plugin "websocket"...
Feb 22 05:43:39 volumio volumio[867]: info: Loading i18n strings for locale ja
Feb 22 05:43:39 volumio volumio[867]: Updating browse sources language
Feb 22 05:43:39 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Feb 22 05:43:39 volumio volumio[867]: Forking 3 albumart workers
Feb 22 05:43:40 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 22 05:43:40 volumio volumio[867]: info: CoreCommandRouter::initPlayerControls
Feb 22 05:43:40 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 22 05:43:40 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 22 05:43:40 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 22 05:43:40 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 22 05:43:40 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 22 05:43:40 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 22 05:43:40 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 22 05:43:40 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 22 05:43:40 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 22 05:43:40 volumio volumio[867]: Express server listening on port 3000
Feb 22 05:43:40 volumio volumio[867]: [Metrics] WebUI: 17s 342.15ms
Feb 22 05:43:40 volumio volumio[867]: info: CoreStateMachine::resetVolumioState
Feb 22 05:43:40 volumio volumio[867]: info: CoreStateMachine::getcurrentVolume
Feb 22 05:43:40 volumio volumio[867]: info: CoreCommandRouter::volumioRetrievevolume
Feb 22 05:43:40 volumio volumio[867]: info: CoreCommandRouter::volumioRetrieveVolumeLevels
Feb 22 05:43:40 volumio volumio[867]: info: CoreStateMachine::getcurrentVolume
Feb 22 05:43:40 volumio volumio[867]: info: CoreCommandRouter::volumioRetrievevolume
Feb 22 05:43:40 volumio volumio[867]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number.
Feb 22 05:43:40 volumio volumio[867]: info: VolumeController:: Volume=undefined Mute =false
Feb 22 05:43:40 volumio volumio[867]: info: CoreStateMachine::pushState
Feb 22 05:43:40 volumio volumio[867]: info: CorePlayQueue::getTrack 0
Feb 22 05:43:40 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 22 05:43:40 volumio volumio[867]: info: CoreCommandRouter::volumioPushState
Feb 22 05:43:40 volumio volumio[867]: info: CoreStateMachine::updateTrackBlock
Feb 22 05:43:40 volumio volumio[867]: info: CorePlayQueue::getTrackBlock
Feb 22 05:43:40 volumio volumio[867]: info: CoreCommandRouter::volumioRetrievevolume
Feb 22 05:43:40 volumio volumio[867]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number.
Feb 22 05:43:41 volumio volumio[867]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number.
Feb 22 05:43:41 volumio volumio[867]: MPD error: Cannot assign requested address
Feb 22 05:43:41 volumio volumio[867]: MPD error: Cannot assign requested address
Feb 22 05:43:41 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 22 05:43:41 volumio volumio[867]: info: VolumeController:: Volume=undefined Mute =false
Feb 22 05:43:41 volumio volumio[867]: info: CoreStateMachine::pushState
Feb 22 05:43:41 volumio volumio[867]: info: CorePlayQueue::getTrack 0
Feb 22 05:43:41 volumio volumio[867]: info: CoreCommandRouter::volumioPushState
Feb 22 05:43:41 volumio volumio[867]: info: CoreStateMachine::updateTrackBlock
Feb 22 05:43:41 volumio volumio[867]: info: CorePlayQueue::getTrackBlock
Feb 22 05:43:41 volumio volumio[867]: info: CoreCommandRouter::volumioRetrievevolume
Feb 22 05:43:41 volumio volumio[867]: info: CoreStateMachine::setRepeat null single undefined
Feb 22 05:43:41 volumio volumio[867]: info: CoreStateMachine::pushState
Feb 22 05:43:41 volumio volumio[867]: info: CorePlayQueue::getTrack 0
Feb 22 05:43:41 volumio volumio[867]: info: CoreCommandRouter::volumioPushState
Feb 22 05:43:41 volumio volumio[867]: info: CoreStateMachine::setRandom null
Feb 22 05:43:41 volumio volumio[867]: info: CoreStateMachine::pushState
Feb 22 05:43:41 volumio volumio[867]: info: CorePlayQueue::getTrack 0
Feb 22 05:43:41 volumio volumio[867]: info: CoreCommandRouter::volumioPushState
Feb 22 05:43:41 volumio volumio[867]: info: Setting Device type: Raspberry PI
Feb 22 05:43:41 volumio volumio[867]: Starting albumart workers
Feb 22 05:43:41 volumio volumio[867]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number.
Feb 22 05:43:41 volumio volumio[867]: info: VolumeController:: Volume=undefined Mute =false
Feb 22 05:43:41 volumio volumio[867]: info: CoreStateMachine::pushState
Feb 22 05:43:41 volumio volumio[867]: info: CorePlayQueue::getTrack 0
Feb 22 05:43:41 volumio volumio[867]: info: CoreCommandRouter::volumioPushState
Feb 22 05:43:41 volumio volumio[867]: Starting albumart workers
Feb 22 05:43:41 volumio volumio[867]: info: VolumeController:: Volume=undefined Mute =false
Feb 22 05:43:41 volumio volumio[867]: info: CoreStateMachine::pushState
Feb 22 05:43:41 volumio volumio[867]: info: CorePlayQueue::getTrack 0
Feb 22 05:43:41 volumio volumio[867]: info: CoreCommandRouter::volumioPushState
Feb 22 05:43:41 volumio volumio[867]: Starting albumart workers
Feb 22 05:43:43 volumio sudo[1014]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Feb 22 05:43:43 volumio sudo[1014]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 22 05:43:43 volumio sudo[1014]: pam_unix(sudo:session): session closed for user root
Feb 22 05:43:43 volumio sudo[1016]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Feb 22 05:43:43 volumio sudo[1016]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 22 05:43:43 volumio sudo[1016]: pam_unix(sudo:session): session closed for user root
Feb 22 05:43:43 volumio volumio[867]: verbose: New Socket.io Connection to 192.168.0.202 from 192.168.0.248 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/123.0.0.0 Safari/537.36 Edg/123.0.0.0 Total Clients: 1
Feb 22 05:43:44 volumio sudo[1020]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Feb 22 05:43:44 volumio sudo[1020]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 22 05:43:44 volumio sudo[1020]: pam_unix(sudo:session): session closed for user root
Feb 22 05:43:44 volumio sudo[1022]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Feb 22 05:43:44 volumio sudo[1022]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 22 05:43:44 volumio sudo[1022]: pam_unix(sudo:session): session closed for user root
Feb 22 05:43:44 volumio volumio[867]: verbose: New Socket.io Connection to 192.168.0.202 from 192.168.0.248 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/123.0.0.0 Safari/537.36 Edg/123.0.0.0 Total Clients: 2
Feb 22 05:43:44 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Feb 22 05:43:44 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Feb 22 05:43:44 volumio volumio[867]: info: CoreCommandRouter::volumioGetVisibleSources
Feb 22 05:43:44 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Feb 22 05:43:44 volumio volumio[867]: info: CoreCommandRouter::volumioGetState
Feb 22 05:43:44 volumio volumio[867]: info: CorePlayQueue::getTrack 0
Feb 22 05:43:44 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Feb 22 05:43:44 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Feb 22 05:43:44 volumio volumio[867]: info: Received Get System Info
Feb 22 05:43:44 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 22 05:43:44 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 22 05:43:44 volumio volumio[867]: info: Discovery: Getting this device information
Feb 22 05:43:44 volumio volumio[867]: info: CoreCommandRouter::volumioGetState
Feb 22 05:43:44 volumio volumio[867]: info: CorePlayQueue::getTrack 0
Feb 22 05:43:44 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 22 05:43:44 volumio volumio[867]: info: CoreCommandRouter::volumioGetState
Feb 22 05:43:44 volumio volumio[867]: info: CorePlayQueue::getTrack 0
Feb 22 05:43:44 volumio volumio[867]: info: Listing playlists
Feb 22 05:43:44 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Feb 22 05:43:44 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Feb 22 05:43:45 volumio volumio-remote-updater[472]: [2024-02-22 05:43:45] [connect] Successful connection
Feb 22 05:43:45 volumio volumio-remote-updater[472]: [2024-02-22 05:43:45] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1708548225 101
Feb 22 05:43:45 volumio volumio[867]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 3
Feb 22 05:43:45 volumio volumio[867]: info: CoreCommandRouter::volumioGetState
Feb 22 05:43:45 volumio volumio[867]: info: CorePlayQueue::getTrack 0
Feb 22 05:43:45 volumio sudo[1026]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Feb 22 05:43:45 volumio sudo[1026]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 22 05:43:45 volumio sudo[1026]: pam_unix(sudo:session): session closed for user root
Feb 22 05:43:45 volumio sudo[1028]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Feb 22 05:43:45 volumio sudo[1028]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 22 05:43:45 volumio sudo[1028]: pam_unix(sudo:session): session closed for user root
Feb 22 05:43:45 volumio sudo[1031]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
Feb 22 05:43:45 volumio sudo[1031]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 22 05:43:46 volumio systemd[1]: Started UPnP Renderer front-end to MPD.
Feb 22 05:43:46 volumio sudo[1031]: pam_unix(sudo:session): session closed for user root
Feb 22 05:43:46 volumio volumio[867]: info: Upmpdcli Daemon Started
Feb 22 05:43:46 volumio volumio[867]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600
Feb 22 05:43:46 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Feb 22 05:43:46 volumio volumio[867]: info: Received Get System Info
Feb 22 05:43:46 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 22 05:43:46 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 22 05:43:46 volumio volumio[867]: info: Discovery: Getting this device information
Feb 22 05:43:46 volumio volumio[867]: info: CoreCommandRouter::volumioGetState
Feb 22 05:43:46 volumio volumio[867]: info: CorePlayQueue::getTrack 0
Feb 22 05:43:46 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 22 05:43:50 volumio volumio[867]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600
Feb 22 05:43:52 volumio volumio[867]: info: CoreCommandRouter::getUIConfigOnPlugin
Feb 22 05:43:52 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Feb 22 05:43:52 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Feb 22 05:43:52 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Feb 22 05:43:52 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Feb 22 05:43:52 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 22 05:43:52 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 22 05:43:52 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 22 05:43:52 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 22 05:43:52 volumio volumio[867]: info: CoreCommandRouter::volumioGetBrowseSources
Feb 22 05:43:52 volumio volumio[867]: info: CoreCommandRouter::volumioGetBrowseSources
Feb 22 05:43:52 volumio volumio[867]: info: CoreCommandRouter::volumioGetBrowseSources
Feb 22 05:43:52 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Feb 22 05:43:52 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
Feb 22 05:43:56 volumio volumio[867]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600
Feb 22 05:43:56 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Feb 22 05:43:59 volumio volumio[867]: info: CoreCommandRouter::volumioGetState
Feb 22 05:43:59 volumio volumio[867]: info: CorePlayQueue::getTrack 0
Feb 22 05:44:01 volumio volumio[867]: info: CoreCommandRouter::getUIConfigOnPlugin
Feb 22 05:44:01 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Feb 22 05:44:01 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Feb 22 05:44:01 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Feb 22 05:44:01 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Feb 22 05:44:01 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 22 05:44:01 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 22 05:44:01 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 22 05:44:01 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 22 05:44:01 volumio volumio[867]: info: CoreCommandRouter::volumioGetBrowseSources
Feb 22 05:44:01 volumio volumio[867]: info: CoreCommandRouter::volumioGetBrowseSources
Feb 22 05:44:01 volumio volumio[867]: info: CoreCommandRouter::volumioGetBrowseSources
Feb 22 05:44:01 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Feb 22 05:44:01 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
Feb 22 05:44:03 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Feb 22 05:44:03 volumio volumio[867]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
Feb 22 05:44:03 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
Feb 22 05:44:03 volumio volumio[867]: info: Received Get System Version
Feb 22 05:44:03 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Feb 22 05:44:03 volumio volumio[867]: info: Received Get System Info
Feb 22 05:44:03 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 22 05:44:03 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 22 05:44:03 volumio volumio[867]: info: Discovery: Getting this device information
Feb 22 05:44:03 volumio volumio[867]: info: CoreCommandRouter::volumioGetState
Feb 22 05:44:03 volumio volumio[867]: info: CorePlayQueue::getTrack 0
Feb 22 05:44:03 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 22 05:44:03 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb
Feb 22 05:44:03 volumio volumio[867]: verbose: ControllerMpd::sendMpdCommand update
Feb 22 05:44:03 volumio volumio[867]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 22 05:44:03 volumio volumio[867]: TypeError: Cannot read property 'then' of undefined
Feb 22 05:44:03 volumio volumio[867]: at ControllerMpd.sendMpdCommand (/volumio/app/plugins/music_service/mpd/index.js:331:6)
Feb 22 05:44:03 volumio volumio[867]: at ControllerMpd.updateDb (/volumio/app/plugins/music_service/mpd/index.js:1898:15)
Feb 22 05:44:03 volumio volumio[867]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1077:32)
Feb 22 05:44:03 volumio volumio[867]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1049:26)
Feb 22 05:44:03 volumio volumio[867]: at Socket.emit (events.js:315:20)
Feb 22 05:44:03 volumio volumio[867]: at /volumio/node_modules/socket.io/lib/socket.js:503:12
Feb 22 05:44:03 volumio volumio[867]: at processTicksAndRejections (internal/process/task_queues.js:75:11)
Feb 22 05:44:03 volumio volumio[867]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 22 05:44:04 volumio sudo[1079]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-02-22 05:43
Feb 22 05:44:04 volumio sudo[1079]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Raspbian GNU/Linux 10 (buster)"
NAME="Raspbian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=raspbian
ID_LIKE=debian
HOME_URL="http://www.raspbian.org/"
SUPPORT_URL="http://www.raspbian.org/RaspbianForums"
BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs"
VOLUMIO_BUILD_VERSION="7f9f1bf001add7a8b19a4516e3c74ef598b2730d"
VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71"
VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1"
VOLUMIO_BE_VERSION="512433c3e91cdaed7ecd2808b21adeffc2137d7f"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Wed 21 Feb 2024 09:37:22 PM CET"
VOLUMIO_VERSION="3.631"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="fdd9dd1169c06c1ad0a30ddd24c91b6b"