-- Logs begin at Wed 2019-06-26 05:05:13 UTC, end at Tue 2025-01-14 03:40:54 UTC. -- Jan 14 03:39:28 volumio systemd[1]: Time has been changed Jan 14 03:39:28 volumio wireless.js[776]: DHCP IP Jan 14 03:39:28 volumio wireless.js[776]: Start ap Jan 14 03:39:28 volumio sudo[895]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd Jan 14 03:39:28 volumio sudo[895]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 14 03:39:28 volumio dhcpcd[899]: version 6.0.5 starting Jan 14 03:39:28 volumio kernel: brcmfmac: power management disabled Jan 14 03:39:28 volumio nmbd[660]: Starting NetBIOS name server: nmbdmkdir failed on directory /var/log/samba/cores: No such file or directory Jan 14 03:39:28 volumio nmbd[660]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Jan 14 03:39:28 volumio nmbd[660]: Unable to setup corepath for nmbd: No such file or directory Jan 14 03:39:28 volumio nmbd[890]: [2025/01/14 03:39:28.843175, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jan 14 03:39:28 volumio nmbd[890]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Jan 14 03:39:28 volumio nmbd[660]: [2025/01/14 03:39:28, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jan 14 03:39:28 volumio nmbd[660]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Jan 14 03:39:28 volumio nmbd[660]: [2025/01/14 03:39:28, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jan 14 03:39:28 volumio nmbd[660]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Jan 14 03:39:28 volumio nmbd[660]: [2025/01/14 03:39:28, 0] ../source3/nmbd/nmbd.c:908(main) Jan 14 03:39:28 volumio nmbd[660]: nmbd version 4.2.14-Debian started. Jan 14 03:39:28 volumio nmbd[660]: Copyright Andrew Tridgell and the Samba Team 1992-2014 Jan 14 03:39:28 volumio nmbd[660]: [2025/01/14 03:39:28.843175, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jan 14 03:39:28 volumio nmbd[660]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Jan 14 03:39:28 volumio nmbd[890]: [2025/01/14 03:39:28.898977, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jan 14 03:39:28 volumio nmbd[890]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Jan 14 03:39:28 volumio nmbd[908]: [2025/01/14 03:39:28.905240, 0] ../source3/nmbd/asyncdns.c:157(start_async_dns) Jan 14 03:39:28 volumio nmbd[908]: started asyncdns process 909 Jan 14 03:39:28 volumio nmbd[908]: [2025/01/14 03:39:28.916163, 0] ../lib/util/become_daemon.c:124(daemon_ready) Jan 14 03:39:28 volumio nmbd[908]: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Jan 14 03:39:28 volumio systemd[1]: Started LSB: start Samba NetBIOS nameserver (nmbd). Jan 14 03:39:28 volumio systemd[1]: Starting LSB: start Samba SMB/CIFS daemon (smbd)... Jan 14 03:39:28 volumio nmbd[660]: [2025/01/14 03:39:28.898977, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jan 14 03:39:28 volumio nmbd[660]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Jan 14 03:39:28 volumio nmbd[660]: . Jan 14 03:39:29 volumio dhcpcd[899]: eth0: soliciting a DHCP lease Jan 14 03:39:29 volumio dhcpcd[899]: wlan0: waiting for carrier Jan 14 03:39:29 volumio dhcpcd[899]: eth0: offered 192.168.179.13 from 192.168.179.1 Jan 14 03:39:29 volumio dhcpcd[899]: eth0: leased 192.168.179.13 for 86400 seconds Jan 14 03:39:29 volumio dhcpcd[899]: eth0: adding host route to 192.168.179.13 via 127.0.0.1 Jan 14 03:39:29 volumio dhcpcd[899]: eth0: adding route to 192.168.179.0/24 Jan 14 03:39:29 volumio dhcpcd[495]: eth0: removing route to 192.168.179.0/24 Jan 14 03:39:29 volumio dhcpcd[899]: eth0: adding default route via 192.168.179.1 Jan 14 03:39:29 volumio dhcpcd[495]: eth0: removing default route via 192.168.179.1 Jan 14 03:39:29 volumio dhcpcd[962]: eth0: removing route to 192.168.179.0/24 Jan 14 03:39:29 volumio dhcpcd[962]: eth0: removing default route via 192.168.179.1 Jan 14 03:39:29 volumio dhcpcd[899]: forked to background, child pid 962 Jan 14 03:39:29 volumio sudo[895]: pam_unix(sudo:session): session closed for user root Jan 14 03:39:29 volumio winbind[656]: Starting the Winbind daemon: winbindmkdir failed on directory /var/log/samba/cores: No such file or directory Jan 14 03:39:29 volumio winbind[656]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Jan 14 03:39:29 volumio winbind[656]: Unable to setup corepath for winbindd: No such file or directory Jan 14 03:39:29 volumio winbind[656]: mkdir failed on directory /var/log/samba/cores: No such file or directory Jan 14 03:39:29 volumio winbind[656]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Jan 14 03:39:29 volumio winbind[656]: Unable to setup corepath for winbindd: No such file or directory Jan 14 03:39:29 volumio winbind[656]: [2025/01/14 03:39:29, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jan 14 03:39:29 volumio winbind[656]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Jan 14 03:39:29 volumio winbind[656]: [2025/01/14 03:39:29, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jan 14 03:39:29 volumio winbind[656]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Jan 14 03:39:29 volumio winbind[656]: [2025/01/14 03:39:29, 0] ../source3/winbindd/winbindd.c:1549(main) Jan 14 03:39:29 volumio winbind[656]: winbindd version 4.2.14-Debian started. Jan 14 03:39:29 volumio winbind[656]: Copyright Andrew Tridgell and the Samba Team 1992-2014 Jan 14 03:39:29 volumio winbind[656]: [2025/01/14 03:39:29, 0] ../lib/util/util.c:220(directory_create_or_exist) Jan 14 03:39:29 volumio winbind[656]: mkdir failed on directory /var/log/samba/cores: No such file or directory Jan 14 03:39:29 volumio winbind[656]: [2025/01/14 03:39:29, 0] ../source3/lib/dumpcore.c:59(get_default_corepath) Jan 14 03:39:29 volumio winbind[656]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Jan 14 03:39:29 volumio winbind[656]: [2025/01/14 03:39:29, 0] ../source3/lib/dumpcore.c:250(dump_core_setup) Jan 14 03:39:29 volumio winbind[656]: Unable to setup corepath for winbindd: No such file or directory Jan 14 03:39:29 volumio winbindd[871]: [2025/01/14 03:39:29.555572, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jan 14 03:39:29 volumio winbindd[871]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Jan 14 03:39:29 volumio winbindd[871]: [2025/01/14 03:39:29.557510, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jan 14 03:39:29 volumio winbindd[871]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Jan 14 03:39:29 volumio winbind[656]: [2025/01/14 03:39:29.555572, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jan 14 03:39:29 volumio winbind[656]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Jan 14 03:39:29 volumio winbind[656]: [2025/01/14 03:39:29.557510, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jan 14 03:39:29 volumio winbind[656]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Jan 14 03:39:29 volumio systemd[1]: Started LSB: start Winbind daemon. Jan 14 03:39:29 volumio wpa_supplicant[894]: Successfully initialized wpa_supplicant Jan 14 03:39:29 volumio winbind[656]: . Jan 14 03:39:29 volumio winbindd[968]: [2025/01/14 03:39:29.605912, 0] ../source3/winbindd/winbindd_cache.c:3235(initialize_winbindd_cache) Jan 14 03:39:29 volumio winbindd[968]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Jan 14 03:39:29 volumio wireless.js[776]: trying... Jan 14 03:39:29 volumio sudo[970]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 14 03:39:29 volumio sudo[970]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 14 03:39:29 volumio sudo[970]: pam_unix(sudo:session): session closed for user root Jan 14 03:39:30 volumio wpa_supplicant[981]: wlan0: Trying to associate with 08:10:86:d0:57:b9 (SSID='SPW_X11_fbfeb2' freq=2437 MHz) Jan 14 03:39:30 volumio wireless.js[776]: trying... Jan 14 03:39:30 volumio sudo[985]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 14 03:39:30 volumio sudo[985]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 14 03:39:30 volumio sudo[985]: pam_unix(sudo:session): session closed for user root Jan 14 03:39:30 volumio wpa_supplicant[981]: wlan0: Associated with 08:10:86:d0:57:b9 Jan 14 03:39:30 volumio wpa_supplicant[981]: wlan0: WPA: Key negotiation completed with 08:10:86:d0:57:b9 [PTK=CCMP GTK=CCMP] Jan 14 03:39:30 volumio wpa_supplicant[981]: wlan0: CTRL-EVENT-CONNECTED - Connection to 08:10:86:d0:57:b9 completed [id=0 id_str=] Jan 14 03:39:30 volumio dhcpcd[962]: wlan0: carrier acquired Jan 14 03:39:31 volumio wpa_supplicant[981]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=JP Jan 14 03:39:31 volumio wireless.js[776]: trying... Jan 14 03:39:31 volumio sudo[1013]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 14 03:39:31 volumio sudo[1013]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 14 03:39:31 volumio sudo[1013]: pam_unix(sudo:session): session closed for user root Jan 14 03:39:32 volumio wireless.js[776]: trying... Jan 14 03:39:33 volumio sudo[1022]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 14 03:39:33 volumio dhcpcd[962]: wlan0: soliciting a DHCP lease Jan 14 03:39:33 volumio sudo[1022]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 14 03:39:33 volumio sudo[1022]: pam_unix(sudo:session): session closed for user root Jan 14 03:39:33 volumio winbindd[968]: [2025/01/14 03:39:33.062502, 0] ../lib/util/become_daemon.c:124(daemon_ready) Jan 14 03:39:33 volumio winbindd[968]: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Jan 14 03:39:33 volumio winbindd[1028]: [2025/01/14 03:39:33.070245, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jan 14 03:39:33 volumio winbindd[1028]: Unable to open new log file '/var/log/samba/log.wb-VOLUMIO': No such file or directory Jan 14 03:39:33 volumio smbd[910]: Starting SMB/CIFS daemon: smbd[2025/01/14 03:39:33, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jan 14 03:39:33 volumio smbd[910]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Jan 14 03:39:33 volumio smbd[910]: [2025/01/14 03:39:33, 0] ../lib/util/util.c:220(directory_create_or_exist) Jan 14 03:39:33 volumio smbd[910]: mkdir failed on directory /var/log/samba/cores: No such file or directory Jan 14 03:39:33 volumio smbd[910]: [2025/01/14 03:39:33, 0] ../source3/lib/dumpcore.c:59(get_default_corepath) Jan 14 03:39:33 volumio smbd[910]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Jan 14 03:39:33 volumio smbd[910]: [2025/01/14 03:39:33, 0] ../source3/lib/dumpcore.c:250(dump_core_setup) Jan 14 03:39:33 volumio smbd[910]: Unable to setup corepath for smbd: No such file or directory Jan 14 03:39:33 volumio smbd[910]: [2025/01/14 03:39:33, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jan 14 03:39:33 volumio smbd[910]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Jan 14 03:39:33 volumio smbd[910]: [2025/01/14 03:39:33, 0] ../source3/smbd/server.c:1241(main) Jan 14 03:39:33 volumio smbd[910]: smbd version 4.2.14-Debian started. Jan 14 03:39:33 volumio smbd[910]: Copyright Andrew Tridgell and the Samba Team 1992-2014 Jan 14 03:39:33 volumio smbd[983]: [2025/01/14 03:39:33.408083, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jan 14 03:39:33 volumio smbd[983]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Jan 14 03:39:33 volumio smbd[983]: [2025/01/14 03:39:33.410596, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jan 14 03:39:33 volumio smbd[983]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Jan 14 03:39:33 volumio smbd[983]: [2025/01/14 03:39:33.410895, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jan 14 03:39:33 volumio smbd[983]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Jan 14 03:39:33 volumio smbd[910]: [2025/01/14 03:39:33.408083, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jan 14 03:39:33 volumio smbd[910]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Jan 14 03:39:33 volumio smbd[910]: [2025/01/14 03:39:33.410596, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jan 14 03:39:33 volumio smbd[910]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Jan 14 03:39:33 volumio smbd[910]: [2025/01/14 03:39:33.410895, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jan 14 03:39:33 volumio smbd[910]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Jan 14 03:39:33 volumio smbd[910]: . Jan 14 03:39:33 volumio systemd[1]: Started LSB: start Samba SMB/CIFS daemon (smbd). Jan 14 03:39:33 volumio winbindd[1034]: [2025/01/14 03:39:33.487426, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jan 14 03:39:33 volumio winbindd[1034]: Unable to open new log file '/var/log/samba/log.winbindd-idmap': No such file or directory Jan 14 03:39:33 volumio winbindd[1035]: [2025/01/14 03:39:33.538559, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jan 14 03:39:33 volumio winbindd[1035]: Unable to open new log file '/var/log/samba/log.wb-BUILTIN': No such file or directory Jan 14 03:39:33 volumio smbd[1031]: [2025/01/14 03:39:33.605985, 0] ../lib/util/become_daemon.c:124(daemon_ready) Jan 14 03:39:33 volumio smbd[1031]: STATUS=daemon 'smbd' finished starting up and ready to serve connections Jan 14 03:39:33 volumio smbd[1036]: [2025/01/14 03:39:33.613823, 0] ../lib/util/debug.c:603(reopen_logs_internal) Jan 14 03:39:33 volumio smbd[1036]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Jan 14 03:39:34 volumio wireless.js[776]: trying... Jan 14 03:39:34 volumio sudo[1039]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 14 03:39:34 volumio sudo[1039]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 14 03:39:34 volumio sudo[1039]: pam_unix(sudo:session): session closed for user root Jan 14 03:39:35 volumio wireless.js[776]: trying... Jan 14 03:39:35 volumio sudo[1048]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 14 03:39:35 volumio sudo[1048]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 14 03:39:35 volumio sudo[1048]: pam_unix(sudo:session): session closed for user root Jan 14 03:39:35 volumio volumio-remote-updater[650]: [2025-01-14 03:39:35] [info] asio async_connect error: system:111 (Connection refused) Jan 14 03:39:35 volumio volumio-remote-updater[650]: [2025-01-14 03:39:35] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Jan 14 03:39:35 volumio volumio-remote-updater[650]: [2025-01-14 03:39:35] [error] handle_connect error: Underlying Transport Error Jan 14 03:39:36 volumio dhcpcd[962]: wlan0: offered 192.168.179.26 from 192.168.179.1 Jan 14 03:39:36 volumio dhcpcd[962]: wlan0: leased 192.168.179.26 for 86400 seconds Jan 14 03:39:36 volumio avahi-daemon[675]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.179.26. Jan 14 03:39:36 volumio avahi-daemon[675]: New relevant interface wlan0.IPv4 for mDNS. Jan 14 03:39:36 volumio dhcpcd[962]: eth0: adding route to 192.168.179.0/24 Jan 14 03:39:36 volumio avahi-daemon[675]: Registering new address record for 192.168.179.26 on wlan0.IPv4. Jan 14 03:39:36 volumio dhcpcd[962]: eth0: adding default route via 192.168.179.1 Jan 14 03:39:36 volumio dhcpcd[962]: wlan0: adding host route to 192.168.179.26 via 127.0.0.1 Jan 14 03:39:36 volumio dhcpcd[962]: wlan0: adding route to 192.168.179.0/24 Jan 14 03:39:36 volumio dhcpcd[962]: wlan0: adding default route via 192.168.179.1 Jan 14 03:39:36 volumio wireless.js[776]: trying... Jan 14 03:39:36 volumio sudo[1057]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 14 03:39:36 volumio sudo[1057]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 14 03:39:36 volumio sudo[1057]: pam_unix(sudo:session): session closed for user root Jan 14 03:39:36 volumio wireless.js[776]: Connected to: ----SPW_X11_fbfeb2 Jan 14 03:39:36 volumio wireless.js[776]: ---- Jan 14 03:39:36 volumio sudo[1066]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 14 03:39:36 volumio sudo[1066]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 14 03:39:36 volumio sudo[1066]: pam_unix(sudo:session): session closed for user root Jan 14 03:39:36 volumio wireless.js[776]: ... joined AP, wlan0 IPv4 is 192.168.179.26, ipV6 is undefined Jan 14 03:39:36 volumio wireless.js[776]: It's done! AP Jan 14 03:39:36 volumio systemd[1]: Started Wireless Services. Jan 14 03:39:36 volumio systemd[1]: Starting Volumio Backend Module... Jan 14 03:39:36 volumio systemd[1]: Started Volumio Backend Module. Jan 14 03:39:36 volumio systemd[1]: Starting Volumio Streaming Daemon... Jan 14 03:39:36 volumio systemd[1]: Started Volumio Streaming Daemon. Jan 14 03:39:37 volumio dhcpcd[962]: eth0: removing route to 192.168.179.0/24 Jan 14 03:39:37 volumio dhcpcd[962]: eth0: removing default route via 192.168.179.1 Jan 14 03:39:37 volumio ntpd[750]: Listen normally on 4 wlan0 192.168.179.26 UDP 123 Jan 14 03:39:37 volumio ntpd[750]: peers refreshed Jan 14 03:39:40 volumio volumio-streaming-daemon[1076]: ############################ Jan 14 03:39:40 volumio volumio-streaming-daemon[1076]: # Volumio Streaming Daemon # Jan 14 03:39:40 volumio volumio-streaming-daemon[1076]: # Running on port 7777 # Jan 14 03:39:40 volumio volumio-streaming-daemon[1076]: ############################ Jan 14 03:39:43 volumio volumio[1075]: info: ------------------------------------------- Jan 14 03:39:43 volumio volumio[1075]: info: ----- Volumio2 ---- Jan 14 03:39:43 volumio volumio[1075]: info: ------------------------------------------- Jan 14 03:39:43 volumio volumio[1075]: info: ----- System startup ---- Jan 14 03:39:43 volumio volumio[1075]: info: ------------------------------------------- Jan 14 03:39:44 volumio volumio[1075]: info: MYVOLUMIO Environment detected Jan 14 03:39:44 volumio volumio[1075]: info: Plugin folders cleanup Jan 14 03:39:44 volumio volumio[1075]: info: Scanning into folder /volumio/app/plugins/ Jan 14 03:39:44 volumio volumio[1075]: info: Scanning category audio_interface Jan 14 03:39:44 volumio volumio[1075]: info: Scanning category miscellanea Jan 14 03:39:44 volumio volumio[1075]: info: Scanning category music_service Jan 14 03:39:44 volumio volumio[1075]: info: Scanning category plugins.json Jan 14 03:39:44 volumio volumio[1075]: info: Scanning category system_controller Jan 14 03:39:44 volumio volumio[1075]: info: Scanning category user_interface Jan 14 03:39:44 volumio volumio[1075]: info: Scanning into folder /data/plugins/ Jan 14 03:39:44 volumio volumio[1075]: info: Plugin folders cleanup completed Jan 14 03:39:44 volumio volumio[1075]: info: ------------------------------------------- Jan 14 03:39:44 volumio volumio[1075]: info: ----- Core plugins startup ---- Jan 14 03:39:44 volumio volumio[1075]: info: ------------------------------------------- Jan 14 03:39:44 volumio volumio[1075]: info: Loading plugins from folder /volumio/app/plugins/ Jan 14 03:39:44 volumio volumio[1075]: info: Adding plugin upnp to MyMusic Plugins Jan 14 03:39:44 volumio volumio[1075]: info: Adding plugin airplay_emulation to MyMusic Plugins Jan 14 03:39:44 volumio volumio[1075]: info: Adding plugin upnp_browser to MyMusic Plugins Jan 14 03:39:44 volumio volumio[1075]: info: Loading plugins from folder /data/plugins/ Jan 14 03:39:44 volumio volumio[1075]: info: Loading plugin "system"... Jan 14 03:39:44 volumio volumio[1075]: info: Loading plugin "appearance"... Jan 14 03:39:45 volumio volumio-remote-updater[650]: [2025-01-14 03:39:45] [connect] Successful connection Jan 14 03:39:46 volumio volumio[1075]: info: Loading plugin "network"... Jan 14 03:39:47 volumio volumio[1075]: info: Loading plugin "services"... Jan 14 03:39:47 volumio volumio[1075]: info: Loading plugin "alsa_controller"... Jan 14 03:39:48 volumio volumio[1075]: info: Loading plugin "wizard"... Jan 14 03:39:48 volumio volumio[1075]: info: Loading plugin "volumio_command_line_client"... Jan 14 03:39:48 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 14 03:39:48 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 14 03:39:48 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 14 03:39:48 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 14 03:39:48 volumio volumio[1075]: info: Plugin upnp is not enabled Jan 14 03:39:48 volumio volumio[1075]: info: Loading plugin "my_music"... Jan 14 03:39:48 volumio volumio[1075]: info: Loading plugin "mpd"... Jan 14 03:39:49 volumio volumio[1075]: info: Plugin upnp_browser is not enabled Jan 14 03:39:49 volumio volumio[1075]: info: Loading plugin "networkfs"... Jan 14 03:39:49 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 14 03:39:49 volumio volumio[1075]: info: Loading plugin "alarm-clock"... Jan 14 03:39:50 volumio volumio[1075]: info: Plugin airplay_emulation is not enabled Jan 14 03:39:50 volumio volumio[1075]: info: Loading plugin "last_100"... Jan 14 03:39:50 volumio volumio[1075]: info: Loading plugin "webradio"... Jan 14 03:39:51 volumio volumio[1075]: info: Loading plugin "i2s_dacs"... Jan 14 03:39:51 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 14 03:39:51 volumio volumio[1075]: info: Loading plugin "volumiodiscovery"... Jan 14 03:39:51 volumio volumio[1075]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 14 03:39:51 volumio node[1075]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 14 03:39:51 volumio node[1075]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 14 03:39:51 volumio node[1075]: *** WARNING *** For more information see Jan 14 03:39:51 volumio node[1075]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 14 03:39:51 volumio node[1075]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 14 03:39:51 volumio node[1075]: *** WARNING *** For more information see Jan 14 03:39:51 volumio volumio[1075]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 14 03:39:51 volumio volumio[1075]: *** WARNING *** For more information see Jan 14 03:39:51 volumio volumio[1075]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 14 03:39:51 volumio volumio[1075]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 14 03:39:51 volumio volumio[1075]: *** WARNING *** For more information see Jan 14 03:39:51 volumio volumio[1075]: info: Applying required configuration parameters for plugin volumiodiscovery Jan 14 03:39:51 volumio volumio[1075]: Discovery: StartAdv! undefined Jan 14 03:39:51 volumio volumio[1075]: Discovery: Started advertising... Volumio - undefined Jan 14 03:39:51 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 14 03:39:51 volumio volumio[1075]: info: Loading plugin "outputs"... Jan 14 03:39:51 volumio volumio[1075]: info: Loading plugin "albumart"... Jan 14 03:39:51 volumio volumio[1075]: info: Plugin example_plugin is not enabled Jan 14 03:39:51 volumio volumio[1075]: info: Loading plugin "inputs"... Jan 14 03:39:51 volumio volumio[1075]: info: Loading plugin "updater_comm"... Jan 14 03:39:52 volumio volumio[1075]: info: Plugin mpdemulation is not enabled Jan 14 03:39:52 volumio volumio[1075]: info: Loading plugin "rest_api"... Jan 14 03:39:52 volumio volumio[1075]: info: Loading plugin "websocket"... Jan 14 03:39:52 volumio volumio[1075]: info: ___________ START PLUGINS ___________ Jan 14 03:39:52 volumio volumio[1075]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 14 03:39:52 volumio volumio[1075]: info: [1736825992212] CoreMusicLibrary::Adding element Last_100 Jan 14 03:39:52 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 14 03:39:52 volumio volumio[1075]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 14 03:39:52 volumio volumio[1075]: info: [1736825992230] CoreMusicLibrary::Adding element Webradio Jan 14 03:39:52 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 14 03:39:52 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 14 03:39:52 volumio volumio[1075]: info: ------------------------------------------- Jan 14 03:39:52 volumio volumio[1075]: info: ----- MyVolumio plugins startup ---- Jan 14 03:39:52 volumio volumio[1075]: info: ------------------------------------------- Jan 14 03:39:52 volumio volumio[1075]: info: Loading plugins from folder /myvolumio/plugins Jan 14 03:39:52 volumio volumio[1075]: info: Loading plugins from folder /data/myvolumio/plugins Jan 14 03:39:52 volumio volumio[1075]: info: Loading plugin "cd_controller"... Jan 14 03:39:52 volumio volumio[1075]: info: Loading plugin "streaming_services"... Jan 14 03:39:52 volumio volumio[1075]: Forking 3 albumart workers Jan 14 03:39:53 volumio volumio[1075]: info: Loading plugin "my_volumio"... Jan 14 03:39:54 volumio volumio[1075]: Starting albumart workers Jan 14 03:39:54 volumio volumio[1075]: Starting albumart workers Jan 14 03:39:54 volumio volumio[1075]: Starting albumart workers Jan 14 03:39:54 volumio volumio[1075]: info: Adding CD REST API Endpoints Jan 14 03:39:54 volumio volumio[1075]: info: Adding detectCD REST Endpoint for plugin: music_service/cd_controller Jan 14 03:39:54 volumio volumio[1075]: info: Adding cdRemove REST Endpoint for plugin: music_service/cd_controller Jan 14 03:39:54 volumio volumio[1075]: info: Adding cdPostScan REST Endpoint for plugin: music_service/cd_controller Jan 14 03:39:54 volumio volumio[1075]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller Jan 14 03:39:54 volumio volumio[1075]: info: Detecting CD presence Jan 14 03:39:54 volumio volumio[1075]: info: Streaming services startup Jan 14 03:39:54 volumio volumio[1075]: info: Starting Streaming Daemon Jan 14 03:39:54 volumio udisks-glue[648]: error: Timeout Jan 14 03:39:54 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 14 03:39:54 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 14 03:39:54 volumio volumio[1075]: info: Starting MyVolumio Remote Streaming Endpoints Jan 14 03:39:54 volumio sudo[1150]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jan 14 03:39:54 volumio sudo[1150]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 14 03:39:54 volumio volumio[1075]: info: Loading i18n strings for locale ja Jan 14 03:39:54 volumio systemd[1]: Stopping Volumio Streaming Daemon... Jan 14 03:39:54 volumio volumio[1075]: Updating browse sources language Jan 14 03:39:54 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 14 03:39:54 volumio systemd[1]: Starting Volumio Streaming Daemon... Jan 14 03:39:54 volumio systemd[1]: Started Volumio Streaming Daemon. Jan 14 03:39:54 volumio sudo[1150]: pam_unix(sudo:session): session closed for user root Jan 14 03:39:54 volumio volumio-streaming-daemon[1156]: ############################ Jan 14 03:39:54 volumio volumio-streaming-daemon[1156]: # Volumio Streaming Daemon # Jan 14 03:39:54 volumio volumio-streaming-daemon[1156]: # Running on port 7777 # Jan 14 03:39:54 volumio volumio-streaming-daemon[1156]: ############################ Jan 14 03:39:54 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 14 03:39:54 volumio volumio[1075]: info: CoreCommandRouter::initPlayerControls Jan 14 03:39:54 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 14 03:39:54 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Jan 14 03:39:55 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 14 03:39:55 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 14 03:39:55 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 14 03:39:55 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 14 03:39:55 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 14 03:39:55 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 14 03:39:55 volumio volumio[1075]: info: BOOT COMPLETED Jan 14 03:39:55 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 14 03:39:55 volumio kernel: pcm512x 1-004d: No SCLK, using BCLK: -2 Jan 14 03:40:00 volumio volumio[1075]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Jan 14 03:40:00 volumio volumio[1075]: info: CoreCommandRouter::Close All Modals sent Jan 14 03:40:00 volumio volumio[1075]: info: CoreCommandRouter::Close All Modals sent Jan 14 03:40:00 volumio volumio[1075]: Express server listening on port 3000 Jan 14 03:40:00 volumio volumio[1075]: Volumio Calling Home Jan 14 03:40:00 volumio volumio[1075]: info: MyVolumio not started Jan 14 03:40:00 volumio volumio[1075]: info: Initializing device activation check Jan 14 03:40:00 volumio volumio[1075]: info: CoreStateMachine::resetVolumioState Jan 14 03:40:00 volumio volumio[1075]: info: CoreStateMachine::getcurrentVolume Jan 14 03:40:00 volumio volumio[1075]: info: CoreCommandRouter::volumioRetrievevolume Jan 14 03:40:00 volumio volumio-remote-updater[650]: [2025-01-14 03:40:00] [connect] Successful connection Jan 14 03:40:01 volumio volumio[1075]: info: Setting Device type: Raspberry PI Jan 14 03:40:01 volumio volumio[1075]: info: MPD running with PID678 ,establishing connection Jan 14 03:40:01 volumio volumio-remote-updater[650]: [2025-01-14 03:40:01] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1736826000 101 Jan 14 03:40:01 volumio volumio[1075]: info: VolumeController:: Volume=100 Mute =false Jan 14 03:40:01 volumio volumio[1075]: info: CoreStateMachine::pushState Jan 14 03:40:01 volumio volumio[1075]: info: CoreStateMachine::getState Jan 14 03:40:01 volumio volumio[1075]: info: CorePlayQueue::getTrack 0 Jan 14 03:40:01 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Jan 14 03:40:01 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 14 03:40:01 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Jan 14 03:40:01 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Jan 14 03:40:01 volumio volumio[1075]: info: Jan 14 03:40:01 volumio volumio[1075]: ---------------------------- Client requests Volume 20 Jan 14 03:40:01 volumio volumio[1075]: info: VolumeController::SetAlsaVolume20 Jan 14 03:40:01 volumio volumio[1075]: info: CoreStateMachine::pushState Jan 14 03:40:01 volumio volumio[1075]: info: CoreStateMachine::getState Jan 14 03:40:01 volumio volumio[1075]: info: CorePlayQueue::getTrack 0 Jan 14 03:40:01 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Jan 14 03:40:01 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 14 03:40:02 volumio volumio[1075]: info: Reloading queue from file Jan 14 03:40:02 volumio volumio[1075]: info: Setting volume on startup at 20 Jan 14 03:40:02 volumio volumio[1075]: info: CoreStateMachine::setRepeat false single undefined Jan 14 03:40:02 volumio volumio[1075]: info: CoreStateMachine::pushState Jan 14 03:40:02 volumio volumio[1075]: info: CoreStateMachine::getState Jan 14 03:40:02 volumio volumio[1075]: info: CorePlayQueue::getTrack 0 Jan 14 03:40:02 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Jan 14 03:40:02 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 14 03:40:02 volumio volumio[1075]: info: CoreStateMachine::setRandom false Jan 14 03:40:02 volumio volumio[1075]: info: CoreStateMachine::pushState Jan 14 03:40:02 volumio volumio[1075]: info: CoreStateMachine::getState Jan 14 03:40:02 volumio volumio[1075]: info: CorePlayQueue::getTrack 0 Jan 14 03:40:02 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Jan 14 03:40:02 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 14 03:40:02 volumio volumio[1075]: Discovery: adding 78fe0e23-efce-4d83-b5cc-be6982c07f53 Jan 14 03:40:02 volumio volumio[1075]: info: mDNS: Found device Volumio Jan 14 03:40:02 volumio volumio[1075]: Discovery: this is already registered, 78fe0e23-efce-4d83-b5cc-be6982c07f53 Jan 14 03:40:02 volumio volumio[1075]: info: mDNS: Found device Volumio Jan 14 03:40:02 volumio sudo[1187]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 14 03:40:02 volumio sudo[1187]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 14 03:40:02 volumio sudo[1187]: pam_unix(sudo:session): session closed for user root Jan 14 03:40:02 volumio sudo[1193]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 14 03:40:02 volumio sudo[1193]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 14 03:40:02 volumio sudo[1193]: pam_unix(sudo:session): session closed for user root Jan 14 03:40:02 volumio volumio[1075]: info: CoreCommandRouter::volumioGetState Jan 14 03:40:02 volumio volumio[1075]: info: CoreStateMachine::getState Jan 14 03:40:02 volumio volumio[1075]: info: CorePlayQueue::getTrack 0 Jan 14 03:40:02 volumio sudo[1205]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 14 03:40:02 volumio sudo[1205]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 14 03:40:02 volumio sudo[1205]: pam_unix(sudo:session): session closed for user root Jan 14 03:40:03 volumio volumio[1075]: info: Fetching Streaming Services browse cache Jan 14 03:40:04 volumio volumio[1075]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesQOBUZ Jan 14 03:40:04 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 14 03:40:04 volumio volumio[1075]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesTIDAL Jan 14 03:40:04 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 14 03:40:04 volumio sudo[1215]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 14 03:40:04 volumio sudo[1217]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 14 03:40:04 volumio sudo[1215]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 14 03:40:04 volumio sudo[1217]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 14 03:40:04 volumio sudo[1215]: pam_unix(sudo:session): session closed for user root Jan 14 03:40:04 volumio sudo[1217]: pam_unix(sudo:session): session closed for user root Jan 14 03:40:04 volumio volumio[1075]: info: CoreCommandRouter::volumioGetVisibleSources Jan 14 03:40:04 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 14 03:40:04 volumio volumio[1075]: info: CoreCommandRouter::volumioGetState Jan 14 03:40:04 volumio volumio[1075]: info: CoreStateMachine::getState Jan 14 03:40:04 volumio volumio[1075]: info: CorePlayQueue::getTrack 0 Jan 14 03:40:04 volumio sudo[1233]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 14 03:40:04 volumio sudo[1233]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 14 03:40:04 volumio sudo[1233]: pam_unix(sudo:session): session closed for user root Jan 14 03:40:05 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jan 14 03:40:05 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jan 14 03:40:05 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jan 14 03:40:05 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jan 14 03:40:05 volumio volumio[1075]: info: Listing playlists Jan 14 03:40:05 volumio sudo[1242]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 14 03:40:05 volumio sudo[1242]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 14 03:40:05 volumio sudo[1242]: pam_unix(sudo:session): session closed for user root Jan 14 03:40:06 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jan 14 03:40:11 volumio volumio[1075]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=2.587&uuid=32234fa12c679bf870f2b323777fa2b8" http://updates.volumio.org:7070/downloader-v1/track-device Jan 14 03:40:11 volumio volumio[1075]: % Total % Received % Xferd Average Speed Time Time Time Current Jan 14 03:40:11 volumio volumio[1075]: Dload Upload Total Spent Left Speed Jan 14 03:40:11 volumio volumio[1075]: 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0curl: (7) Failed to connect to updates.volumio.org port 7070: Connection refused Jan 14 03:40:11 volumio volumio[1075]: retrying in 5 seconds, trial 0 Jan 14 03:40:11 volumio volumio[1075]: Volumio Calling Home Jan 14 03:40:17 volumio volumio[1075]: info: CoreCommandRouter::volumioGetQueue Jan 14 03:40:17 volumio volumio[1075]: info: CoreStateMachine::getQueue Jan 14 03:40:17 volumio volumio[1075]: info: CorePlayQueue::getQueue Jan 14 03:40:17 volumio volumio[1075]: info: No input data Jan 14 03:40:17 volumio volumio[1075]: info: No input data Jan 14 03:40:18 volumio volumio[1075]: info: No input data Jan 14 03:40:18 volumio volumio[1075]: info: No input data Jan 14 03:40:18 volumio volumio[1075]: info: No input data Jan 14 03:40:19 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jan 14 03:40:19 volumio volumio[1075]: info: CURURI: music-library Jan 14 03:40:22 volumio volumio[1075]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=2.587&uuid=32234fa12c679bf870f2b323777fa2b8" http://updates.volumio.org:7070/downloader-v1/track-device Jan 14 03:40:22 volumio volumio[1075]: % Total % Received % Xferd Average Speed Time Time Time Current Jan 14 03:40:22 volumio volumio[1075]: Dload Upload Total Spent Left Speed Jan 14 03:40:22 volumio volumio[1075]: 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0curl: (7) Failed to connect to updates.volumio.org port 7070: Connection refused Jan 14 03:40:22 volumio volumio[1075]: retrying in 5 seconds, trial 1 Jan 14 03:40:22 volumio volumio[1075]: Volumio Calling Home Jan 14 03:40:22 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 14 03:40:22 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 14 03:40:29 volumio volumio[1075]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 14 03:40:29 volumio volumio[1075]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 14 03:40:30 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jan 14 03:40:30 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jan 14 03:40:30 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jan 14 03:40:30 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jan 14 03:40:30 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 14 03:40:30 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 14 03:40:30 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 14 03:40:30 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 14 03:40:30 volumio volumio[1075]: info: CoreCommandRouter::volumioGetBrowseSources Jan 14 03:40:30 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 14 03:40:30 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jan 14 03:40:32 volumio volumio[1075]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=2.587&uuid=32234fa12c679bf870f2b323777fa2b8" http://updates.volumio.org:7070/downloader-v1/track-device Jan 14 03:40:32 volumio volumio[1075]: % Total % Received % Xferd Average Speed Time Time Time Current Jan 14 03:40:32 volumio volumio[1075]: Dload Upload Total Spent Left Speed Jan 14 03:40:32 volumio volumio[1075]: 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0curl: (7) Failed to connect to updates.volumio.org port 7070: Connection refused Jan 14 03:40:32 volumio volumio[1075]: retrying in 5 seconds, trial 2 Jan 14 03:40:32 volumio volumio[1075]: Volumio Calling Home Jan 14 03:40:34 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 14 03:40:38 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 14 03:40:42 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 14 03:40:46 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jan 14 03:40:51 volumio systemd[1]: mpd.service start operation timed out. Terminating. Jan 14 03:40:51 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jan 14 03:40:51 volumio volumio[1075]: info: CURURI: albums:// Jan 14 03:40:51 volumio volumio[1075]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 14 03:40:51 volumio volumio[1075]: { AssertionError [ERR_ASSERTION]: false == true Jan 14 03:40:51 volumio volumio[1075]: at MpdClient.sendCommand (/volumio/app/plugins/music_service/mpd/lib/mpd.js:92:9) Jan 14 03:40:51 volumio volumio[1075]: at /volumio/app/plugins/music_service/mpd/index.js:3061:19 Jan 14 03:40:51 volumio volumio[1075]: at _combinedTickCallback (internal/process/next_tick.js:131:7) Jan 14 03:40:51 volumio volumio[1075]: at process._tickCallback (internal/process/next_tick.js:180:9) Jan 14 03:40:51 volumio volumio[1075]: generatedMessage: true, Jan 14 03:40:51 volumio volumio[1075]: name: 'AssertionError [ERR_ASSERTION]', Jan 14 03:40:51 volumio volumio[1075]: code: 'ERR_ASSERTION', Jan 14 03:40:51 volumio volumio[1075]: actual: false, Jan 14 03:40:51 volumio volumio[1075]: expected: true, Jan 14 03:40:51 volumio volumio[1075]: operator: '==' } Jan 14 03:40:51 volumio volumio[1075]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 14 03:40:53 volumio systemd[1]: Failed to start Music Player Daemon. Jan 14 03:40:53 volumio systemd[1]: Unit mpd.service entered failed state. Jan 14 03:40:53 volumio systemd[1]: Starting Music Player Daemon... Jan 14 03:40:54 volumio sudo[1273]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-01-14 03:39 Jan 14 03:40:54 volumio sudo[1273]: 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="074a8b52bd03468c65e5a209cdebba5007f34703" VOLUMIO_FE_VERSION="5db94767d659330af647ae45872bf36d33ac66f0" VOLUMIO_BE_VERSION="3471ca4b1cd31c92377257fc1329bec5decac71b" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Jun 11 23:06:27 CEST 2019" VOLUMIO_VERSION="2.587" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="35bc50d6dcafb6f68a8cd72776953365"