-- Logs begin at Sun 2024-08-18 10:17:01 UTC, end at Sun 2024-08-18 10:41:24 UTC. -- Aug 18 10:40:54 biblio systemd[1]: Time has been changed Aug 18 10:40:54 biblio wpa_supplicant[1318]: wlan0: Trying to associate with SSID 'Skogtun' Aug 18 10:40:54 biblio wireless.js[1019]: trying... Aug 18 10:40:55 biblio sudo[1344]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 18 10:40:55 biblio sudo[1344]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 10:40:55 biblio sudo[1344]: pam_unix(sudo:session): session closed for user root Aug 18 10:40:55 biblio systemd[1]: Started Music Player Daemon. Aug 18 10:40:55 biblio udisks-glue[713]: Updating DB (#1) ... Aug 18 10:40:55 biblio udisks-glue[713]: volume: 40% repeat: off random: off single: off consume: off Aug 18 10:40:55 biblio smbd[1239]: Starting SMB/CIFS daemon: smbd[2024/08/18 10:40:55, 0] ../lib/util/debug.c:603(reopen_logs_internal) Aug 18 10:40:55 biblio smbd[1239]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Aug 18 10:40:55 biblio smbd[1239]: [2024/08/18 10:40:55, 0] ../lib/util/util.c:220(directory_create_or_exist) Aug 18 10:40:55 biblio smbd[1239]: mkdir failed on directory /var/log/samba/cores: No such file or directory Aug 18 10:40:55 biblio smbd[1239]: [2024/08/18 10:40:55, 0] ../source3/lib/dumpcore.c:59(get_default_corepath) Aug 18 10:40:55 biblio smbd[1239]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Aug 18 10:40:55 biblio smbd[1239]: [2024/08/18 10:40:55, 0] ../source3/lib/dumpcore.c:250(dump_core_setup) Aug 18 10:40:55 biblio smbd[1239]: Unable to setup corepath for smbd: No such file or directory Aug 18 10:40:55 biblio smbd[1239]: [2024/08/18 10:40:55, 0] ../lib/util/debug.c:603(reopen_logs_internal) Aug 18 10:40:55 biblio smbd[1239]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Aug 18 10:40:55 biblio smbd[1239]: [2024/08/18 10:40:55, 0] ../source3/smbd/server.c:1241(main) Aug 18 10:40:55 biblio smbd[1239]: smbd version 4.2.14-Debian started. Aug 18 10:40:55 biblio smbd[1239]: Copyright Andrew Tridgell and the Samba Team 1992-2014 Aug 18 10:40:55 biblio smbd[1346]: [2024/08/18 10:40:55.402166, 0] ../lib/util/debug.c:603(reopen_logs_internal) Aug 18 10:40:55 biblio smbd[1346]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Aug 18 10:40:55 biblio smbd[1346]: [2024/08/18 10:40:55.404634, 0] ../lib/util/debug.c:603(reopen_logs_internal) Aug 18 10:40:55 biblio smbd[1346]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Aug 18 10:40:55 biblio smbd[1346]: [2024/08/18 10:40:55.405015, 0] ../lib/util/debug.c:603(reopen_logs_internal) Aug 18 10:40:55 biblio smbd[1346]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Aug 18 10:40:55 biblio smbd[1239]: [2024/08/18 10:40:55.402166, 0] ../lib/util/debug.c:603(reopen_logs_internal) Aug 18 10:40:55 biblio smbd[1239]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Aug 18 10:40:55 biblio smbd[1239]: [2024/08/18 10:40:55.404634, 0] ../lib/util/debug.c:603(reopen_logs_internal) Aug 18 10:40:55 biblio smbd[1239]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Aug 18 10:40:55 biblio smbd[1239]: [2024/08/18 10:40:55.405015, 0] ../lib/util/debug.c:603(reopen_logs_internal) Aug 18 10:40:55 biblio smbd[1239]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Aug 18 10:40:55 biblio smbd[1239]: . Aug 18 10:40:55 biblio systemd[1]: Started LSB: start Samba SMB/CIFS daemon (smbd). Aug 18 10:40:55 biblio winbindd[1360]: [2024/08/18 10:40:55.498191, 0] ../lib/util/debug.c:603(reopen_logs_internal) Aug 18 10:40:55 biblio winbindd[1360]: Unable to open new log file '/var/log/samba/log.winbindd-idmap': No such file or directory Aug 18 10:40:55 biblio winbindd[1361]: [2024/08/18 10:40:55.564930, 0] ../lib/util/debug.c:603(reopen_logs_internal) Aug 18 10:40:55 biblio winbindd[1361]: Unable to open new log file '/var/log/samba/log.wb-BUILTIN': No such file or directory Aug 18 10:40:55 biblio wpa_supplicant[1318]: wlan0: Associated with 34:21:09:45:eb:99 Aug 18 10:40:55 biblio smbd[1356]: [2024/08/18 10:40:55.637184, 0] ../lib/util/become_daemon.c:124(daemon_ready) Aug 18 10:40:55 biblio smbd[1356]: STATUS=daemon 'smbd' finished starting up and ready to serve connections Aug 18 10:40:55 biblio smbd[1362]: [2024/08/18 10:40:55.647390, 0] ../lib/util/debug.c:603(reopen_logs_internal) Aug 18 10:40:55 biblio smbd[1362]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Aug 18 10:40:55 biblio nmbd[1237]: [2024/08/18 10:40:55.700789, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Aug 18 10:40:55 biblio nmbd[1237]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.39.127 for name WORKGROUP<1d>. Aug 18 10:40:55 biblio nmbd[1237]: This response was from IP 192.168.39.101, reporting an IP address of 192.168.39.101. Aug 18 10:40:56 biblio wireless.js[1019]: trying... Aug 18 10:40:56 biblio sudo[1366]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 18 10:40:56 biblio sudo[1366]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 10:40:56 biblio sudo[1366]: pam_unix(sudo:session): session closed for user root Aug 18 10:40:56 biblio wpa_supplicant[1318]: wlan0: WPA: Key negotiation completed with 34:21:09:45:eb:99 [PTK=CCMP GTK=TKIP] Aug 18 10:40:56 biblio wpa_supplicant[1318]: wlan0: CTRL-EVENT-CONNECTED - Connection to 34:21:09:45:eb:99 completed [id=0 id_str=] Aug 18 10:40:56 biblio dhcpcd[1339]: wlan0: carrier acquired Aug 18 10:40:56 biblio dhcpcd[1339]: wlan0: soliciting an IPv6 router Aug 18 10:40:56 biblio dhcpcd[1339]: wlan0: rebinding lease of 192.168.39.119 Aug 18 10:40:57 biblio wireless.js[1019]: trying... Aug 18 10:40:57 biblio sudo[1393]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 18 10:40:57 biblio sudo[1393]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 10:40:57 biblio sudo[1393]: pam_unix(sudo:session): session closed for user root Aug 18 10:40:58 biblio wireless.js[1019]: trying... Aug 18 10:40:58 biblio sudo[1402]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 18 10:40:58 biblio sudo[1402]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 10:40:58 biblio sudo[1402]: pam_unix(sudo:session): session closed for user root Aug 18 10:40:59 biblio wireless.js[1019]: trying... Aug 18 10:40:59 biblio sudo[1411]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 18 10:40:59 biblio sudo[1411]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 10:40:59 biblio sudo[1411]: pam_unix(sudo:session): session closed for user root Aug 18 10:41:00 biblio wireless.js[1019]: trying... Aug 18 10:41:00 biblio sudo[1420]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 18 10:41:00 biblio sudo[1420]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 10:41:00 biblio sudo[1420]: pam_unix(sudo:session): session closed for user root Aug 18 10:41:01 biblio volumio-remote-updater[715]: [2024-08-18 10:41:01] [info] asio async_connect error: system:111 (Connection refused) Aug 18 10:41:01 biblio volumio-remote-updater[715]: [2024-08-18 10:41:01] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Aug 18 10:41:01 biblio volumio-remote-updater[715]: [2024-08-18 10:41:01] [error] handle_connect error: Underlying Transport Error Aug 18 10:41:01 biblio wireless.js[1019]: trying... Aug 18 10:41:01 biblio sudo[1429]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 18 10:41:01 biblio sudo[1429]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 10:41:01 biblio sudo[1429]: pam_unix(sudo:session): session closed for user root Aug 18 10:41:02 biblio wireless.js[1019]: trying... Aug 18 10:41:02 biblio sudo[1438]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 18 10:41:02 biblio sudo[1438]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 10:41:02 biblio sudo[1438]: pam_unix(sudo:session): session closed for user root Aug 18 10:41:02 biblio dhcpcd[1339]: wlan0: leased 192.168.39.119 for 86400 seconds Aug 18 10:41:02 biblio avahi-daemon[787]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.39.119. Aug 18 10:41:02 biblio avahi-daemon[787]: New relevant interface wlan0.IPv4 for mDNS. Aug 18 10:41:02 biblio dhcpcd[1339]: eth0: adding route to 192.168.39.0/24 Aug 18 10:41:02 biblio avahi-daemon[787]: Registering new address record for 192.168.39.119 on wlan0.IPv4. Aug 18 10:41:02 biblio dhcpcd[1339]: eth0: adding default route via 192.168.39.1 Aug 18 10:41:02 biblio dhcpcd[1339]: wlan0: adding host route to 192.168.39.119 via 127.0.0.1 Aug 18 10:41:02 biblio dhcpcd[1339]: wlan0: adding route to 192.168.39.0/24 Aug 18 10:41:02 biblio dhcpcd[1339]: wlan0: adding default route via 192.168.39.1 Aug 18 10:41:02 biblio dhcpcd[1339]: eth0: removing route to 192.168.39.0/24 Aug 18 10:41:02 biblio dhcpcd[1339]: eth0: removing default route via 192.168.39.1 Aug 18 10:41:02 biblio kernel: Voltage normalised (0x00000000) Aug 18 10:41:03 biblio wireless.js[1019]: trying... Aug 18 10:41:03 biblio sudo[1470]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Aug 18 10:41:03 biblio sudo[1470]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 10:41:03 biblio sudo[1470]: pam_unix(sudo:session): session closed for user root Aug 18 10:41:03 biblio wireless.js[1019]: Connected to: ----Skogtun Aug 18 10:41:03 biblio wireless.js[1019]: ---- Aug 18 10:41:03 biblio sudo[1479]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 18 10:41:03 biblio sudo[1479]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 10:41:03 biblio sudo[1479]: pam_unix(sudo:session): session closed for user root Aug 18 10:41:03 biblio wireless.js[1019]: ... joined AP, wlan0 IPv4 is 192.168.39.119, ipV6 is undefined Aug 18 10:41:03 biblio wireless.js[1019]: It's done! AP Aug 18 10:41:03 biblio systemd[1]: Started Wireless Services. Aug 18 10:41:03 biblio systemd[1]: Starting Volumio Backend Module... Aug 18 10:41:03 biblio systemd[1]: Started Volumio Backend Module. Aug 18 10:41:03 biblio systemd[1]: Starting Volumio Streaming Daemon... Aug 18 10:41:03 biblio systemd[1]: Started Volumio Streaming Daemon. Aug 18 10:41:03 biblio systemd[1]: Starting Multi-User System. Aug 18 10:41:03 biblio systemd[1]: Reached target Multi-User System. Aug 18 10:41:03 biblio systemd[1]: Starting Graphical Interface. Aug 18 10:41:03 biblio systemd[1]: Reached target Graphical Interface. Aug 18 10:41:03 biblio systemd[1]: Starting Update UTMP about System Runlevel Changes... Aug 18 10:41:03 biblio systemd[1]: Started Update UTMP about System Runlevel Changes. Aug 18 10:41:03 biblio systemd[1]: Startup finished in 9.576s (kernel) + 33.612s (userspace) = 43.189s. Aug 18 10:41:03 biblio ntpd[925]: Listen normally on 4 wlan0 192.168.39.119 UDP 123 Aug 18 10:41:03 biblio ntpd[925]: peers refreshed Aug 18 10:41:03 biblio volumio-streaming-daemon[1489]: ############################ Aug 18 10:41:03 biblio volumio-streaming-daemon[1489]: # Volumio Streaming Daemon # Aug 18 10:41:03 biblio volumio-streaming-daemon[1489]: # Running on port 7777 # Aug 18 10:41:03 biblio volumio-streaming-daemon[1489]: ############################ Aug 18 10:41:03 biblio volumio-streaming-daemon[1489]: Environment: production Aug 18 10:41:07 biblio volumio[1488]: info: ------------------------------------------- Aug 18 10:41:07 biblio volumio[1488]: info: ----- Volumio2 ---- Aug 18 10:41:07 biblio volumio[1488]: info: ------------------------------------------- Aug 18 10:41:07 biblio volumio[1488]: info: ----- System startup ---- Aug 18 10:41:07 biblio volumio[1488]: info: ------------------------------------------- Aug 18 10:41:08 biblio volumio[1488]: info: MYVOLUMIO Environment detected Aug 18 10:41:08 biblio volumio[1488]: info: Plugin folders cleanup Aug 18 10:41:08 biblio volumio[1488]: info: Scanning into folder /volumio/app/plugins/ Aug 18 10:41:08 biblio volumio[1488]: info: Scanning category audio_interface Aug 18 10:41:08 biblio volumio[1488]: info: Scanning category miscellanea Aug 18 10:41:08 biblio volumio[1488]: info: Scanning category music_service Aug 18 10:41:08 biblio volumio[1488]: info: Scanning category plugins.json Aug 18 10:41:08 biblio volumio[1488]: info: Scanning category system_controller Aug 18 10:41:08 biblio volumio[1488]: info: Scanning category user_interface Aug 18 10:41:08 biblio volumio[1488]: info: Scanning into folder /data/plugins/ Aug 18 10:41:08 biblio volumio[1488]: info: Scanning category miscellanea Aug 18 10:41:08 biblio volumio[1488]: info: Plugin folders cleanup completed Aug 18 10:41:08 biblio volumio[1488]: info: ------------------------------------------- Aug 18 10:41:08 biblio volumio[1488]: info: ----- Core plugins startup ---- Aug 18 10:41:08 biblio volumio[1488]: info: ------------------------------------------- Aug 18 10:41:08 biblio volumio[1488]: info: Loading plugins from folder /volumio/app/plugins/ Aug 18 10:41:08 biblio volumio[1488]: info: Adding plugin upnp to MyMusic Plugins Aug 18 10:41:08 biblio volumio[1488]: info: Adding plugin airplay_emulation to MyMusic Plugins Aug 18 10:41:08 biblio volumio[1488]: info: Adding plugin upnp_browser to MyMusic Plugins Aug 18 10:41:08 biblio volumio[1488]: info: Loading plugins from folder /data/plugins/ Aug 18 10:41:08 biblio volumio[1488]: info: Loading plugin "system"... Aug 18 10:41:09 biblio volumio[1488]: info: Loading plugin "appearance"... Aug 18 10:41:11 biblio volumio-remote-updater[715]: [2024-08-18 10:41:11] [connect] Successful connection Aug 18 10:41:13 biblio volumio[1488]: info: Loading plugin "network"... Aug 18 10:41:13 biblio volumio[1488]: info: Refreshing Cached IP Addresses Aug 18 10:41:13 biblio sudo[1514]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 18 10:41:13 biblio volumio[1488]: info: Loading plugin "services"... Aug 18 10:41:13 biblio volumio[1488]: info: Loading plugin "alsa_controller"... Aug 18 10:41:13 biblio sudo[1514]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 10:41:13 biblio sudo[1514]: pam_unix(sudo:session): session closed for user root Aug 18 10:41:13 biblio sudo[1517]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 18 10:41:13 biblio sudo[1517]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 10:41:13 biblio sudo[1517]: pam_unix(sudo:session): session closed for user root Aug 18 10:41:13 biblio volumio[1488]: info: Loading plugin "wizard"... Aug 18 10:41:13 biblio volumio[1488]: info: Loading plugin "volumio_command_line_client"... Aug 18 10:41:13 biblio volumio[1488]: info: Plugin upnp is not enabled Aug 18 10:41:13 biblio volumio[1488]: info: Loading plugin "my_music"... Aug 18 10:41:13 biblio volumio[1488]: info: Loading plugin "mpd"... Aug 18 10:41:14 biblio volumio[1488]: info: Plugin upnp_browser is not enabled Aug 18 10:41:14 biblio volumio[1488]: info: Loading plugin "networkfs"... Aug 18 10:41:14 biblio volumio[1488]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 18 10:41:14 biblio volumio[1488]: info: Loading plugin "alarm-clock"... Aug 18 10:41:14 biblio volumio[1488]: info: Plugin airplay_emulation is not enabled Aug 18 10:41:14 biblio volumio[1488]: info: Loading plugin "last_100"... Aug 18 10:41:14 biblio volumio[1488]: info: Loading plugin "webradio"... Aug 18 10:41:14 biblio volumio[1488]: info: Loading plugin "i2s_dacs"... Aug 18 10:41:14 biblio volumio[1488]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 18 10:41:14 biblio volumio[1488]: info: Loading plugin "volumiodiscovery"... Aug 18 10:41:14 biblio volumio[1488]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Aug 18 10:41:14 biblio node[1488]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Aug 18 10:41:14 biblio node[1488]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 18 10:41:14 biblio node[1488]: *** WARNING *** For more information see Aug 18 10:41:14 biblio node[1488]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Aug 18 10:41:14 biblio node[1488]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 18 10:41:14 biblio node[1488]: *** WARNING *** For more information see Aug 18 10:41:14 biblio volumio[1488]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 18 10:41:14 biblio volumio[1488]: *** WARNING *** For more information see Aug 18 10:41:14 biblio volumio[1488]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Aug 18 10:41:14 biblio volumio[1488]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 18 10:41:14 biblio volumio[1488]: *** WARNING *** For more information see Aug 18 10:41:14 biblio volumio[1488]: info: Applying required configuration parameters for plugin volumiodiscovery Aug 18 10:41:14 biblio volumio[1488]: Discovery: StartAdv! undefined Aug 18 10:41:14 biblio volumio[1488]: Discovery: Started advertising... biblio - undefined Aug 18 10:41:14 biblio volumio[1488]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 18 10:41:14 biblio volumio[1488]: info: Loading plugin "auto_play"... Aug 18 10:41:14 biblio volumio[1488]: info: ControllerAutoPlay - connecting mpd on host: localhost; port: 6600 Aug 18 10:41:14 biblio volumio[1488]: info: Loading plugin "outputs"... Aug 18 10:41:14 biblio volumio[1488]: info: Loading plugin "albumart"... Aug 18 10:41:14 biblio volumio[1488]: info: Plugin example_plugin is not enabled Aug 18 10:41:14 biblio volumio[1488]: info: Loading plugin "inputs"... Aug 18 10:41:14 biblio volumio[1488]: info: Loading plugin "updater_comm"... Aug 18 10:41:15 biblio volumio[1488]: info: Plugin mpdemulation is not enabled Aug 18 10:41:15 biblio volumio[1488]: info: Loading plugin "rest_api"... Aug 18 10:41:15 biblio volumio[1488]: info: Loading plugin "websocket"... Aug 18 10:41:15 biblio volumio[1488]: info: ___________ START PLUGINS ___________ Aug 18 10:41:15 biblio volumio[1488]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 18 10:41:15 biblio volumio[1488]: info: [1723977675227] CoreMusicLibrary::Adding element Last_100 Aug 18 10:41:15 biblio volumio[1488]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 18 10:41:15 biblio volumio[1488]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 18 10:41:15 biblio volumio[1488]: info: [1723977675237] CoreMusicLibrary::Adding element Webradio Aug 18 10:41:15 biblio volumio[1488]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 18 10:41:15 biblio volumio[1488]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 18 10:41:15 biblio volumio[1488]: info: ------------------------------------------- Aug 18 10:41:15 biblio volumio[1488]: info: ----- MyVolumio plugins startup ---- Aug 18 10:41:15 biblio volumio[1488]: info: ------------------------------------------- Aug 18 10:41:15 biblio volumio[1488]: info: [MyVolumio PluginManager] Fetching plans data.... Aug 18 10:41:15 biblio volumio[1488]: info: Loading i18n strings for locale en Aug 18 10:41:15 biblio volumio[1488]: Updating browse sources language Aug 18 10:41:15 biblio volumio[1488]: Forking 3 albumart workers Aug 18 10:41:15 biblio volumio[1488]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 18 10:41:15 biblio volumio[1488]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 18 10:41:15 biblio volumio[1488]: info: CoreCommandRouter::initPlayerControls Aug 18 10:41:15 biblio volumio[1488]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 10:41:15 biblio volumio[1488]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Aug 18 10:41:15 biblio volumio[1488]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 10:41:15 biblio volumio[1488]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 10:41:15 biblio volumio[1488]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 10:41:15 biblio volumio[1488]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 10:41:15 biblio volumio[1488]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 10:41:15 biblio volumio[1488]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 18 10:41:15 biblio volumio[1488]: info: BOOT COMPLETED Aug 18 10:41:15 biblio volumio[1488]: [Metrics] CommandRouter: 7s 754.69ms Aug 18 10:41:15 biblio volumio[1488]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 18 10:41:16 biblio volumio[1488]: Starting albumart workers Aug 18 10:41:16 biblio volumio[1488]: Starting albumart workers Aug 18 10:41:16 biblio volumio[1488]: Starting albumart workers Aug 18 10:41:20 biblio volumio[1488]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Aug 18 10:41:20 biblio volumio[1488]: info: CoreCommandRouter::Close All Modals sent Aug 18 10:41:20 biblio volumio[1488]: info: CoreCommandRouter::Close All Modals sent Aug 18 10:41:20 biblio volumio[1488]: Express server listening on port 3000 Aug 18 10:41:20 biblio volumio[1488]: [Metrics] WebUI: 13s 913.75ms Aug 18 10:41:20 biblio volumio[1488]: Volumio Calling Home Aug 18 10:41:20 biblio volumio[1488]: info: CoreStateMachine::resetVolumioState Aug 18 10:41:20 biblio volumio[1488]: info: CoreStateMachine::getcurrentVolume Aug 18 10:41:20 biblio volumio[1488]: info: CoreCommandRouter::volumioRetrievevolume Aug 18 10:41:21 biblio volumio[1488]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 18 10:41:21 biblio volumio[1488]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 10:41:21 biblio volumio[1488]: info: I2S DAC Found on wrong device number, changing it to device 2 Aug 18 10:41:21 biblio volumio[1488]: info: Output device has changed, restarting MPD Aug 18 10:41:21 biblio sudo[1601]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 18 10:41:21 biblio sudo[1603]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 18 10:41:21 biblio sudo[1601]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 10:41:21 biblio sudo[1603]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 10:41:21 biblio sudo[1601]: pam_unix(sudo:session): session closed for user root Aug 18 10:41:21 biblio systemd[1]: Stopping Music Player Daemon... Aug 18 10:41:21 biblio volumio[1488]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control 'Digital',0 Aug 18 10:41:21 biblio volumio[1488]: info: Setting Device type: Raspberry PI Aug 18 10:41:21 biblio volumio[1488]: info: MPD running with PID796 Aug 18 10:41:21 biblio volumio[1488]: ,establishing connection Aug 18 10:41:21 biblio systemd[1]: Starting Music Player Daemon... Aug 18 10:41:21 biblio volumio[1488]: info: MPD Permissions set Aug 18 10:41:21 biblio volumio[1488]: info: Volumio called home Aug 18 10:41:21 biblio volumio[1488]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Aug 18 10:41:21 biblio volumio[1488]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 18 10:41:21 biblio volumio[1488]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Aug 18 10:41:21 biblio volumio[1488]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 18 10:41:21 biblio volumio[1488]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 18 10:41:21 biblio volumio[1488]: info: Discovery: Getting this device information Aug 18 10:41:21 biblio volumio[1488]: info: CoreCommandRouter::volumioGetState Aug 18 10:41:22 biblio volumio[1488]: info: CorePlayQueue::getTrack 0 Aug 18 10:41:22 biblio volumio[1488]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Aug 18 10:41:22 biblio volumio[1488]: info: CoreCommandRouter::executeOnPlugin: system , getConf Aug 18 10:41:22 biblio volumio[1488]: info: CoreCommandRouter::executeOnPlugin: system , getConf Aug 18 10:41:22 biblio volumio[1488]: info: VolumeController:: Volume=undefined Mute =false Aug 18 10:41:22 biblio volumio[1488]: info: CoreStateMachine::pushState Aug 18 10:41:22 biblio volumio[1488]: info: CorePlayQueue::getTrack 0 Aug 18 10:41:22 biblio volumio[1488]: info: CoreCommandRouter::volumioPushState Aug 18 10:41:22 biblio volumio[1488]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 18 10:41:22 biblio volumio[1488]: info: CoreStateMachine::updateTrackBlock Aug 18 10:41:22 biblio volumio[1488]: info: CorePlayQueue::getTrackBlock Aug 18 10:41:22 biblio volumio[1488]: info: CoreCommandRouter::volumioRetrievevolume Aug 18 10:41:22 biblio volumio[1488]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setDefaultMixer Aug 18 10:41:22 biblio volumio[1488]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 18 10:41:22 biblio volumio[1488]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SMixer Aug 18 10:41:22 biblio volumio[1488]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 18 10:41:22 biblio volumio[1488]: info: Found match in i2s Card Database: setting mixer Digital for card HiFiBerry DAC Plus Aug 18 10:41:22 biblio volumio[1488]: info: CoreCommandRouter::volumioUpdateVolumeSettings Aug 18 10:41:22 biblio volumio[1488]: info: Updating Volume Controller Parameters: Device: 2 Name: HiFiBerry DAC Plus Mixer: Digital Max Vol: 100 Vol Curve; logarithmic Vol Steps: 10 Aug 18 10:41:22 biblio volumio[1488]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 18 10:41:22 biblio volumio[1488]: { Error: write EPIPE Aug 18 10:41:22 biblio volumio[1488]: at _errnoException (util.js:1022:11) Aug 18 10:41:22 biblio volumio[1488]: at WriteWrap.afterWrite [as oncomplete] (net.js:880:14) code: 'EPIPE', errno: 'EPIPE', syscall: 'write' } Aug 18 10:41:22 biblio volumio[1488]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 18 10:41:23 biblio systemd[1]: Started Music Player Daemon. Aug 18 10:41:23 biblio sudo[1603]: pam_unix(sudo:session): session closed for user root Aug 18 10:41:24 biblio sudo[1643]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-08-18 10:40 Aug 18 10:41:24 biblio sudo[1643]: 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"