-- Logs begin at Sun 2024-08-18 10:59:12 UTC, end at Sun 2024-08-18 11:08:59 UTC. -- Aug 18 11:08:36 biblio systemd[1]: Time has been changed Aug 18 11:08:36 biblio sudo[1255]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd Aug 18 11:08:36 biblio sudo[1255]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 11:08:36 biblio dhcpcd[1259]: version 6.0.5 starting Aug 18 11:08:36 biblio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Aug 18 11:08:36 biblio wpa_supplicant[1254]: Successfully initialized wpa_supplicant Aug 18 11:08:36 biblio dhcpcd[1259]: eth0: soliciting an IPv6 router Aug 18 11:08:36 biblio dhcpcd[1259]: eth0: rebinding lease of 192.168.39.127 Aug 18 11:08:36 biblio dhcpcd[1259]: wlan0: waiting for carrier Aug 18 11:08:36 biblio dhcpcd[1259]: eth0: leased 192.168.39.127 for 86400 seconds Aug 18 11:08:36 biblio dhcpcd[600]: eth0: removing route to 192.168.39.0/24 Aug 18 11:08:36 biblio dhcpcd[1259]: eth0: adding host route to 192.168.39.127 via 127.0.0.1 Aug 18 11:08:36 biblio dhcpcd[1259]: eth0: adding route to 192.168.39.0/24 Aug 18 11:08:36 biblio dhcpcd[1259]: eth0: adding default route via 192.168.39.1 Aug 18 11:08:36 biblio dhcpcd[600]: eth0: removing default route via 192.168.39.1 Aug 18 11:08:36 biblio dhcpcd[1259]: forked to background, child pid 1321 Aug 18 11:08:36 biblio sudo[1255]: pam_unix(sudo:session): session closed for user root Aug 18 11:08:36 biblio dhcpcd[1321]: eth0: removing route to 192.168.39.0/24 Aug 18 11:08:36 biblio dhcpcd[1321]: eth0: removing default route via 192.168.39.1 Aug 18 11:08:36 biblio wpa_supplicant[1298]: wlan0: Trying to associate with SSID 'Skogtun' Aug 18 11:08:37 biblio systemd[1]: Started Music Player Daemon. Aug 18 11:08:37 biblio udisks-glue[692]: Updating DB (#1) ... Aug 18 11:08:37 biblio udisks-glue[692]: volume: 40% repeat: off random: off single: off consume: off Aug 18 11:08:37 biblio smbd[1221]: Starting SMB/CIFS daemon: smbd[2024/08/18 11:08:37, 0] ../lib/util/debug.c:603(reopen_logs_internal) Aug 18 11:08:37 biblio smbd[1221]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Aug 18 11:08:37 biblio smbd[1221]: [2024/08/18 11:08:37, 0] ../lib/util/util.c:220(directory_create_or_exist) Aug 18 11:08:37 biblio smbd[1221]: mkdir failed on directory /var/log/samba/cores: No such file or directory Aug 18 11:08:37 biblio smbd[1221]: [2024/08/18 11:08:37, 0] ../source3/lib/dumpcore.c:59(get_default_corepath) Aug 18 11:08:37 biblio smbd[1221]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Aug 18 11:08:37 biblio smbd[1221]: [2024/08/18 11:08:37, 0] ../source3/lib/dumpcore.c:250(dump_core_setup) Aug 18 11:08:37 biblio smbd[1221]: Unable to setup corepath for smbd: No such file or directory Aug 18 11:08:37 biblio smbd[1221]: [2024/08/18 11:08:37, 0] ../lib/util/debug.c:603(reopen_logs_internal) Aug 18 11:08:37 biblio smbd[1221]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Aug 18 11:08:37 biblio smbd[1221]: [2024/08/18 11:08:37, 0] ../source3/smbd/server.c:1241(main) Aug 18 11:08:37 biblio smbd[1221]: smbd version 4.2.14-Debian started. Aug 18 11:08:37 biblio smbd[1221]: Copyright Andrew Tridgell and the Samba Team 1992-2014 Aug 18 11:08:37 biblio wireless.js[1073]: trying... Aug 18 11:08:37 biblio sudo[1330]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 18 11:08:37 biblio smbd[1326]: [2024/08/18 11:08:37.166947, 0] ../lib/util/debug.c:603(reopen_logs_internal) Aug 18 11:08:37 biblio smbd[1326]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Aug 18 11:08:37 biblio smbd[1221]: [2024/08/18 11:08:37.166947, 0] ../lib/util/debug.c:603(reopen_logs_internal) Aug 18 11:08:37 biblio smbd[1221]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Aug 18 11:08:37 biblio smbd[1326]: [2024/08/18 11:08:37.169894, 0] ../lib/util/debug.c:603(reopen_logs_internal) Aug 18 11:08:37 biblio smbd[1326]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Aug 18 11:08:37 biblio smbd[1326]: [2024/08/18 11:08:37.170364, 0] ../lib/util/debug.c:603(reopen_logs_internal) Aug 18 11:08:37 biblio smbd[1326]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Aug 18 11:08:37 biblio sudo[1330]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 11:08:37 biblio smbd[1221]: [2024/08/18 11:08:37.169894, 0] ../lib/util/debug.c:603(reopen_logs_internal) Aug 18 11:08:37 biblio smbd[1221]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Aug 18 11:08:37 biblio smbd[1221]: [2024/08/18 11:08:37.170364, 0] ../lib/util/debug.c:603(reopen_logs_internal) Aug 18 11:08:37 biblio smbd[1221]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Aug 18 11:08:37 biblio smbd[1221]: . Aug 18 11:08:37 biblio systemd[1]: Started LSB: start Samba SMB/CIFS daemon (smbd). Aug 18 11:08:37 biblio sudo[1330]: pam_unix(sudo:session): session closed for user root Aug 18 11:08:37 biblio winbindd[1341]: [2024/08/18 11:08:37.262129, 0] ../lib/util/debug.c:603(reopen_logs_internal) Aug 18 11:08:37 biblio winbindd[1341]: Unable to open new log file '/var/log/samba/log.winbindd-idmap': No such file or directory Aug 18 11:08:37 biblio winbindd[1342]: [2024/08/18 11:08:37.345404, 0] ../lib/util/debug.c:603(reopen_logs_internal) Aug 18 11:08:37 biblio winbindd[1342]: Unable to open new log file '/var/log/samba/log.wb-BUILTIN': No such file or directory Aug 18 11:08:37 biblio smbd[1334]: [2024/08/18 11:08:37.415259, 0] ../lib/util/become_daemon.c:124(daemon_ready) Aug 18 11:08:37 biblio smbd[1334]: STATUS=daemon 'smbd' finished starting up and ready to serve connections Aug 18 11:08:37 biblio smbd[1343]: [2024/08/18 11:08:37.424162, 0] ../lib/util/debug.c:603(reopen_logs_internal) Aug 18 11:08:37 biblio smbd[1343]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Aug 18 11:08:37 biblio wpa_supplicant[1298]: wlan0: Associated with 34:21:09:45:eb:99 Aug 18 11:08:37 biblio wpa_supplicant[1298]: wlan0: WPA: Key negotiation completed with 34:21:09:45:eb:99 [PTK=CCMP GTK=TKIP] Aug 18 11:08:37 biblio wpa_supplicant[1298]: wlan0: CTRL-EVENT-CONNECTED - Connection to 34:21:09:45:eb:99 completed [id=0 id_str=] Aug 18 11:08:37 biblio dhcpcd[1321]: wlan0: carrier acquired Aug 18 11:08:37 biblio dhcpcd[1321]: wlan0: soliciting an IPv6 router Aug 18 11:08:37 biblio dhcpcd[1321]: wlan0: rebinding lease of 192.168.39.119 Aug 18 11:08:37 biblio nmbd[1219]: [2024/08/18 11:08:37.787360, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Aug 18 11:08:37 biblio nmbd[1219]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.39.127 for name WORKGROUP<1d>. Aug 18 11:08:37 biblio nmbd[1219]: This response was from IP 192.168.39.101, reporting an IP address of 192.168.39.101. Aug 18 11:08:38 biblio wireless.js[1073]: trying... Aug 18 11:08:38 biblio sudo[1364]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 18 11:08:38 biblio sudo[1364]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 11:08:38 biblio sudo[1364]: pam_unix(sudo:session): session closed for user root Aug 18 11:08:39 biblio wireless.js[1073]: trying... Aug 18 11:08:39 biblio sudo[1373]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 18 11:08:39 biblio sudo[1373]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 11:08:39 biblio sudo[1373]: pam_unix(sudo:session): session closed for user root Aug 18 11:08:40 biblio wireless.js[1073]: trying... Aug 18 11:08:40 biblio sudo[1382]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 18 11:08:40 biblio sudo[1382]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 11:08:40 biblio sudo[1382]: pam_unix(sudo:session): session closed for user root Aug 18 11:08:41 biblio wireless.js[1073]: trying... Aug 18 11:08:41 biblio sudo[1391]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 18 11:08:41 biblio sudo[1391]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 11:08:41 biblio sudo[1391]: pam_unix(sudo:session): session closed for user root Aug 18 11:08:42 biblio wireless.js[1073]: trying... Aug 18 11:08:42 biblio sudo[1400]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 18 11:08:42 biblio sudo[1400]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 11:08:42 biblio sudo[1400]: pam_unix(sudo:session): session closed for user root Aug 18 11:08:42 biblio volumio-remote-updater[694]: [2024-08-18 11:08:42] [info] asio async_connect error: system:111 (Connection refused) Aug 18 11:08:42 biblio volumio-remote-updater[694]: [2024-08-18 11:08:42] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Aug 18 11:08:42 biblio volumio-remote-updater[694]: [2024-08-18 11:08:42] [error] handle_connect error: Underlying Transport Error Aug 18 11:08:43 biblio kernel: Voltage normalised (0x00000000) Aug 18 11:08:43 biblio dhcpcd[1321]: wlan0: leased 192.168.39.119 for 86400 seconds Aug 18 11:08:43 biblio avahi-daemon[777]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.39.119. Aug 18 11:08:43 biblio dhcpcd[1321]: eth0: adding route to 192.168.39.0/24 Aug 18 11:08:43 biblio dhcpcd[1321]: eth0: adding default route via 192.168.39.1 Aug 18 11:08:43 biblio dhcpcd[1321]: wlan0: adding host route to 192.168.39.119 via 127.0.0.1 Aug 18 11:08:43 biblio dhcpcd[1321]: wlan0: adding route to 192.168.39.0/24 Aug 18 11:08:43 biblio dhcpcd[1321]: wlan0: adding default route via 192.168.39.1 Aug 18 11:08:43 biblio avahi-daemon[777]: New relevant interface wlan0.IPv4 for mDNS. Aug 18 11:08:43 biblio avahi-daemon[777]: Registering new address record for 192.168.39.119 on wlan0.IPv4. Aug 18 11:08:43 biblio wireless.js[1073]: trying... Aug 18 11:08:43 biblio sudo[1432]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 18 11:08:43 biblio sudo[1432]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 11:08:43 biblio dhcpcd[1321]: eth0: removing route to 192.168.39.0/24 Aug 18 11:08:43 biblio dhcpcd[1321]: eth0: removing default route via 192.168.39.1 Aug 18 11:08:43 biblio sudo[1432]: pam_unix(sudo:session): session closed for user root Aug 18 11:08:43 biblio wireless.js[1073]: Connected to: ----Skogtun Aug 18 11:08:43 biblio wireless.js[1073]: ---- Aug 18 11:08:43 biblio sudo[1441]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 18 11:08:43 biblio sudo[1441]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 11:08:43 biblio sudo[1441]: pam_unix(sudo:session): session closed for user root Aug 18 11:08:43 biblio wireless.js[1073]: ... joined AP, wlan0 IPv4 is 192.168.39.119, ipV6 is undefined Aug 18 11:08:43 biblio wireless.js[1073]: It's done! AP Aug 18 11:08:43 biblio systemd[1]: Started Wireless Services. Aug 18 11:08:43 biblio systemd[1]: Starting Volumio Backend Module... Aug 18 11:08:43 biblio systemd[1]: Started Volumio Backend Module. Aug 18 11:08:43 biblio systemd[1]: Starting Volumio Streaming Daemon... Aug 18 11:08:43 biblio systemd[1]: Started Volumio Streaming Daemon. Aug 18 11:08:43 biblio systemd[1]: Starting Multi-User System. Aug 18 11:08:43 biblio systemd[1]: Reached target Multi-User System. Aug 18 11:08:43 biblio systemd[1]: Starting Graphical Interface. Aug 18 11:08:43 biblio systemd[1]: Reached target Graphical Interface. Aug 18 11:08:43 biblio systemd[1]: Starting Update UTMP about System Runlevel Changes... Aug 18 11:08:43 biblio systemd[1]: Started Update UTMP about System Runlevel Changes. Aug 18 11:08:43 biblio systemd[1]: Startup finished in 9.561s (kernel) + 36.262s (userspace) = 45.823s. Aug 18 11:08:43 biblio volumio-streaming-daemon[1451]: ############################ Aug 18 11:08:43 biblio volumio-streaming-daemon[1451]: # Volumio Streaming Daemon # Aug 18 11:08:43 biblio volumio-streaming-daemon[1451]: # Running on port 7777 # Aug 18 11:08:43 biblio volumio-streaming-daemon[1451]: ############################ Aug 18 11:08:43 biblio volumio-streaming-daemon[1451]: Environment: production Aug 18 11:08:45 biblio ntpd[1001]: Listen normally on 4 wlan0 192.168.39.119 UDP 123 Aug 18 11:08:45 biblio ntpd[1001]: peers refreshed Aug 18 11:08:46 biblio volumio[1450]: info: ------------------------------------------- Aug 18 11:08:46 biblio volumio[1450]: info: ----- Volumio2 ---- Aug 18 11:08:46 biblio volumio[1450]: info: ------------------------------------------- Aug 18 11:08:46 biblio volumio[1450]: info: ----- System startup ---- Aug 18 11:08:46 biblio volumio[1450]: info: ------------------------------------------- Aug 18 11:08:47 biblio volumio[1450]: info: MYVOLUMIO Environment detected Aug 18 11:08:47 biblio volumio[1450]: info: Plugin folders cleanup Aug 18 11:08:47 biblio volumio[1450]: info: Scanning into folder /volumio/app/plugins/ Aug 18 11:08:47 biblio volumio[1450]: info: Scanning category audio_interface Aug 18 11:08:47 biblio volumio[1450]: info: Scanning category miscellanea Aug 18 11:08:47 biblio volumio[1450]: info: Scanning category music_service Aug 18 11:08:47 biblio volumio[1450]: info: Scanning category plugins.json Aug 18 11:08:47 biblio volumio[1450]: info: Scanning category system_controller Aug 18 11:08:47 biblio volumio[1450]: info: Scanning category user_interface Aug 18 11:08:47 biblio volumio[1450]: info: Scanning into folder /data/plugins/ Aug 18 11:08:47 biblio volumio[1450]: info: Scanning category miscellanea Aug 18 11:08:47 biblio volumio[1450]: info: Plugin folders cleanup completed Aug 18 11:08:47 biblio volumio[1450]: info: ------------------------------------------- Aug 18 11:08:47 biblio volumio[1450]: info: ----- Core plugins startup ---- Aug 18 11:08:47 biblio volumio[1450]: info: ------------------------------------------- Aug 18 11:08:47 biblio volumio[1450]: info: Loading plugins from folder /volumio/app/plugins/ Aug 18 11:08:47 biblio volumio[1450]: info: Adding plugin upnp to MyMusic Plugins Aug 18 11:08:47 biblio volumio[1450]: info: Adding plugin airplay_emulation to MyMusic Plugins Aug 18 11:08:47 biblio volumio[1450]: info: Adding plugin upnp_browser to MyMusic Plugins Aug 18 11:08:47 biblio volumio[1450]: info: Loading plugins from folder /data/plugins/ Aug 18 11:08:47 biblio volumio[1450]: info: Loading plugin "system"... Aug 18 11:08:47 biblio volumio[1450]: info: Loading plugin "appearance"... Aug 18 11:08:50 biblio volumio[1450]: info: Loading plugin "network"... Aug 18 11:08:50 biblio volumio[1450]: info: Refreshing Cached IP Addresses Aug 18 11:08:50 biblio sudo[1476]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 18 11:08:50 biblio volumio[1450]: info: Loading plugin "services"... Aug 18 11:08:50 biblio volumio[1450]: info: Loading plugin "alsa_controller"... Aug 18 11:08:50 biblio sudo[1476]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 11:08:50 biblio sudo[1479]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 18 11:08:50 biblio sudo[1476]: pam_unix(sudo:session): session closed for user root Aug 18 11:08:50 biblio sudo[1479]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 11:08:50 biblio sudo[1479]: pam_unix(sudo:session): session closed for user root Aug 18 11:08:50 biblio volumio[1450]: info: Loading plugin "wizard"... Aug 18 11:08:50 biblio volumio[1450]: info: Loading plugin "volumio_command_line_client"... Aug 18 11:08:50 biblio volumio[1450]: info: Plugin upnp is not enabled Aug 18 11:08:50 biblio volumio[1450]: info: Loading plugin "my_music"... Aug 18 11:08:50 biblio volumio[1450]: info: Loading plugin "mpd"... Aug 18 11:08:51 biblio volumio[1450]: info: Plugin upnp_browser is not enabled Aug 18 11:08:51 biblio volumio[1450]: info: Loading plugin "networkfs"... Aug 18 11:08:51 biblio volumio[1450]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 18 11:08:51 biblio volumio[1450]: info: Loading plugin "alarm-clock"... Aug 18 11:08:51 biblio volumio[1450]: info: Plugin airplay_emulation is not enabled Aug 18 11:08:51 biblio volumio[1450]: info: Loading plugin "last_100"... Aug 18 11:08:51 biblio volumio[1450]: info: Loading plugin "webradio"... Aug 18 11:08:51 biblio volumio[1450]: info: Loading plugin "i2s_dacs"... Aug 18 11:08:51 biblio volumio[1450]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 18 11:08:51 biblio volumio[1450]: info: Loading plugin "volumiodiscovery"... Aug 18 11:08:52 biblio volumio[1450]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Aug 18 11:08:52 biblio node[1450]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Aug 18 11:08:52 biblio node[1450]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 18 11:08:52 biblio node[1450]: *** WARNING *** For more information see Aug 18 11:08:52 biblio node[1450]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Aug 18 11:08:52 biblio node[1450]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 18 11:08:52 biblio node[1450]: *** WARNING *** For more information see Aug 18 11:08:52 biblio volumio[1450]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 18 11:08:52 biblio volumio[1450]: *** WARNING *** For more information see Aug 18 11:08:52 biblio volumio[1450]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Aug 18 11:08:52 biblio volumio[1450]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 18 11:08:52 biblio volumio[1450]: *** WARNING *** For more information see Aug 18 11:08:52 biblio volumio[1450]: info: Applying required configuration parameters for plugin volumiodiscovery Aug 18 11:08:52 biblio volumio[1450]: Discovery: StartAdv! undefined Aug 18 11:08:52 biblio volumio[1450]: Discovery: Started advertising... biblio - undefined Aug 18 11:08:52 biblio volumio[1450]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 18 11:08:52 biblio volumio[1450]: info: Loading plugin "auto_play"... Aug 18 11:08:52 biblio volumio[1450]: info: ControllerAutoPlay - connecting mpd on host: localhost; port: 6600 Aug 18 11:08:52 biblio volumio[1450]: info: Loading plugin "outputs"... Aug 18 11:08:52 biblio volumio[1450]: info: Loading plugin "albumart"... Aug 18 11:08:52 biblio volumio[1450]: info: Plugin example_plugin is not enabled Aug 18 11:08:52 biblio volumio[1450]: info: Loading plugin "inputs"... Aug 18 11:08:52 biblio volumio[1450]: info: Loading plugin "updater_comm"... Aug 18 11:08:52 biblio volumio[1450]: info: Plugin mpdemulation is not enabled Aug 18 11:08:52 biblio volumio[1450]: info: Loading plugin "rest_api"... Aug 18 11:08:52 biblio volumio[1450]: info: Loading plugin "websocket"... Aug 18 11:08:52 biblio volumio[1450]: info: ___________ START PLUGINS ___________ Aug 18 11:08:52 biblio volumio[1450]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 18 11:08:52 biblio volumio[1450]: info: [1723979332440] CoreMusicLibrary::Adding element Last_100 Aug 18 11:08:52 biblio volumio[1450]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 18 11:08:52 biblio volumio[1450]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 18 11:08:52 biblio volumio[1450]: info: [1723979332452] CoreMusicLibrary::Adding element Webradio Aug 18 11:08:52 biblio volumio[1450]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 18 11:08:52 biblio volumio[1450]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 18 11:08:52 biblio volumio[1450]: Forking 3 albumart workers Aug 18 11:08:52 biblio volumio[1450]: info: ------------------------------------------- Aug 18 11:08:52 biblio volumio[1450]: info: ----- MyVolumio plugins startup ---- Aug 18 11:08:52 biblio volumio[1450]: info: ------------------------------------------- Aug 18 11:08:52 biblio volumio[1450]: info: [MyVolumio PluginManager] Fetching plans data.... Aug 18 11:08:52 biblio volumio[1450]: info: Loading i18n strings for locale en Aug 18 11:08:52 biblio volumio[1450]: Updating browse sources language Aug 18 11:08:52 biblio volumio[1450]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 18 11:08:52 biblio volumio[1450]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 18 11:08:52 biblio volumio[1450]: info: CoreCommandRouter::initPlayerControls Aug 18 11:08:52 biblio volumio[1450]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 11:08:52 biblio volumio[1450]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Aug 18 11:08:52 biblio volumio[1450]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 11:08:52 biblio volumio[1450]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 11:08:52 biblio volumio[1450]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 11:08:52 biblio volumio[1450]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 11:08:52 biblio volumio[1450]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 11:08:52 biblio volumio[1450]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 18 11:08:52 biblio volumio[1450]: info: BOOT COMPLETED Aug 18 11:08:52 biblio volumio[1450]: [Metrics] CommandRouter: 6s 286.94ms Aug 18 11:08:52 biblio volumio[1450]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 18 11:08:52 biblio volumio-remote-updater[694]: [2024-08-18 11:08:52] [connect] Successful connection Aug 18 11:08:53 biblio volumio[1450]: Starting albumart workers Aug 18 11:08:53 biblio volumio[1450]: Starting albumart workers Aug 18 11:08:53 biblio volumio[1450]: Starting albumart workers Aug 18 11:08:57 biblio volumio[1450]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Aug 18 11:08:57 biblio volumio[1450]: info: CoreCommandRouter::Close All Modals sent Aug 18 11:08:57 biblio volumio[1450]: info: CoreCommandRouter::Close All Modals sent Aug 18 11:08:57 biblio volumio[1450]: Express server listening on port 3000 Aug 18 11:08:57 biblio volumio[1450]: [Metrics] WebUI: 12s 372.16ms Aug 18 11:08:57 biblio volumio[1450]: Volumio Calling Home Aug 18 11:08:58 biblio volumio[1450]: info: CoreStateMachine::resetVolumioState Aug 18 11:08:58 biblio volumio[1450]: info: CoreStateMachine::getcurrentVolume Aug 18 11:08:58 biblio volumio[1450]: info: CoreCommandRouter::volumioRetrievevolume Aug 18 11:08:58 biblio volumio[1450]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 18 11:08:58 biblio volumio[1450]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 11:08:58 biblio volumio[1450]: info: I2S DAC Found on wrong device number, changing it to device 2 Aug 18 11:08:58 biblio volumio[1450]: info: Output device has changed, restarting MPD Aug 18 11:08:58 biblio sudo[1566]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 18 11:08:58 biblio sudo[1568]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 18 11:08:58 biblio sudo[1566]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 11:08:58 biblio sudo[1566]: pam_unix(sudo:session): session closed for user root Aug 18 11:08:58 biblio sudo[1568]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 11:08:58 biblio systemd[1]: Stopping Music Player Daemon... Aug 18 11:08:58 biblio volumio[1450]: info: Setting Device type: Raspberry PI Aug 18 11:08:58 biblio volumio[1450]: info: MPD running with PID778 Aug 18 11:08:58 biblio volumio[1450]: ,establishing connection Aug 18 11:08:58 biblio systemd[1]: Starting Music Player Daemon... Aug 18 11:08:58 biblio volumio[1450]: info: MPD Permissions set Aug 18 11:08:58 biblio volumio[1450]: info: Volumio called home Aug 18 11:08:58 biblio volumio[1450]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 18 11:08:58 biblio volumio[1450]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 18 11:08:58 biblio volumio[1450]: info: Discovery: Getting this device information Aug 18 11:08:58 biblio volumio[1450]: info: CoreCommandRouter::volumioGetState Aug 18 11:08:58 biblio volumio[1450]: info: CorePlayQueue::getTrack 0 Aug 18 11:08:58 biblio volumio[1450]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Aug 18 11:08:58 biblio volumio[1450]: info: CoreCommandRouter::executeOnPlugin: system , getConf Aug 18 11:08:58 biblio volumio[1450]: info: CoreCommandRouter::executeOnPlugin: system , getConf Aug 18 11:08:58 biblio volumio[1450]: info: Aug 18 11:08:58 biblio volumio[1450]: ---------------------------- Client requests Volume 80 Aug 18 11:08:58 biblio volumio[1450]: info: VolumeController::SetAlsaVolume80 Aug 18 11:08:58 biblio volumio[1450]: info: CoreStateMachine::pushState Aug 18 11:08:58 biblio volumio[1450]: info: CorePlayQueue::getTrack 0 Aug 18 11:08:58 biblio volumio[1450]: info: CoreCommandRouter::volumioPushState Aug 18 11:08:58 biblio volumio[1450]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 18 11:08:59 biblio volumio[1450]: info: VolumeController:: Volume=40 Mute =false Aug 18 11:08:59 biblio volumio[1450]: info: CoreStateMachine::pushState Aug 18 11:08:59 biblio volumio[1450]: info: CorePlayQueue::getTrack 0 Aug 18 11:08:59 biblio volumio[1450]: info: CoreCommandRouter::volumioPushState Aug 18 11:08:59 biblio volumio[1450]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 18 11:08:59 biblio volumio[1450]: info: CoreStateMachine::updateTrackBlock Aug 18 11:08:59 biblio volumio[1450]: info: CorePlayQueue::getTrackBlock Aug 18 11:08:59 biblio volumio[1450]: info: CoreCommandRouter::volumioRetrievevolume Aug 18 11:08:59 biblio volumio[1450]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Aug 18 11:08:59 biblio volumio[1450]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 18 11:08:59 biblio volumio[1450]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Aug 18 11:08:59 biblio volumio[1450]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 18 11:08:59 biblio volumio[1450]: { Error: write EPIPE Aug 18 11:08:59 biblio volumio[1450]: at _errnoException (util.js:1022:11) Aug 18 11:08:59 biblio volumio[1450]: at WriteWrap.afterWrite [as oncomplete] (net.js:880:14) code: 'EPIPE', errno: 'EPIPE', syscall: 'write' } Aug 18 11:08:59 biblio volumio[1450]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 18 11:08:59 biblio systemd[1]: Started Music Player Daemon. Aug 18 11:08:59 biblio sudo[1568]: pam_unix(sudo:session): session closed for user root Aug 18 11:08:59 biblio sudo[1600]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-08-18 11:07 Aug 18 11:08:59 biblio sudo[1600]: 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"