-- Logs begin at Wed 2021-10-06 13:44:32 UTC, end at Wed 2021-10-06 13:46:54 UTC. --
Oct 06 13:45:01 volumio volumio[479]: Could not open config: /tmp/upmpdcli.conf
Oct 06 13:45:01 volumio systemd[1]: upmpdcli.service: main process exited, code=exited, status=1/FAILURE
Oct 06 13:45:01 volumio systemd[1]: Unit upmpdcli.service entered failed state.
Oct 06 13:45:02 volumio systemd-logind[499]: New seat seat0.
Oct 06 13:45:02 volumio systemd[1]: Started Login Service.
Oct 06 13:45:02 volumio systemd[1]: Starting Disk Manager (legacy version)...
Oct 06 13:45:03 volumio systemd[1]: Starting OpenBSD Secure Shell server...
Oct 06 13:45:03 volumio systemd[1]: Starting Load/Save RF Kill Switch Status of rfkill1...
Oct 06 13:45:03 volumio systemd[1]: Starting Bluetooth service...
Oct 06 13:45:03 volumio systemd[1]: Starting LSB: set CPUFreq kernel parameters...
Oct 06 13:45:03 volumio systemd[1]: Starting Hold until boot process finishes up...
Oct 06 13:45:03 volumio systemd[1]: Starting Terminate Plymouth Boot Screen...
Oct 06 13:45:04 volumio systemd[1]: Received SIGRTMIN+21 from PID 199 (plymouthd).
Oct 06 13:45:04 volumio systemd[1]: Started Load/Save RF Kill Switch Status of rfkill1.
Oct 06 13:45:04 volumio systemd[1]: Started Hold until boot process finishes up.
Oct 06 13:45:04 volumio systemd[1]: Started Terminate Plymouth Boot Screen.
Oct 06 13:45:04 volumio volumio-remote-updater[480]: [2021-10-06 13:45:04] [info] asio async_connect error: system:111 (Connection refused)
Oct 06 13:45:04 volumio volumio-remote-updater[480]: [2021-10-06 13:45:04] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Oct 06 13:45:04 volumio volumio-remote-updater[480]: [2021-10-06 13:45:04] [error] handle_connect error: Underlying Transport Error
Oct 06 13:45:05 volumio bluetoothd[642]: Bluetooth daemon 5.23
Oct 06 13:45:05 volumio dbus[560]: [system] Successfully activated service 'org.freedesktop.UDisks'
Oct 06 13:45:05 volumio cpufrequtils[643]: CPUFreq Utilities: Setting performance CPUFreq governor...CPU0...done.
Oct 06 13:45:05 volumio systemd[1]: Started LSB: set CPUFreq kernel parameters.
Oct 06 13:45:05 volumio bluetoothd[642]: Starting SDP server
Oct 06 13:45:05 volumio bluetoothd[642]: Excluding (cli) sap
Oct 06 13:45:05 volumio systemd[1]: Started Disk Manager (legacy version).
Oct 06 13:45:05 volumio kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3
Oct 06 13:45:05 volumio kernel: Bluetooth: BNEP filters: protocol multicast
Oct 06 13:45:05 volumio kernel: Bluetooth: BNEP socket layer initialized
Oct 06 13:45:06 volumio bluetoothd[642]: Bluetooth management interface 1.14 initialized
Oct 06 13:45:06 volumio dbus[560]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service'
Oct 06 13:45:06 volumio dbus[560]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkitd.service'
Oct 06 13:45:06 volumio systemd[1]: Started OpenBSD Secure Shell server.
Oct 06 13:45:06 volumio sudo[497]: pam_unix(sudo:session): session closed for user root
Oct 06 13:45:06 volumio systemd[1]: Started Bluetooth service.
Oct 06 13:45:06 volumio sshd[664]: Server listening on 0.0.0.0 port 22.
Oct 06 13:45:06 volumio sshd[664]: Server listening on :: port 22.
Oct 06 13:45:07 volumio systemd[1]: Starting Authenticate and Authorize Users to Run Privileged Tasks...
Oct 06 13:45:07 volumio systemd[1]: Starting Hostname Service...
Oct 06 13:45:07 volumio systemd[1]: Starting Bluetooth.
Oct 06 13:45:07 volumio systemd[1]: Reached target Bluetooth.
Oct 06 13:45:07 volumio systemd[1]: Starting Getty on tty1...
Oct 06 13:45:08 volumio systemd[1]: Started Getty on tty1.
Oct 06 13:45:08 volumio systemd[1]: Starting Login Prompts.
Oct 06 13:45:08 volumio systemd[1]: Reached target Login Prompts.
Oct 06 13:45:08 volumio ntpd[585]: Deferring DNS for 0.debian.pool.ntp.org 1
Oct 06 13:45:08 volumio polkitd[673]: started daemon version 0.105 using authority implementation `local' version `0.105'
Oct 06 13:45:08 volumio dbus[560]: [system] Successfully activated service 'org.freedesktop.PolicyKit1'
Oct 06 13:45:08 volumio ntpd[585]: Deferring DNS for 1.debian.pool.ntp.org 1
Oct 06 13:45:08 volumio ntpd[585]: Deferring DNS for 2.debian.pool.ntp.org 1
Oct 06 13:45:08 volumio ntpd[585]: Deferring DNS for 3.debian.pool.ntp.org 1
Oct 06 13:45:08 volumio systemd-hostnamed[674]: Warning: nss-myhostname is not installed. Changing the local hostname might make it unresolveable. Please install nss-myhostname!
Oct 06 13:45:09 volumio ntpd[679]: signal_no_reset: signal 17 had flags 4000000
Oct 06 13:45:09 volumio dbus[560]: [system] Successfully activated service 'org.freedesktop.hostname1'
Oct 06 13:45:10 volumio udisks-glue[475]: Device file /dev/sda1 inserted
Oct 06 13:45:10 volumio udisks-glue[475]: Trying to automount /dev/sda1...
Oct 06 13:45:11 volumio ntpd_intres[679]: host name not found: 0.debian.pool.ntp.org
Oct 06 13:45:11 volumio systemd[1]: Started Authenticate and Authorize Users to Run Privileged Tasks.
Oct 06 13:45:11 volumio ntpd_intres[679]: host name not found: 1.debian.pool.ntp.org
Oct 06 13:45:11 volumio ntpd_intres[679]: host name not found: 2.debian.pool.ntp.org
Oct 06 13:45:11 volumio ntpd_intres[679]: host name not found: 3.debian.pool.ntp.org
Oct 06 13:45:11 volumio systemd[1]: Started Hostname Service.
Oct 06 13:45:11 volumio kernel: FAT-fs (sda1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck.
Oct 06 13:45:11 volumio udisks-glue[475]: Successfully automounted /dev/sda1 at /media/UTO4G_K_
Oct 06 13:45:12 volumio udisks-glue[475]: Device file /dev/sda inserted
Oct 06 13:45:12 volumio udisks-glue[475]: Device file /dev/mmcblk0 inserted
Oct 06 13:45:12 volumio volumio-remote-updater[480]: [2021-10-06 13:45:12] [info] asio async_connect error: system:111 (Connection refused)
Oct 06 13:45:12 volumio volumio-remote-updater[480]: [2021-10-06 13:45:12] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Oct 06 13:45:12 volumio volumio-remote-updater[480]: [2021-10-06 13:45:12] [error] handle_connect error: Underlying Transport Error
Oct 06 13:45:12 volumio udisks-glue[475]: Device file /dev/sda1 mounted at /media/UTO4G_K_
Oct 06 13:45:19 volumio haveged[472]: haveged: ver: 1.9.1; arch: generic; vend: ; build: (gcc 4.8.2 CTV); collect: 128K
Oct 06 13:45:19 volumio haveged[472]: haveged: cpu: (VC); data: 16K (D); inst: 16K (D); idx: 8/40; sz: 15248/74244
Oct 06 13:45:19 volumio haveged[472]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 7.99806
Oct 06 13:45:19 volumio haveged[472]: haveged: fills: 0, generated: 0
Oct 06 13:45:22 volumio volumio-remote-updater[480]: [2021-10-06 13:45:22] [info] asio async_connect error: system:111 (Connection refused)
Oct 06 13:45:22 volumio volumio-remote-updater[480]: [2021-10-06 13:45:22] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Oct 06 13:45:22 volumio volumio-remote-updater[480]: [2021-10-06 13:45:22] [error] handle_connect error: Underlying Transport Error
Oct 06 13:45:24 volumio systemd[1]: Started LSB: start Samba daemons for the AD DC.
Oct 06 13:45:25 volumio wireless.js[625]: Cleaning previous...
Oct 06 13:45:25 volumio systemd[1]: Stopped hotspot.service.
Oct 06 13:45:26 volumio sudo[711]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0
Oct 06 13:45:26 volumio sudo[711]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 06 13:45:26 volumio systemd[1]: Started Music Player Daemon.
Oct 06 13:45:26 volumio sudo[711]: pam_unix(sudo:session): session closed for user root
Oct 06 13:45:26 volumio sudo[721]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down
Oct 06 13:45:26 volumio sudo[721]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 06 13:45:26 volumio udisks-glue[475]: Updating DB (#1) ...
Oct 06 13:45:26 volumio udisks-glue[475]: volume: 40% repeat: off random: off single: off consume: off
Oct 06 13:45:27 volumio sudo[721]: pam_unix(sudo:session): session closed for user root
Oct 06 13:45:27 volumio winbind[503]: Starting the Winbind daemon: winbindmkdir failed on directory /var/log/samba/cores: No such file or directory
Oct 06 13:45:27 volumio winbind[503]: Failed to create /var/log/samba/cores for user 0 with mode 0700
Oct 06 13:45:27 volumio winbind[503]: Unable to setup corepath for winbindd: No such file or directory
Oct 06 13:45:27 volumio winbind[503]: mkdir failed on directory /var/log/samba/cores: No such file or directory
Oct 06 13:45:27 volumio winbind[503]: Failed to create /var/log/samba/cores for user 0 with mode 0700
Oct 06 13:45:28 volumio winbind[503]: Unable to setup corepath for winbindd: No such file or directory
Oct 06 13:45:28 volumio winbind[503]: [2021/10/06 13:45:27, 0] ../lib/util/debug.c:603(reopen_logs_internal)
Oct 06 13:45:28 volumio winbind[503]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory
Oct 06 13:45:28 volumio winbind[503]: [2021/10/06 13:45:28, 0] ../lib/util/debug.c:603(reopen_logs_internal)
Oct 06 13:45:28 volumio winbind[503]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory
Oct 06 13:45:28 volumio winbind[503]: [2021/10/06 13:45:28, 0] ../source3/winbindd/winbindd.c:1549(main)
Oct 06 13:45:28 volumio winbind[503]: winbindd version 4.2.14-Debian started.
Oct 06 13:45:28 volumio winbind[503]: Copyright Andrew Tridgell and the Samba Team 1992-2014
Oct 06 13:45:28 volumio winbind[503]: [2021/10/06 13:45:28, 0] ../lib/util/util.c:220(directory_create_or_exist)
Oct 06 13:45:28 volumio winbind[503]: mkdir failed on directory /var/log/samba/cores: No such file or directory
Oct 06 13:45:28 volumio winbind[503]: [2021/10/06 13:45:28, 0] ../source3/lib/dumpcore.c:59(get_default_corepath)
Oct 06 13:45:28 volumio winbind[503]: Failed to create /var/log/samba/cores for user 0 with mode 0700
Oct 06 13:45:28 volumio winbind[503]: [2021/10/06 13:45:28, 0] ../source3/lib/dumpcore.c:250(dump_core_setup)
Oct 06 13:45:28 volumio winbind[503]: Unable to setup corepath for winbindd: No such file or directory
Oct 06 13:45:28 volumio winbindd[704]: [2021/10/06 13:45:28.061805, 0] ../lib/util/debug.c:603(reopen_logs_internal)
Oct 06 13:45:28 volumio winbindd[704]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory
Oct 06 13:45:28 volumio winbindd[704]: [2021/10/06 13:45:28.074349, 0] ../lib/util/debug.c:603(reopen_logs_internal)
Oct 06 13:45:28 volumio winbindd[704]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory
Oct 06 13:45:28 volumio winbindd[736]: [2021/10/06 13:45:28.216795, 0] ../source3/winbindd/winbindd_cache.c:3235(initialize_winbindd_cache)
Oct 06 13:45:28 volumio winbindd[736]: initialize_winbindd_cache: clearing cache and re-creating with version number 2
Oct 06 13:45:28 volumio systemd[1]: Started LSB: start Winbind daemon.
Oct 06 13:45:28 volumio winbind[503]: [2021/10/06 13:45:28.061805, 0] ../lib/util/debug.c:603(reopen_logs_internal)
Oct 06 13:45:28 volumio winbind[503]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory
Oct 06 13:45:28 volumio winbind[503]: [2021/10/06 13:45:28.074349, 0] ../lib/util/debug.c:603(reopen_logs_internal)
Oct 06 13:45:28 volumio winbind[503]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory
Oct 06 13:45:28 volumio winbind[503]: .
Oct 06 13:45:28 volumio wireless.js[625]: Stopped aP
Oct 06 13:45:28 volumio nmbd[519]: Starting NetBIOS name server: nmbdmkdir failed on directory /var/log/samba/cores: No such file or directory
Oct 06 13:45:28 volumio nmbd[519]: Failed to create /var/log/samba/cores for user 0 with mode 0700
Oct 06 13:45:28 volumio nmbd[726]: [2021/10/06 13:45:28.376194, 0] ../lib/util/debug.c:603(reopen_logs_internal)
Oct 06 13:45:28 volumio nmbd[726]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory
Oct 06 13:45:28 volumio nmbd[519]: Unable to setup corepath for nmbd: No such file or directory
Oct 06 13:45:28 volumio nmbd[519]: [2021/10/06 13:45:28, 0] ../lib/util/debug.c:603(reopen_logs_internal)
Oct 06 13:45:28 volumio nmbd[519]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory
Oct 06 13:45:28 volumio nmbd[519]: [2021/10/06 13:45:28, 0] ../lib/util/debug.c:603(reopen_logs_internal)
Oct 06 13:45:28 volumio nmbd[519]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory
Oct 06 13:45:28 volumio nmbd[519]: [2021/10/06 13:45:28, 0] ../source3/nmbd/nmbd.c:908(main)
Oct 06 13:45:28 volumio nmbd[519]: nmbd version 4.2.14-Debian started.
Oct 06 13:45:28 volumio nmbd[519]: Copyright Andrew Tridgell and the Samba Team 1992-2014
Oct 06 13:45:28 volumio nmbd[519]: [2021/10/06 13:45:28.376194, 0] ../lib/util/debug.c:603(reopen_logs_internal)
Oct 06 13:45:28 volumio nmbd[519]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory
Oct 06 13:45:28 volumio nmbd[726]: [2021/10/06 13:45:28.388802, 0] ../lib/util/debug.c:603(reopen_logs_internal)
Oct 06 13:45:28 volumio nmbd[726]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory
Oct 06 13:45:28 volumio nmbd[737]: [2021/10/06 13:45:28.463106, 0] ../source3/nmbd/asyncdns.c:157(start_async_dns)
Oct 06 13:45:28 volumio nmbd[737]: started asyncdns process 739
Oct 06 13:45:28 volumio systemd[1]: Started LSB: start Samba NetBIOS nameserver (nmbd).
Oct 06 13:45:28 volumio systemd[1]: Starting LSB: start Samba SMB/CIFS daemon (smbd)...
Oct 06 13:45:28 volumio nmbd[737]: [2021/10/06 13:45:28.524078, 0] ../lib/util/become_daemon.c:135(daemon_status)
Oct 06 13:45:28 volumio nmbd[737]: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ...NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6).
Oct 06 13:45:28 volumio wireless.js[625]: Start wireless flow
Oct 06 13:45:28 volumio wireless.js[625]: Stopped hotspot (if there)..
Oct 06 13:45:28 volumio winbindd[736]: [2021/10/06 13:45:28.580584, 0] ../lib/util/become_daemon.c:124(daemon_ready)
Oct 06 13:45:28 volumio winbindd[736]: STATUS=daemon 'winbindd' finished starting up and ready to serve connections
Oct 06 13:45:28 volumio nmbd[519]: [2021/10/06 13:45:28.388802, 0] ../lib/util/debug.c:603(reopen_logs_internal)
Oct 06 13:45:28 volumio nmbd[519]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory
Oct 06 13:45:28 volumio nmbd[519]: .
Oct 06 13:45:28 volumio winbindd[742]: [2021/10/06 13:45:28.623163, 0] ../lib/util/debug.c:603(reopen_logs_internal)
Oct 06 13:45:28 volumio winbindd[742]: Unable to open new log file '/var/log/samba/log.wb-VOLUMIO': No such file or directory
Oct 06 13:45:28 volumio sudo[741]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0
Oct 06 13:45:28 volumio sudo[741]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 06 13:45:28 volumio sudo[741]: pam_unix(sudo:session): session closed for user root
Oct 06 13:45:29 volumio sudo[755]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down
Oct 06 13:45:29 volumio sudo[755]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 06 13:45:29 volumio sudo[755]: pam_unix(sudo:session): session closed for user root
Oct 06 13:45:29 volumio wireless.js[625]: DHCP IP
Oct 06 13:45:29 volumio wireless.js[625]: Start ap
Oct 06 13:45:29 volumio sudo[764]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd
Oct 06 13:45:29 volumio sudo[764]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 06 13:45:29 volumio dhcpcd[768]: version 6.0.5 starting
Oct 06 13:45:30 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled
Oct 06 13:45:30 volumio wpa_supplicant[763]: Successfully initialized wpa_supplicant
Oct 06 13:45:30 volumio dhcpcd[768]: wlan0: waiting for carrier
Oct 06 13:45:30 volumio wireless.js[625]: trying...
Oct 06 13:45:30 volumio sudo[783]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Oct 06 13:45:30 volumio sudo[783]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 06 13:45:30 volumio sudo[783]: pam_unix(sudo:session): session closed for user root
Oct 06 13:45:31 volumio wpa_supplicant[784]: wlan0: Trying to associate with SSID 'defaultu'
Oct 06 13:45:31 volumio wpa_supplicant[784]: wlan0: Associated with 00:a0:b0:5e:8d:07
Oct 06 13:45:31 volumio wpa_supplicant[784]: wlan0: CTRL-EVENT-CONNECTED - Connection to 00:a0:b0:5e:8d:07 completed [id=0 id_str=]
Oct 06 13:45:31 volumio dhcpcd[768]: wlan0: carrier acquired
Oct 06 13:45:32 volumio wireless.js[625]: trying...
Oct 06 13:45:32 volumio wpa_supplicant[784]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=JP
Oct 06 13:45:32 volumio volumio-remote-updater[480]: [2021-10-06 13:45:32] [info] asio async_connect error: system:111 (Connection refused)
Oct 06 13:45:32 volumio volumio-remote-updater[480]: [2021-10-06 13:45:32] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Oct 06 13:45:32 volumio volumio-remote-updater[480]: [2021-10-06 13:45:32] [error] handle_connect error: Underlying Transport Error
Oct 06 13:45:32 volumio dhcpcd[768]: wlan0: soliciting an IPv6 router
Oct 06 13:45:32 volumio dhcpcd[768]: wlan0: rebinding lease of 192.168.0.12
Oct 06 13:45:32 volumio sudo[801]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Oct 06 13:45:32 volumio sudo[801]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 06 13:45:32 volumio sudo[801]: pam_unix(sudo:session): session closed for user root
Oct 06 13:45:33 volumio wireless.js[625]: trying...
Oct 06 13:45:33 volumio sudo[818]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Oct 06 13:45:33 volumio sudo[818]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 06 13:45:33 volumio sudo[818]: pam_unix(sudo:session): session closed for user root
Oct 06 13:45:33 volumio smbd[740]: Starting SMB/CIFS daemon: smbd[2021/10/06 13:45:33, 0] ../lib/util/debug.c:603(reopen_logs_internal)
Oct 06 13:45:33 volumio smbd[740]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory
Oct 06 13:45:33 volumio smbd[740]: [2021/10/06 13:45:33, 0] ../lib/util/util.c:220(directory_create_or_exist)
Oct 06 13:45:33 volumio smbd[740]: mkdir failed on directory /var/log/samba/cores: No such file or directory
Oct 06 13:45:33 volumio smbd[740]: [2021/10/06 13:45:33, 0] ../source3/lib/dumpcore.c:59(get_default_corepath)
Oct 06 13:45:33 volumio smbd[740]: Failed to create /var/log/samba/cores for user 0 with mode 0700
Oct 06 13:45:33 volumio smbd[740]: [2021/10/06 13:45:33, 0] ../source3/lib/dumpcore.c:250(dump_core_setup)
Oct 06 13:45:33 volumio smbd[740]: Unable to setup corepath for smbd: No such file or directory
Oct 06 13:45:33 volumio smbd[740]: [2021/10/06 13:45:33, 0] ../lib/util/debug.c:603(reopen_logs_internal)
Oct 06 13:45:33 volumio smbd[740]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory
Oct 06 13:45:33 volumio smbd[740]: [2021/10/06 13:45:33, 0] ../source3/smbd/server.c:1241(main)
Oct 06 13:45:33 volumio smbd[740]: smbd version 4.2.14-Debian started.
Oct 06 13:45:33 volumio smbd[740]: Copyright Andrew Tridgell and the Samba Team 1992-2014
Oct 06 13:45:34 volumio smbd[816]: [2021/10/06 13:45:34.010385, 0] ../lib/util/debug.c:603(reopen_logs_internal)
Oct 06 13:45:34 volumio smbd[816]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory
Oct 06 13:45:34 volumio smbd[740]: [2021/10/06 13:45:34.010385, 0] ../lib/util/debug.c:603(reopen_logs_internal)
Oct 06 13:45:34 volumio smbd[740]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory
Oct 06 13:45:34 volumio smbd[816]: [2021/10/06 13:45:34.021648, 0] ../lib/util/debug.c:603(reopen_logs_internal)
Oct 06 13:45:34 volumio smbd[816]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory
Oct 06 13:45:34 volumio smbd[816]: [2021/10/06 13:45:34.022298, 0] ../lib/util/debug.c:603(reopen_logs_internal)
Oct 06 13:45:34 volumio smbd[816]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory
Oct 06 13:45:34 volumio smbd[740]: [2021/10/06 13:45:34.021648, 0] ../lib/util/debug.c:603(reopen_logs_internal)
Oct 06 13:45:34 volumio smbd[740]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory
Oct 06 13:45:34 volumio smbd[740]: [2021/10/06 13:45:34.022298, 0] ../lib/util/debug.c:603(reopen_logs_internal)
Oct 06 13:45:34 volumio smbd[740]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory
Oct 06 13:45:34 volumio systemd[1]: Started LSB: start Samba SMB/CIFS daemon (smbd).
Oct 06 13:45:34 volumio smbd[740]: .
Oct 06 13:45:34 volumio winbindd[829]: [2021/10/06 13:45:34.194267, 0] ../lib/util/debug.c:603(reopen_logs_internal)
Oct 06 13:45:34 volumio winbindd[829]: Unable to open new log file '/var/log/samba/log.winbindd-idmap': No such file or directory
Oct 06 13:45:34 volumio smbd[826]: [2021/10/06 13:45:34.300431, 0] ../lib/util/become_daemon.c:124(daemon_ready)
Oct 06 13:45:34 volumio smbd[826]: STATUS=daemon 'smbd' finished starting up and ready to serve connections
Oct 06 13:45:34 volumio smbd[830]: [2021/10/06 13:45:34.321745, 0] ../lib/util/debug.c:603(reopen_logs_internal)
Oct 06 13:45:34 volumio smbd[830]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory
Oct 06 13:45:34 volumio wireless.js[625]: trying...
Oct 06 13:45:34 volumio sudo[833]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Oct 06 13:45:34 volumio sudo[833]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 06 13:45:35 volumio sudo[833]: pam_unix(sudo:session): session closed for user root
Oct 06 13:45:36 volumio wireless.js[625]: trying...
Oct 06 13:45:36 volumio sudo[842]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Oct 06 13:45:36 volumio sudo[842]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 06 13:45:36 volumio sudo[842]: pam_unix(sudo:session): session closed for user root
Oct 06 13:45:36 volumio dhcpcd[768]: wlan0: leased 192.168.0.12 for 86400 seconds
Oct 06 13:45:36 volumio avahi-daemon[544]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.0.12.
Oct 06 13:45:36 volumio avahi-daemon[544]: New relevant interface wlan0.IPv4 for mDNS.
Oct 06 13:45:36 volumio avahi-daemon[544]: Registering new address record for 192.168.0.12 on wlan0.IPv4.
Oct 06 13:45:36 volumio dhcpcd[768]: wlan0: adding host route to 192.168.0.12 via 127.0.0.1
Oct 06 13:45:36 volumio dhcpcd[768]: wlan0: adding route to 192.168.0.0/24
Oct 06 13:45:36 volumio dhcpcd[768]: wlan0: adding default route via 192.168.0.1
Oct 06 13:45:36 volumio dhcpcd[768]: forked to background, child pid 871
Oct 06 13:45:36 volumio sudo[764]: pam_unix(sudo:session): session closed for user root
Oct 06 13:45:37 volumio wireless.js[625]: trying...
Oct 06 13:45:37 volumio sudo[876]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Oct 06 13:45:37 volumio sudo[876]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 06 13:45:37 volumio sudo[876]: pam_unix(sudo:session): session closed for user root
Oct 06 13:45:37 volumio wireless.js[625]: Connected to: ----defaultu
Oct 06 13:45:37 volumio wireless.js[625]: ----
Oct 06 13:45:37 volumio sudo[885]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Oct 06 13:45:37 volumio sudo[885]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 06 13:45:37 volumio sudo[885]: pam_unix(sudo:session): session closed for user root
Oct 06 13:45:37 volumio wireless.js[625]: ... joined AP, wlan0 IPv4 is 192.168.0.12, ipV6 is undefined
Oct 06 13:45:37 volumio wireless.js[625]: It's done! AP
Oct 06 13:45:37 volumio systemd[1]: Started Wireless Services.
Oct 06 13:45:37 volumio systemd[1]: Starting Volumio Backend Module...
Oct 06 13:45:37 volumio systemd[1]: Started Volumio Backend Module.
Oct 06 13:45:37 volumio systemd[1]: Starting Volumio Streaming Daemon...
Oct 06 13:45:37 volumio systemd[1]: Started Volumio Streaming Daemon.
Oct 06 13:45:37 volumio systemd[1]: Starting Multi-User System.
Oct 06 13:45:37 volumio systemd[1]: Reached target Multi-User System.
Oct 06 13:45:37 volumio systemd[1]: Starting Graphical Interface.
Oct 06 13:45:37 volumio systemd[1]: Reached target Graphical Interface.
Oct 06 13:45:37 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes...
Oct 06 13:45:37 volumio systemd[1]: Started Update UTMP about System Runlevel Changes.
Oct 06 13:45:37 volumio systemd[1]: Startup finished in 12.977s (kernel) + 1min 7.480s (userspace) = 1min 20.458s.
Oct 06 13:45:38 volumio volumio-streaming-daemon[895]: ############################
Oct 06 13:45:38 volumio volumio-streaming-daemon[895]: # Volumio Streaming Daemon #
Oct 06 13:45:38 volumio volumio-streaming-daemon[895]: # Running on port 7777 #
Oct 06 13:45:38 volumio volumio-streaming-daemon[895]: ############################
Oct 06 13:45:38 volumio volumio-streaming-daemon[895]: Environment:
Oct 06 13:45:38 volumio nmbd[737]: [2021/10/06 13:45:38.541808, 0] ../lib/util/become_daemon.c:124(daemon_ready)
Oct 06 13:45:38 volumio nmbd[737]: STATUS=daemon 'nmbd' finished starting up and ready to serve connections
Oct 06 13:45:38 volumio ntpd[585]: Listen normally on 3 wlan0 192.168.0.12 UDP 123
Oct 06 13:45:38 volumio ntpd[585]: peers refreshed
Oct 06 13:45:40 volumio ntpd_intres[679]: DNS 0.debian.pool.ntp.org -> 133.243.238.243
Oct 06 13:45:40 volumio ntpd_intres[679]: DNS 1.debian.pool.ntp.org -> 202.182.111.234
Oct 06 13:45:40 volumio ntpd_intres[679]: DNS 2.debian.pool.ntp.org -> 202.182.111.234
Oct 06 13:45:40 volumio ntpd_intres[679]: DNS 3.debian.pool.ntp.org -> 133.130.121.141
Oct 06 13:45:42 volumio volumio-remote-updater[480]: [2021-10-06 13:45:42] [info] asio async_connect error: system:111 (Connection refused)
Oct 06 13:45:42 volumio volumio-remote-updater[480]: [2021-10-06 13:45:42] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Oct 06 13:45:42 volumio volumio-remote-updater[480]: [2021-10-06 13:45:42] [error] handle_connect error: Underlying Transport Error
Oct 06 13:45:47 volumio volumio[894]: info: -------------------------------------------
Oct 06 13:45:47 volumio volumio[894]: info: ----- Volumio2 ----
Oct 06 13:45:47 volumio volumio[894]: info: -------------------------------------------
Oct 06 13:45:47 volumio volumio[894]: info: ----- System startup ----
Oct 06 13:45:47 volumio volumio[894]: info: -------------------------------------------
Oct 06 13:45:51 volumio volumio[894]: info: MYVOLUMIO Environment detected
Oct 06 13:45:52 volumio volumio[894]: info: Plugin folders cleanup
Oct 06 13:45:52 volumio volumio[894]: info: Scanning into folder /volumio/app/plugins/
Oct 06 13:45:52 volumio volumio[894]: info: Scanning category audio_interface
Oct 06 13:45:52 volumio volumio-remote-updater[480]: [2021-10-06 13:45:52] [connect] Successful connection
Oct 06 13:45:52 volumio volumio[894]: info: Scanning category miscellanea
Oct 06 13:45:52 volumio volumio[894]: info: Scanning category music_service
Oct 06 13:45:52 volumio volumio[894]: info: Scanning category plugins.json
Oct 06 13:45:52 volumio volumio[894]: info: Scanning category system_controller
Oct 06 13:45:52 volumio volumio[894]: info: Scanning category user_interface
Oct 06 13:45:52 volumio volumio[894]: info: Scanning into folder /data/plugins/
Oct 06 13:45:52 volumio volumio[894]: info: Plugin folders cleanup completed
Oct 06 13:45:52 volumio volumio[894]: info: -------------------------------------------
Oct 06 13:45:52 volumio volumio[894]: info: ----- Core plugins startup ----
Oct 06 13:45:52 volumio volumio[894]: info: -------------------------------------------
Oct 06 13:45:52 volumio volumio[894]: info: Loading plugins from folder /volumio/app/plugins/
Oct 06 13:45:52 volumio volumio[894]: info: Adding plugin upnp to MyMusic Plugins
Oct 06 13:45:52 volumio volumio[894]: info: Adding plugin airplay_emulation to MyMusic Plugins
Oct 06 13:45:52 volumio volumio[894]: info: Adding plugin upnp_browser to MyMusic Plugins
Oct 06 13:45:52 volumio volumio[894]: info: Loading plugins from folder /data/plugins/
Oct 06 13:45:52 volumio volumio[894]: info: Loading plugin "system"...
Oct 06 13:45:52 volumio volumio[894]: { Error: ENOENT: no such file or directory, open '/sys/class/net/eth0/address'
Oct 06 13:45:52 volumio volumio[894]: at Object.fs.openSync (fs.js:646:18)
Oct 06 13:45:52 volumio volumio[894]: at Object.fs.readFileSync (fs.js:551:33)
Oct 06 13:45:52 volumio volumio[894]: at ControllerSystem.callHome (/volumio/app/plugins/system_controller/system/index.js:570:22)
Oct 06 13:45:52 volumio volumio[894]: at ControllerSystem.onVolumioStart (/volumio/app/plugins/system_controller/system/index.js:51:8)
Oct 06 13:45:52 volumio volumio[894]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:171:38)
Oct 06 13:45:52 volumio volumio[894]: at /volumio/app/pluginmanager.js:250:34
Oct 06 13:45:52 volumio volumio[894]: at Array.forEach ()
Oct 06 13:45:52 volumio volumio[894]: at HashMap. (/volumio/app/pluginmanager.js:249:20)
Oct 06 13:45:52 volumio volumio[894]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10)
Oct 06 13:45:52 volumio volumio[894]: at HashMap.proto.(anonymous function) [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7)
Oct 06 13:45:52 volumio volumio[894]: errno: -2,
Oct 06 13:45:52 volumio volumio[894]: code: 'ENOENT',
Oct 06 13:45:52 volumio volumio[894]: syscall: 'open',
Oct 06 13:45:52 volumio volumio[894]: path: '/sys/class/net/eth0/address' }
Oct 06 13:45:52 volumio volumio[894]: info: Loading plugin "appearance"...
Oct 06 13:46:03 volumio volumio[894]: info: Loading plugin "network"...
Oct 06 13:46:03 volumio volumio[894]: info: Refreshing Cached IP Addresses
Oct 06 13:46:03 volumio sudo[936]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Oct 06 13:46:03 volumio volumio[894]: info: Loading plugin "services"...
Oct 06 13:46:03 volumio volumio[894]: info: Loading plugin "alsa_controller"...
Oct 06 13:46:03 volumio sudo[936]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 06 13:46:03 volumio sudo[938]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Oct 06 13:46:03 volumio sudo[936]: pam_unix(sudo:session): session closed for user root
Oct 06 13:46:03 volumio sudo[938]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 06 13:46:03 volumio sudo[938]: pam_unix(sudo:session): session closed for user root
Oct 06 13:46:04 volumio volumio[894]: info: Loading plugin "wizard"...
Oct 06 13:46:04 volumio volumio[894]: info: Loading plugin "volumio_command_line_client"...
Oct 06 13:46:04 volumio volumio[894]: info: Loading plugin "upnp"...
Oct 06 13:46:04 volumio volumio[894]: info: [1633527964857] Starting Upmpd Daemon
Oct 06 13:46:04 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Oct 06 13:46:04 volumio volumio[894]: info: Loading plugin "my_music"...
Oct 06 13:46:04 volumio volumio[894]: info: Loading plugin "mpd"...
Oct 06 13:46:06 volumio volumio[894]: info: Loading plugin "upnp_browser"...
Oct 06 13:46:07 volumio volumio-remote-updater[480]: [2021-10-06 13:46:07] [connect] Successful connection
Oct 06 13:46:08 volumio volumio[894]: info: Loading plugin "networkfs"...
Oct 06 13:46:09 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Oct 06 13:46:09 volumio volumio[894]: info: Loading plugin "alarm-clock"...
Oct 06 13:46:10 volumio volumio[894]: info: Loading plugin "airplay_emulation"...
Oct 06 13:46:10 volumio volumio[894]: info: Starting Shairport Sync
Oct 06 13:46:10 volumio volumio[894]: info: Loading plugin "last_100"...
Oct 06 13:46:10 volumio volumio[894]: info: Loading plugin "webradio"...
Oct 06 13:46:11 volumio volumio[894]: info: Loading plugin "i2s_dacs"...
Oct 06 13:46:11 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 06 13:46:11 volumio volumio[894]: info: Loading plugin "volumiodiscovery"...
Oct 06 13:46:11 volumio volumio[894]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Oct 06 13:46:11 volumio node[894]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Oct 06 13:46:11 volumio node[894]: *** WARNING *** Please fix your application to use the native API of Avahi!
Oct 06 13:46:11 volumio node[894]: *** WARNING *** For more information see
Oct 06 13:46:11 volumio node[894]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Oct 06 13:46:11 volumio node[894]: *** WARNING *** Please fix your application to use the native API of Avahi!
Oct 06 13:46:11 volumio node[894]: *** WARNING *** For more information see
Oct 06 13:46:11 volumio volumio[894]: *** WARNING *** Please fix your application to use the native API of Avahi!
Oct 06 13:46:11 volumio volumio[894]: *** WARNING *** For more information see
Oct 06 13:46:11 volumio volumio[894]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Oct 06 13:46:11 volumio volumio[894]: *** WARNING *** Please fix your application to use the native API of Avahi!
Oct 06 13:46:11 volumio volumio[894]: *** WARNING *** For more information see
Oct 06 13:46:11 volumio volumio[894]: info: Applying required configuration parameters for plugin volumiodiscovery
Oct 06 13:46:11 volumio volumio[894]: Discovery: StartAdv! undefined
Oct 06 13:46:11 volumio volumio[894]: Discovery: Started advertising... Volumio - undefined
Oct 06 13:46:11 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Oct 06 13:46:11 volumio volumio[894]: info: Loading plugin "outputs"...
Oct 06 13:46:11 volumio volumio[894]: info: Loading plugin "albumart"...
Oct 06 13:46:12 volumio volumio[894]: info: Plugin example_plugin is not enabled
Oct 06 13:46:12 volumio volumio[894]: info: Loading plugin "inputs"...
Oct 06 13:46:12 volumio volumio[894]: info: Loading plugin "updater_comm"...
Oct 06 13:46:13 volumio volumio[894]: info: Plugin mpdemulation is not enabled
Oct 06 13:46:13 volumio volumio[894]: info: Loading plugin "rest_api"...
Oct 06 13:46:13 volumio volumio[894]: info: Loading plugin "websocket"...
Oct 06 13:46:14 volumio volumio[894]: info: ___________ START PLUGINS ___________
Oct 06 13:46:14 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 06 13:46:14 volumio volumio[894]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Oct 06 13:46:14 volumio volumio[894]: info: [1633527974271] CoreMusicLibrary::Adding element Media Servers
Oct 06 13:46:14 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Oct 06 13:46:14 volumio volumio[894]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Oct 06 13:46:15 volumio volumio[894]: Forking 1 albumart workers
Oct 06 13:46:15 volumio volumio[894]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Oct 06 13:46:15 volumio volumio[894]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Oct 06 13:46:15 volumio volumio[894]: info: [1633527975295] CoreMusicLibrary::Adding element Last_100
Oct 06 13:46:15 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Oct 06 13:46:15 volumio volumio[894]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Oct 06 13:46:15 volumio volumio[894]: info: [1633527975349] CoreMusicLibrary::Adding element Webradio
Oct 06 13:46:15 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Oct 06 13:46:15 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Oct 06 13:46:15 volumio volumio[894]: info: -------------------------------------------
Oct 06 13:46:15 volumio volumio[894]: info: ----- MyVolumio plugins startup ----
Oct 06 13:46:15 volumio volumio[894]: info: -------------------------------------------
Oct 06 13:46:15 volumio volumio[894]: info: [MyVolumio PluginManager] Fetching plans data....
Oct 06 13:46:15 volumio volumio[894]: info: Loading i18n strings for locale ja
Oct 06 13:46:15 volumio volumio[894]: Updating browse sources language
Oct 06 13:46:15 volumio volumio[894]: Cannot find translation for sourceMedia Servers
Oct 06 13:46:15 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Oct 06 13:46:15 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 06 13:46:15 volumio volumio[894]: info: CoreCommandRouter::initPlayerControls
Oct 06 13:46:15 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 06 13:46:15 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards
Oct 06 13:46:16 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 06 13:46:16 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 06 13:46:16 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 06 13:46:16 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 06 13:46:16 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 06 13:46:16 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Oct 06 13:46:16 volumio volumio[894]: info: BOOT COMPLETED
Oct 06 13:46:16 volumio volumio[894]: [Metrics] CommandRouter: 28s 750.88ms
Oct 06 13:46:16 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 06 13:46:19 volumio volumio[894]: Starting albumart workers
Oct 06 13:46:21 volumio volumio[894]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo
Oct 06 13:46:21 volumio volumio[894]: info: CoreCommandRouter::Close All Modals sent
Oct 06 13:46:22 volumio volumio[894]: info: CoreCommandRouter::Close All Modals sent
Oct 06 13:46:22 volumio volumio[894]: Express server listening on port 3000
Oct 06 13:46:22 volumio volumio[894]: [Metrics] WebUI: 36s 930.16ms
Oct 06 13:46:22 volumio volumio[894]: Volumio Calling Home
Oct 06 13:46:22 volumio volumio-remote-updater[480]: [2021-10-06 13:46:22] [connect] Successful connection
Oct 06 13:46:22 volumio volumio[894]: info: CoreStateMachine::resetVolumioState
Oct 06 13:46:22 volumio volumio[894]: info: CoreStateMachine::getcurrentVolume
Oct 06 13:46:22 volumio volumio[894]: info: CoreCommandRouter::volumioRetrievevolume
Oct 06 13:46:22 volumio volumio[894]: info: CoreStateMachine::pushState
Oct 06 13:46:22 volumio volumio[894]: info: CorePlayQueue::getTrack 0
Oct 06 13:46:22 volumio volumio[894]: info: CoreCommandRouter::volumioPushState
Oct 06 13:46:22 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 06 13:46:22 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 06 13:46:23 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Oct 06 13:46:23 volumio sudo[1000]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Oct 06 13:46:23 volumio sudo[1000]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 06 13:46:23 volumio sudo[1002]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Oct 06 13:46:23 volumio sudo[1002]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 06 13:46:23 volumio sudo[1000]: pam_unix(sudo:session): session closed for user root
Oct 06 13:46:23 volumio sudo[1002]: pam_unix(sudo:session): session closed for user root
Oct 06 13:46:23 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
Oct 06 13:46:23 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Oct 06 13:46:23 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
Oct 06 13:46:24 volumio volumio[894]: info: Volumio called home
Oct 06 13:46:24 volumio volumio[894]: info: Setting Device type: Raspberry PI
Oct 06 13:46:24 volumio volumio[894]: info: MPD running with PID553
Oct 06 13:46:24 volumio volumio[894]: ,establishing connection
Oct 06 13:46:24 volumio volumio-remote-updater[480]: [2021-10-06 13:46:24] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1633527982 101
Oct 06 13:46:25 volumio volumio[894]: info: Reloading queue from file
Oct 06 13:46:25 volumio volumio[894]: error: updateQueue error: null
Oct 06 13:46:25 volumio volumio[894]: info: CoreStateMachine::setRepeat true single undefined
Oct 06 13:46:25 volumio volumio[894]: info: CoreStateMachine::pushState
Oct 06 13:46:25 volumio volumio[894]: info: CorePlayQueue::getTrack 0
Oct 06 13:46:25 volumio volumio[894]: info: CoreCommandRouter::volumioPushState
Oct 06 13:46:25 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 06 13:46:25 volumio volumio[894]: info: CoreStateMachine::setRandom false
Oct 06 13:46:25 volumio volumio[894]: info: CoreStateMachine::pushState
Oct 06 13:46:25 volumio volumio[894]: info: CorePlayQueue::getTrack 0
Oct 06 13:46:25 volumio volumio[894]: info: CoreCommandRouter::volumioPushState
Oct 06 13:46:25 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 06 13:46:26 volumio volumio[894]: info: Starting Shairport Sync
Oct 06 13:46:26 volumio volumio[894]: info: Starting Shairport Sync
Oct 06 13:46:26 volumio sudo[1021]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Oct 06 13:46:26 volumio sudo[1021]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 06 13:46:26 volumio sudo[1023]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Oct 06 13:46:26 volumio sudo[1023]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 06 13:46:26 volumio systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver...
Oct 06 13:46:26 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Oct 06 13:46:26 volumio sudo[1028]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
Oct 06 13:46:26 volumio sudo[1028]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 06 13:46:27 volumio volumio[894]: Discovery: adding 321c6086-ab0e-47cd-ac8a-f19801dfb079
Oct 06 13:46:27 volumio volumio[894]: info: mDNS: Found device Volumio
Oct 06 13:46:27 volumio volumio[894]: info: CoreCommandRouter::volumioGetState
Oct 06 13:46:27 volumio volumio[894]: info: CorePlayQueue::getTrack 0
Oct 06 13:46:27 volumio sudo[1021]: pam_unix(sudo:session): session closed for user root
Oct 06 13:46:28 volumio systemd[1]: Starting UPnP Renderer front-end to MPD...
Oct 06 13:46:28 volumio systemd[1]: Started UPnP Renderer front-end to MPD.
Oct 06 13:46:28 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Oct 06 13:46:28 volumio sudo[1028]: pam_unix(sudo:session): session closed for user root
Oct 06 13:46:28 volumio systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver...
Oct 06 13:46:28 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Oct 06 13:46:28 volumio sudo[1023]: pam_unix(sudo:session): session closed for user root
Oct 06 13:46:29 volumio volumio[894]: info: Shairport-Sync Started
Oct 06 13:46:29 volumio volumio[894]: Error adding Membership: Error: addMembership EINVAL
Oct 06 13:46:29 volumio volumio[894]: info: Upmpdcli Daemon Started
Oct 06 13:46:29 volumio volumio[894]: info: Shairport-Sync Started
Oct 06 13:46:29 volumio volumio[894]: info: CoreCommandRouter::volumioGetState
Oct 06 13:46:29 volumio volumio[894]: info: CorePlayQueue::getTrack 0
Oct 06 13:46:35 volumio sudo[1090]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Oct 06 13:46:35 volumio sudo[1092]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Oct 06 13:46:35 volumio sudo[1090]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 06 13:46:35 volumio sudo[1092]: pam_unix(sudo:session): session opened for user root by (uid=0)
Oct 06 13:46:35 volumio sudo[1092]: pam_unix(sudo:session): session closed for user root
Oct 06 13:46:35 volumio sudo[1090]: pam_unix(sudo:session): session closed for user root
Oct 06 13:46:36 volumio volumio[894]: info: CoreCommandRouter::volumioGetVisibleSources
Oct 06 13:46:36 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Oct 06 13:46:36 volumio volumio[894]: info: CoreCommandRouter::volumioGetState
Oct 06 13:46:36 volumio volumio[894]: info: CorePlayQueue::getTrack 0
Oct 06 13:46:36 volumio volumio[894]: info: CoreCommandRouter::volumioGetQueue
Oct 06 13:46:36 volumio volumio[894]: info: CoreStateMachine::getQueue
Oct 06 13:46:36 volumio volumio[894]: info: CorePlayQueue::getQueue
Oct 06 13:46:36 volumio volumio[894]: info: Listing playlists
Oct 06 13:46:36 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Oct 06 13:46:36 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Oct 06 13:46:36 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Oct 06 13:46:36 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Oct 06 13:46:36 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Oct 06 13:46:37 volumio volumio[894]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Joe%20Hisaishi/Kikujiro/1122b39a-689a-4b90-8d98-37a828a3ec8a.jpg'
Oct 06 13:46:38 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Oct 06 13:46:38 volumio volumio[894]: info: CURURI: music-library
Oct 06 13:46:39 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Oct 06 13:46:39 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Oct 06 13:46:39 volumio volumio[894]: info: CURURI: music-library/USB
Oct 06 13:46:40 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken
Oct 06 13:46:40 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Oct 06 13:46:40 volumio volumio[894]: info: CURURI: music-library/USB/UTO4G_K_
Oct 06 13:46:44 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Oct 06 13:46:44 volumio volumio[894]: info: CURURI: music-library/USB/UTO4G_K_/シルヴィ・バルタン
Oct 06 13:46:45 volumio volumio[894]: /usr/bin/md5sum: /sys/class/net/eth0/address: No such file or directory
Oct 06 13:46:45 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 06 13:46:45 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Oct 06 13:46:45 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Oct 06 13:46:48 volumio volumio[894]: info: CoreCommandRouter::volumioReplaceandPlayItems
Oct 06 13:46:48 volumio volumio[894]: info: CoreStateMachine::ClearQueue
Oct 06 13:46:48 volumio volumio[894]: info: CoreStateMachine::stop
Oct 06 13:46:48 volumio volumio[894]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 06 13:46:48 volumio volumio[894]: verbose: UNSET VOLATILE
Oct 06 13:46:48 volumio volumio[894]: info: CorePlayQueue::clearPlayQueue
Oct 06 13:46:48 volumio volumio[894]: info: CorePlayQueue::saveQueue
Oct 06 13:46:48 volumio volumio[894]: info: CoreCommandRouter::volumioPushState
Oct 06 13:46:48 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 06 13:46:48 volumio volumio[894]: info: CoreCommandRouter::volumioPushQueue
Oct 06 13:46:48 volumio volumio[894]: info: CoreStateMachine::addQueueItems
Oct 06 13:46:48 volumio volumio[894]: info: CorePlayQueue::addQueueItems
Oct 06 13:46:48 volumio volumio[894]: info: Adding Item to queue: music-library/USB/UTO4G_K_/シルヴィ・バルタン/【懐メロ洋楽】「悲しみの兵士」シルヴィ・バルタン.m4a
Oct 06 13:46:48 volumio volumio[894]: info: Exploding uri music-library/USB/UTO4G_K_/シルヴィ・バルタン/【懐メロ洋楽】「悲しみの兵士」シルヴィ・バルタン.m4a in service mpd
Oct 06 13:46:48 volumio volumio[894]: info: Adding Item to queue: music-library/USB/UTO4G_K_/シルヴィ・バルタン/En écoutant la pluie.m4a
Oct 06 13:46:48 volumio volumio[894]: info: Exploding uri music-library/USB/UTO4G_K_/シルヴィ・バルタン/En écoutant la pluie.m4a in service mpd
Oct 06 13:46:48 volumio volumio[894]: info: Adding Item to queue: music-library/USB/UTO4G_K_/シルヴィ・バルタン/あなたのとりこ.m4a
Oct 06 13:46:48 volumio volumio[894]: info: Exploding uri music-library/USB/UTO4G_K_/シルヴィ・バルタン/あなたのとりこ.m4a in service mpd
Oct 06 13:46:48 volumio volumio[894]: info: ALBUMART /albumart?cacheid=831&web=%E6%98%AD%E5%92%8C%E6%AD%8C%E8%AC%A1%E3%83%81%E3%83%A3%E3%83%B3%E3%83%8D%E3%83%ABM//extralarge&path=%2Fmnt%2FUSB%2FUTO4G_K_%2F%E3%82%B7%E3%83%AB%E3%83%B4%E3%82%A3%E3%83%BB%E3%83%90%E3%83%AB%E3%82%BF%E3%83%B3%2F%E3%80%90%E6%87%90%E3%83%A1%E3%83%AD%E6%B4%8B%E6%A5%BD%E3%80%91%E3%80%8C%E6%82%B2%E3%81%97%E3%81%BF%E3%81%AE%E5%85%B5%E5%A3%AB%E3%80%8D%E3%82%B7%E3%83%AB%E3%83%B4%E3%82%A3%E3%83%BB%E3%83%90%E3%83%AB%E3%82%BF%E3%83%B3.m4a&metadata=false
Oct 06 13:46:48 volumio volumio[894]: info: URI /mnt/USB/UTO4G_K_/シルヴィ・バルタン/【懐メロ洋楽】「悲しみの兵士」シルヴィ・バルタン.m4a
Oct 06 13:46:48 volumio volumio[894]: info: ALBUMART /albumart?cacheid=831&web=Sylvie%20Vartan/Twiste%20et%20chante/extralarge&path=%2Fmnt%2FUSB%2FUTO4G_K_%2F%E3%82%B7%E3%83%AB%E3%83%B4%E3%82%A3%E3%83%BB%E3%83%90%E3%83%AB%E3%82%BF%E3%83%B3%2FEn%20%C3%A9coutant%20la%20pluie.m4a&metadata=false
Oct 06 13:46:48 volumio volumio[894]: info: URI /mnt/USB/UTO4G_K_/シルヴィ・バルタン/En écoutant la pluie.m4a
Oct 06 13:46:48 volumio volumio[894]: info: ALBUMART /albumart?cacheid=831&web=Sylvie%20Vartan/%E3%82%B7%E3%83%AB%E3%83%B4%E3%82%A3%E3%83%BB%E3%83%B4%E3%82%A1%E3%83%AB%E3%82%BF%E3%83%B3%20%E3%83%99%E3%82%B9%E3%83%88%EF%BC%86%E3%82%B0%E3%83%AC%E3%82%A4%E3%83%86%E3%82%B9%E3%83%88%E3%83%BB%E3%83%92%E3%83%83%E3%83%84/extralarge&path=%2Fmnt%2FUSB%2FUTO4G_K_%2F%E3%82%B7%E3%83%AB%E3%83%B4%E3%82%A3%E3%83%BB%E3%83%90%E3%83%AB%E3%82%BF%E3%83%B3%2F%E3%81%82%E3%81%AA%E3%81%9F%E3%81%AE%E3%81%A8%E3%82%8A%E3%81%93.m4a&metadata=false
Oct 06 13:46:48 volumio volumio[894]: info: URI /mnt/USB/UTO4G_K_/シルヴィ・バルタン/あなたのとりこ.m4a
Oct 06 13:46:48 volumio volumio[894]: info: CorePlayQueue::saveQueue
Oct 06 13:46:48 volumio volumio[894]: info: CoreCommandRouter::volumioPushQueue
Oct 06 13:46:48 volumio volumio[894]: info: CoreStateMachine::updateTrackBlock
Oct 06 13:46:48 volumio volumio[894]: info: CorePlayQueue::getTrackBlock
Oct 06 13:46:48 volumio volumio[894]: info: CoreCommandRouter::volumioPlay
Oct 06 13:46:48 volumio volumio[894]: verbose: UNSET VOLATILE
Oct 06 13:46:48 volumio volumio[894]: info: CoreStateMachine::play index 1
Oct 06 13:46:48 volumio volumio[894]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 06 13:46:48 volumio volumio[894]: info: CoreStateMachine::stop
Oct 06 13:46:48 volumio volumio[894]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 06 13:46:48 volumio volumio[894]: verbose: UNSET VOLATILE
Oct 06 13:46:48 volumio volumio[894]: info: CoreStateMachine::play index undefined
Oct 06 13:46:48 volumio volumio[894]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 06 13:46:48 volumio volumio[894]: info: CorePlayQueue::getTrack 1
Oct 06 13:46:48 volumio volumio[894]: info: CoreStateMachine::startPlaybackTimer
Oct 06 13:46:48 volumio volumio[894]: info: CorePlayQueue::getTrack 1
Oct 06 13:46:48 volumio volumio[894]: verbose: ControllerMpd::clearAddPlayTracks USB/UTO4G_K_/シルヴィ・バルタン/En écoutant la pluie.m4a
Oct 06 13:46:48 volumio volumio[894]: verbose: ControllerMpd::sendMpdCommand stop
Oct 06 13:46:48 volumio volumio[894]: info: sendMpdCommand stop took 33 milliseconds
Oct 06 13:46:48 volumio volumio[894]: verbose: ControllerMpd::sendMpdCommand clear
Oct 06 13:46:48 volumio volumio[894]: info:
Oct 06 13:46:48 volumio volumio[894]: ---------------------------- MPD announces system playlist update
Oct 06 13:46:48 volumio volumio[894]: info: Ignoring MPD Status Update
Oct 06 13:46:48 volumio volumio[894]: info: sendMpdCommand clear took 59 milliseconds
Oct 06 13:46:48 volumio volumio[894]: verbose: ControllerMpd::sendMpdCommand add "USB/UTO4G_K_/シルヴィ・バルタン/En écoutant la pluie.m4a"
Oct 06 13:46:48 volumio volumio[894]: error: updateQueue error: null
Oct 06 13:46:48 volumio volumio[894]: info:
Oct 06 13:46:48 volumio volumio[894]: ---------------------------- MPD announces system playlist update
Oct 06 13:46:48 volumio volumio[894]: info: Ignoring MPD Status Update
Oct 06 13:46:48 volumio volumio[894]: info: ------------------------------ 75ms
Oct 06 13:46:48 volumio volumio[894]: info: sendMpdCommand add "USB/UTO4G_K_/シルヴィ・バルタン/En écoutant la pluie.m4a" took 40 milliseconds
Oct 06 13:46:48 volumio volumio[894]: verbose: ControllerMpd::sendMpdCommand play
Oct 06 13:46:48 volumio volumio[894]: info: ------------------------------ 116ms
Oct 06 13:46:48 volumio volumio[894]: info: sendMpdCommand play took 98 milliseconds
Oct 06 13:46:49 volumio volumio[894]: info:
Oct 06 13:46:49 volumio volumio[894]: ---------------------------- MPD announces state update: player
Oct 06 13:46:49 volumio volumio[894]: info: ControllerMpd::getState
Oct 06 13:46:49 volumio volumio[894]: verbose: ControllerMpd::sendMpdCommand status
Oct 06 13:46:49 volumio volumio[894]: info:
Oct 06 13:46:49 volumio volumio[894]: ---------------------------- MPD announces state update: player
Oct 06 13:46:49 volumio volumio[894]: info: ControllerMpd::getState
Oct 06 13:46:49 volumio volumio[894]: verbose: ControllerMpd::sendMpdCommand status
Oct 06 13:46:49 volumio volumio[894]: info: sendMpdCommand status took 38 milliseconds
Oct 06 13:46:49 volumio volumio[894]: verbose: ControllerMpd::parseState
Oct 06 13:46:49 volumio volumio[894]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 06 13:46:49 volumio volumio[894]: info: sendMpdCommand status took 126 milliseconds
Oct 06 13:46:49 volumio volumio[894]: info: sendMpdCommand playlistinfo took 81 milliseconds
Oct 06 13:46:49 volumio volumio[894]: verbose: ControllerMpd::parseState
Oct 06 13:46:49 volumio volumio[894]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 06 13:46:49 volumio volumio[894]: verbose: ControllerMpd::parseTrackInfo
Oct 06 13:46:49 volumio volumio[894]: info: ControllerMpd::pushState
Oct 06 13:46:49 volumio volumio[894]: info: CoreCommandRouter::servicePushState
Oct 06 13:46:49 volumio volumio[894]: info: CorePlayQueue::getTrack 1
Oct 06 13:46:49 volumio volumio[894]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":141,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"En écoutant la pluie","artist":"Sylvie Vartan","album":"Twiste et chante","uri":"USB/UTO4G_K_/シルヴィ・バルタン/En écoutant la pluie.m4a","trackType":"m4a"}
Oct 06 13:46:49 volumio volumio[894]: verbose: CURRENT POSITION 1
Oct 06 13:46:49 volumio volumio[894]: info: CoreStateMachine::syncState stateService play
Oct 06 13:46:49 volumio volumio[894]: info: CoreStateMachine::syncState currentStatus stop
Oct 06 13:46:49 volumio volumio[894]: info: CoreStateMachine::pushState
Oct 06 13:46:49 volumio volumio[894]: info: CorePlayQueue::getTrack 1
Oct 06 13:46:49 volumio volumio[894]: info: CoreCommandRouter::volumioPushState
Oct 06 13:46:49 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 06 13:46:49 volumio volumio[894]: info: ------------------------------ 485ms
Oct 06 13:46:49 volumio volumio[894]: info: sendMpdCommand playlistinfo took 263 milliseconds
Oct 06 13:46:49 volumio volumio[894]: verbose: ControllerMpd::parseTrackInfo
Oct 06 13:46:49 volumio volumio[894]: info: ControllerMpd::pushState
Oct 06 13:46:49 volumio volumio[894]: info: CoreCommandRouter::servicePushState
Oct 06 13:46:49 volumio volumio[894]: info: CorePlayQueue::getTrack 1
Oct 06 13:46:49 volumio volumio[894]: verbose: STATE SERVICE {"status":"play","position":0,"seek":487,"duration":141,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"En écoutant la pluie","artist":"Sylvie Vartan","album":"Twiste et chante","uri":"USB/UTO4G_K_/シルヴィ・バルタン/En écoutant la pluie.m4a","trackType":"m4a"}
Oct 06 13:46:49 volumio volumio[894]: verbose: CURRENT POSITION 1
Oct 06 13:46:49 volumio volumio[894]: info: CoreStateMachine::syncState stateService play
Oct 06 13:46:49 volumio volumio[894]: info: CoreStateMachine::syncState currentStatus play
Oct 06 13:46:49 volumio volumio[894]: info: Received an update from plugin. extracting info from payload
Oct 06 13:46:49 volumio volumio[894]: info: CoreStateMachine::pushState
Oct 06 13:46:49 volumio volumio[894]: info: CorePlayQueue::getTrack 1
Oct 06 13:46:49 volumio volumio[894]: info: CoreCommandRouter::volumioPushState
Oct 06 13:46:49 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 06 13:46:49 volumio volumio[894]: info: CoreStateMachine::pushState
Oct 06 13:46:49 volumio volumio[894]: info: CorePlayQueue::getTrack 1
Oct 06 13:46:49 volumio volumio[894]: info: CoreCommandRouter::volumioPushState
Oct 06 13:46:49 volumio volumio[894]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 06 13:46:49 volumio volumio[894]: info: ------------------------------ 596ms
Oct 06 13:46:50 volumio volumio[894]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Oct 06 13:46:50 volumio volumio[894]: { Error: certificate is not yet valid
Oct 06 13:46:50 volumio volumio[894]: at TLSSocket. (_tls_wrap.js:1105:38)
Oct 06 13:46:50 volumio volumio[894]: at emitNone (events.js:106:13)
Oct 06 13:46:50 volumio volumio[894]: at TLSSocket.emit (events.js:208:7)
Oct 06 13:46:50 volumio volumio[894]: at TLSSocket._finishInit (_tls_wrap.js:639:8)
Oct 06 13:46:50 volumio volumio[894]: at TLSWrap.ssl.onhandshakedone (_tls_wrap.js:469:38) code: 'CERT_NOT_YET_VALID' }
Oct 06 13:46:50 volumio volumio[894]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Oct 06 13:46:53 volumio sudo[1152]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2021-10-06 13:45
Oct 06 13:46:54 volumio sudo[1152]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)"
NAME="Raspbian GNU/Linux"
VERSION_ID="8"
VERSION="8 (jessie)"
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="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03"
VOLUMIO_FE_VERSION="958dedc0edff114f244fa9acc70cf53089d9e5ae"
VOLUMIO_BE_VERSION="fd3e37ffec12db034ec93f94dbc26e5495d5b91a"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Wed Oct 6 12:34:49 CEST 2021"
VOLUMIO_VERSION="2.917"
VOLUMIO_HARDWARE="pi"
VOLUMIO_HASH="98c8f08c531a6f0456f17ab17795e35f"