-- Logs begin at Sun 2025-06-15 15:15:23 UTC, end at Sun 2025-12-21 12:46:53 UTC. -- Jun 15 15:15:45 volumio dhcpcd[993]: eth0: adding route to 192.168.1.0/24 Jun 15 15:15:45 volumio dhcpcd[993]: eth0: adding default route via 192.168.1.1 Jun 15 15:15:45 volumio dhcpcd[546]: eth0: removing default route via 192.168.1.1 Dec 21 12:45:46 volumio systemd[1]: Time has been changed Dec 21 12:45:46 volumio dhcpcd[1050]: eth0: removing route to 192.168.1.0/24 Dec 21 12:45:46 volumio dhcpcd[1050]: eth0: removing default route via 192.168.1.1 Dec 21 12:45:46 volumio dhcpcd[993]: forked to background, child pid 1050 Dec 21 12:45:46 volumio sudo[989]: pam_unix(sudo:session): session closed for user root Dec 21 12:45:47 volumio ntfs-3g[1055]: Version 2014.2.15AR.2 integrated FUSE 28 Dec 21 12:45:47 volumio ntfs-3g[1055]: Mounted /dev/sda1 (Read-Write, label "Music", NTFS 3.1) Dec 21 12:45:47 volumio ntfs-3g[1055]: Cmdline options: rw,nodev,nosuid,noatime,uid=1000,gid=1000,dmask=0077,fmask=0177,dmask=0000,fmask=0000,uhelper=udisks Dec 21 12:45:47 volumio ntfs-3g[1055]: Mount options: rw,nodev,nosuid,uhelper=udisks,allow_other,nonempty,noatime,default_permissions,fsname=/dev/sda1,blkdev,blksize=4096 Dec 21 12:45:47 volumio ntfs-3g[1055]: Global ownership and permissions enforced, configuration type 7 Dec 21 12:45:47 volumio udisks-glue[699]: Successfully automounted /dev/sda1 at /media/Music Dec 21 12:45:47 volumio udisks-glue[699]: Device file /dev/sda1 mounted at /media/Music Dec 21 12:45:47 volumio wpa_supplicant[1026]: wlan0: Trying to associate with SSID 'PCCADET1' Dec 21 12:45:47 volumio wireless.js[838]: trying... Dec 21 12:45:47 volumio sudo[1059]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 21 12:45:47 volumio sudo[1059]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 21 12:45:47 volumio sudo[1059]: pam_unix(sudo:session): session closed for user root Dec 21 12:45:47 volumio smbd[967]: Starting SMB/CIFS daemon: smbd[2025/12/21 12:45:47, 0] ../lib/util/debug.c:603(reopen_logs_internal) Dec 21 12:45:47 volumio smbd[967]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Dec 21 12:45:47 volumio wpa_supplicant[1026]: wlan0: Associated with cc:50:0a:c5:8f:e3 Dec 21 12:45:47 volumio smbd[967]: [2025/12/21 12:45:47, 0] ../lib/util/util.c:220(directory_create_or_exist) Dec 21 12:45:47 volumio smbd[967]: mkdir failed on directory /var/log/samba/cores: No such file or directory Dec 21 12:45:47 volumio smbd[967]: [2025/12/21 12:45:47, 0] ../source3/lib/dumpcore.c:59(get_default_corepath) Dec 21 12:45:47 volumio smbd[967]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Dec 21 12:45:47 volumio smbd[967]: [2025/12/21 12:45:47, 0] ../source3/lib/dumpcore.c:250(dump_core_setup) Dec 21 12:45:47 volumio smbd[967]: Unable to setup corepath for smbd: No such file or directory Dec 21 12:45:47 volumio smbd[967]: [2025/12/21 12:45:47, 0] ../lib/util/debug.c:603(reopen_logs_internal) Dec 21 12:45:47 volumio smbd[967]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Dec 21 12:45:47 volumio smbd[967]: [2025/12/21 12:45:47, 0] ../source3/smbd/server.c:1241(main) Dec 21 12:45:47 volumio smbd[967]: smbd version 4.2.14-Debian started. Dec 21 12:45:47 volumio smbd[967]: Copyright Andrew Tridgell and the Samba Team 1992-2014 Dec 21 12:45:47 volumio wpa_supplicant[1026]: wlan0: WPA: Key negotiation completed with cc:50:0a:c5:8f:e3 [PTK=CCMP GTK=TKIP] Dec 21 12:45:47 volumio wpa_supplicant[1026]: wlan0: CTRL-EVENT-CONNECTED - Connection to cc:50:0a:c5:8f:e3 completed [id=0 id_str=] Dec 21 12:45:47 volumio dhcpcd[1050]: wlan0: carrier acquired Dec 21 12:45:47 volumio smbd[1068]: [2025/12/21 12:45:47.860612, 0] ../lib/util/debug.c:603(reopen_logs_internal) Dec 21 12:45:47 volumio smbd[1068]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Dec 21 12:45:47 volumio smbd[1068]: [2025/12/21 12:45:47.863913, 0] ../lib/util/debug.c:603(reopen_logs_internal) Dec 21 12:45:47 volumio smbd[1068]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Dec 21 12:45:47 volumio smbd[1068]: [2025/12/21 12:45:47.864459, 0] ../lib/util/debug.c:603(reopen_logs_internal) Dec 21 12:45:47 volumio smbd[1068]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Dec 21 12:45:47 volumio smbd[967]: [2025/12/21 12:45:47.860612, 0] ../lib/util/debug.c:603(reopen_logs_internal) Dec 21 12:45:47 volumio smbd[967]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Dec 21 12:45:47 volumio smbd[967]: [2025/12/21 12:45:47.863913, 0] ../lib/util/debug.c:603(reopen_logs_internal) Dec 21 12:45:47 volumio smbd[967]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Dec 21 12:45:47 volumio smbd[967]: [2025/12/21 12:45:47.864459, 0] ../lib/util/debug.c:603(reopen_logs_internal) Dec 21 12:45:47 volumio smbd[967]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Dec 21 12:45:47 volumio smbd[967]: . Dec 21 12:45:47 volumio systemd[1]: Started LSB: start Samba SMB/CIFS daemon (smbd). Dec 21 12:45:47 volumio winbindd[1090]: [2025/12/21 12:45:47.962899, 0] ../lib/util/debug.c:603(reopen_logs_internal) Dec 21 12:45:47 volumio winbindd[1090]: Unable to open new log file '/var/log/samba/log.winbindd-idmap': No such file or directory Dec 21 12:45:47 volumio dhcpcd[1050]: wlan0: soliciting a DHCP lease Dec 21 12:45:48 volumio winbindd[1091]: [2025/12/21 12:45:48.034615, 0] ../lib/util/debug.c:603(reopen_logs_internal) Dec 21 12:45:48 volumio winbindd[1091]: Unable to open new log file '/var/log/samba/log.wb-BUILTIN': No such file or directory Dec 21 12:45:48 volumio smbd[1077]: [2025/12/21 12:45:48.104099, 0] ../lib/util/become_daemon.c:124(daemon_ready) Dec 21 12:45:48 volumio smbd[1077]: STATUS=daemon 'smbd' finished starting up and ready to serve connections Dec 21 12:45:48 volumio smbd[1092]: [2025/12/21 12:45:48.111820, 0] ../lib/util/debug.c:603(reopen_logs_internal) Dec 21 12:45:48 volumio smbd[1092]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Dec 21 12:45:48 volumio wireless.js[838]: trying... Dec 21 12:45:48 volumio sudo[1095]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 21 12:45:48 volumio sudo[1095]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 21 12:45:48 volumio sudo[1095]: pam_unix(sudo:session): session closed for user root Dec 21 12:45:49 volumio wireless.js[838]: trying... Dec 21 12:45:49 volumio sudo[1107]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 21 12:45:49 volumio sudo[1107]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 21 12:45:49 volumio sudo[1107]: pam_unix(sudo:session): session closed for user root Dec 21 12:45:50 volumio wireless.js[838]: trying... Dec 21 12:45:50 volumio sudo[1116]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 21 12:45:50 volumio sudo[1116]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 21 12:45:50 volumio sudo[1116]: pam_unix(sudo:session): session closed for user root Dec 21 12:45:50 volumio dhcpcd[1050]: wlan0: offered 192.168.1.6 from 192.168.1.1 Dec 21 12:45:51 volumio dhcpcd[1050]: wlan0: leased 192.168.1.6 for 7200 seconds Dec 21 12:45:51 volumio avahi-daemon[757]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.6. Dec 21 12:45:51 volumio avahi-daemon[757]: New relevant interface wlan0.IPv4 for mDNS. Dec 21 12:45:51 volumio dhcpcd[1050]: eth0: adding route to 192.168.1.0/24 Dec 21 12:45:51 volumio avahi-daemon[757]: Registering new address record for 192.168.1.6 on wlan0.IPv4. Dec 21 12:45:51 volumio dhcpcd[1050]: eth0: adding default route via 192.168.1.1 Dec 21 12:45:51 volumio dhcpcd[1050]: wlan0: adding host route to 192.168.1.6 via 127.0.0.1 Dec 21 12:45:51 volumio dhcpcd[1050]: wlan0: adding route to 192.168.1.0/24 Dec 21 12:45:51 volumio dhcpcd[1050]: wlan0: adding default route via 192.168.1.1 Dec 21 12:45:51 volumio dhcpcd[1050]: eth0: removing route to 192.168.1.0/24 Dec 21 12:45:51 volumio dhcpcd[1050]: eth0: removing default route via 192.168.1.1 Dec 21 12:45:51 volumio wireless.js[838]: trying... Dec 21 12:45:51 volumio sudo[1146]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 21 12:45:51 volumio sudo[1146]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 21 12:45:51 volumio sudo[1146]: pam_unix(sudo:session): session closed for user root Dec 21 12:45:51 volumio wireless.js[838]: Connected to: ----PCCADET1 Dec 21 12:45:51 volumio wireless.js[838]: ---- Dec 21 12:45:51 volumio sudo[1155]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 21 12:45:51 volumio sudo[1155]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 21 12:45:51 volumio sudo[1155]: pam_unix(sudo:session): session closed for user root Dec 21 12:45:51 volumio wireless.js[838]: ... joined AP, wlan0 IPv4 is 192.168.1.6, ipV6 is undefined Dec 21 12:45:51 volumio wireless.js[838]: It's done! AP Dec 21 12:45:51 volumio systemd[1]: Started Wireless Services. Dec 21 12:45:51 volumio systemd[1]: Starting Volumio Backend Module... Dec 21 12:45:51 volumio systemd[1]: Started Volumio Backend Module. Dec 21 12:45:51 volumio systemd[1]: Starting Volumio Streaming Daemon... Dec 21 12:45:51 volumio systemd[1]: Started Volumio Streaming Daemon. Dec 21 12:45:51 volumio volumio-streaming-daemon[1165]: ############################ Dec 21 12:45:51 volumio volumio-streaming-daemon[1165]: # Volumio Streaming Daemon # Dec 21 12:45:51 volumio volumio-streaming-daemon[1165]: # Running on port 7777 # Dec 21 12:45:51 volumio volumio-streaming-daemon[1165]: ############################ Dec 21 12:45:52 volumio volumio-remote-updater[702]: [2025-12-21 12:45:52] [info] asio async_connect error: system:111 (Connection refused) Dec 21 12:45:52 volumio volumio-remote-updater[702]: [2025-12-21 12:45:52] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Dec 21 12:45:52 volumio volumio-remote-updater[702]: [2025-12-21 12:45:52] [error] handle_connect error: Underlying Transport Error Dec 21 12:45:52 volumio kernel: Voltage normalised (0x00000000) Dec 21 12:45:52 volumio ntpd[831]: Listen normally on 4 wlan0 192.168.1.6 UDP 123 Dec 21 12:45:52 volumio ntpd[831]: peers refreshed Dec 21 12:45:54 volumio volumio[1164]: info: ------------------------------------------- Dec 21 12:45:54 volumio volumio[1164]: info: ----- Volumio2 ---- Dec 21 12:45:54 volumio volumio[1164]: info: ------------------------------------------- Dec 21 12:45:54 volumio volumio[1164]: info: ----- System startup ---- Dec 21 12:45:54 volumio volumio[1164]: info: ------------------------------------------- Dec 21 12:45:54 volumio volumio[1164]: info: MYVOLUMIO Environment detected Dec 21 12:45:55 volumio volumio[1164]: info: Plugin folders cleanup Dec 21 12:45:55 volumio volumio[1164]: info: Scanning into folder /volumio/app/plugins/ Dec 21 12:45:55 volumio volumio[1164]: info: Scanning category audio_interface Dec 21 12:45:55 volumio volumio[1164]: info: Scanning category miscellanea Dec 21 12:45:55 volumio volumio[1164]: info: Scanning category music_service Dec 21 12:45:55 volumio volumio[1164]: info: Scanning category plugins.json Dec 21 12:45:55 volumio volumio[1164]: info: Scanning category system_controller Dec 21 12:45:55 volumio volumio[1164]: info: Scanning category user_interface Dec 21 12:45:55 volumio volumio[1164]: info: Scanning into folder /data/plugins/ Dec 21 12:45:55 volumio volumio[1164]: info: Plugin folders cleanup completed Dec 21 12:45:55 volumio volumio[1164]: info: ------------------------------------------- Dec 21 12:45:55 volumio volumio[1164]: info: ----- Core plugins startup ---- Dec 21 12:45:55 volumio volumio[1164]: info: ------------------------------------------- Dec 21 12:45:55 volumio volumio[1164]: info: Loading plugins from folder /volumio/app/plugins/ Dec 21 12:45:55 volumio volumio[1164]: info: Adding plugin upnp to MyMusic Plugins Dec 21 12:45:55 volumio volumio[1164]: info: Adding plugin airplay_emulation to MyMusic Plugins Dec 21 12:45:55 volumio volumio[1164]: info: Adding plugin upnp_browser to MyMusic Plugins Dec 21 12:45:55 volumio volumio[1164]: info: Loading plugins from folder /data/plugins/ Dec 21 12:45:55 volumio volumio[1164]: info: Loading plugin "system"... Dec 21 12:45:55 volumio volumio[1164]: info: Loading plugin "appearance"... Dec 21 12:45:57 volumio volumio[1164]: info: Loading plugin "network"... Dec 21 12:45:57 volumio volumio[1164]: info: Loading plugin "services"... Dec 21 12:45:57 volumio volumio[1164]: info: Loading plugin "alsa_controller"... Dec 21 12:45:57 volumio volumio[1164]: info: Loading plugin "wizard"... Dec 21 12:45:57 volumio volumio[1164]: info: Loading plugin "volumio_command_line_client"... Dec 21 12:45:57 volumio volumio[1164]: info: Loading plugin "upnp"... Dec 21 12:45:57 volumio volumio[1164]: info: [1766321157742] Starting Upmpd Daemon Dec 21 12:45:57 volumio volumio[1164]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 21 12:45:57 volumio volumio[1164]: info: Loading plugin "my_music"... Dec 21 12:45:57 volumio volumio[1164]: info: Loading plugin "mpd"... Dec 21 12:45:58 volumio sudo[1191]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 21 12:45:58 volumio volumio[1164]: info: Loading plugin "upnp_browser"... Dec 21 12:45:58 volumio sudo[1194]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 21 12:45:58 volumio sudo[1191]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 21 12:45:58 volumio sudo[1194]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 21 12:45:58 volumio sudo[1191]: pam_unix(sudo:session): session closed for user root Dec 21 12:45:58 volumio systemd[1]: Stopping Music Player Daemon... Dec 21 12:45:58 volumio volumio[1164]: info: Loading plugin "networkfs"... Dec 21 12:45:59 volumio volumio[1164]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 21 12:45:59 volumio volumio[1164]: info: Loading plugin "alarm-clock"... Dec 21 12:45:59 volumio volumio[1164]: info: Loading plugin "airplay_emulation"... Dec 21 12:45:59 volumio volumio[1164]: info: Starting Shairport Sync Dec 21 12:45:59 volumio volumio[1164]: info: Loading plugin "last_100"... Dec 21 12:45:59 volumio volumio[1164]: info: Loading plugin "webradio"... Dec 21 12:45:59 volumio volumio[1164]: info: Loading plugin "i2s_dacs"... Dec 21 12:45:59 volumio volumio[1164]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 21 12:45:59 volumio volumio[1164]: info: Loading plugin "volumiodiscovery"... Dec 21 12:45:59 volumio node[1164]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 21 12:45:59 volumio node[1164]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 21 12:45:59 volumio node[1164]: *** WARNING *** For more information see Dec 21 12:45:59 volumio node[1164]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 21 12:45:59 volumio node[1164]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 21 12:45:59 volumio node[1164]: *** WARNING *** For more information see Dec 21 12:45:59 volumio volumio[1164]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 21 12:45:59 volumio volumio[1164]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 21 12:45:59 volumio volumio[1164]: *** WARNING *** For more information see Dec 21 12:45:59 volumio volumio[1164]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 21 12:45:59 volumio volumio[1164]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 21 12:45:59 volumio volumio[1164]: *** WARNING *** For more information see Dec 21 12:45:59 volumio volumio[1164]: info: Applying required configuration parameters for plugin volumiodiscovery Dec 21 12:45:59 volumio volumio[1164]: Discovery: StartAdv! undefined Dec 21 12:45:59 volumio volumio[1164]: Discovery: Started advertising... Volumio - undefined Dec 21 12:45:59 volumio volumio[1164]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 21 12:45:59 volumio volumio[1164]: info: Loading plugin "outputs"... Dec 21 12:45:59 volumio volumio[1164]: info: Loading plugin "albumart"... Dec 21 12:45:59 volumio volumio[1164]: info: Plugin example_plugin is not enabled Dec 21 12:45:59 volumio volumio[1164]: info: Loading plugin "inputs"... Dec 21 12:45:59 volumio volumio[1164]: info: Loading plugin "updater_comm"... Dec 21 12:45:59 volumio volumio[1164]: info: Plugin mpdemulation is not enabled Dec 21 12:45:59 volumio volumio[1164]: info: Loading plugin "rest_api"... Dec 21 12:45:59 volumio volumio[1164]: info: Loading plugin "websocket"... Dec 21 12:46:00 volumio volumio[1164]: info: ___________ START PLUGINS ___________ Dec 21 12:46:00 volumio volumio[1164]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 21 12:46:00 volumio volumio[1164]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 21 12:46:00 volumio volumio[1164]: info: [1766321160035] CoreMusicLibrary::Adding element Media Servers Dec 21 12:46:00 volumio volumio[1164]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 21 12:46:00 volumio volumio[1164]: Forking 3 albumart workers Dec 21 12:46:00 volumio volumio[1164]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 12:46:00 volumio volumio[1164]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 21 12:46:00 volumio volumio[1164]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 12:46:00 volumio volumio[1164]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 21 12:46:00 volumio volumio[1164]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 21 12:46:00 volumio volumio[1164]: info: [1766321160294] CoreMusicLibrary::Adding element Last_100 Dec 21 12:46:00 volumio volumio[1164]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 21 12:46:00 volumio volumio[1164]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 21 12:46:00 volumio volumio[1164]: info: [1766321160302] CoreMusicLibrary::Adding element Webradio Dec 21 12:46:00 volumio volumio[1164]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 21 12:46:00 volumio volumio[1164]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 21 12:46:00 volumio volumio[1164]: info: ------------------------------------------- Dec 21 12:46:00 volumio volumio[1164]: info: ----- MyVolumio plugins startup ---- Dec 21 12:46:00 volumio volumio[1164]: info: ------------------------------------------- Dec 21 12:46:00 volumio volumio[1164]: info: [MyVolumio PluginManager] Fetching plans data.... Dec 21 12:46:00 volumio volumio[1164]: info: Loading i18n strings for locale en Dec 21 12:46:00 volumio volumio[1164]: Updating browse sources language Dec 21 12:46:00 volumio volumio[1164]: Cannot find translation for sourceMedia Servers Dec 21 12:46:00 volumio volumio[1164]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 21 12:46:00 volumio volumio[1164]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 21 12:46:00 volumio volumio[1164]: info: CoreCommandRouter::initPlayerControls Dec 21 12:46:00 volumio volumio[1164]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 12:46:00 volumio volumio[1164]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 12:46:00 volumio volumio[1164]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 12:46:00 volumio volumio[1164]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 12:46:00 volumio volumio[1164]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 12:46:00 volumio volumio[1164]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 12:46:00 volumio volumio[1164]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 12:46:00 volumio volumio[1164]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 21 12:46:00 volumio volumio[1164]: info: BOOT COMPLETED Dec 21 12:46:00 volumio volumio[1164]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 21 12:46:01 volumio volumio[1164]: Starting albumart workers Dec 21 12:46:01 volumio volumio[1164]: Starting albumart workers Dec 21 12:46:01 volumio volumio[1164]: Starting albumart workers Dec 21 12:46:02 volumio volumio-remote-updater[702]: [2025-12-21 12:46:02] [connect] Successful connection Dec 21 12:46:06 volumio volumio[1164]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Dec 21 12:46:06 volumio volumio[1164]: info: CoreCommandRouter::Close All Modals sent Dec 21 12:46:06 volumio volumio[1164]: info: CoreCommandRouter::Close All Modals sent Dec 21 12:46:06 volumio volumio[1164]: Express server listening on port 3000 Dec 21 12:46:06 volumio volumio[1164]: Volumio Calling Home Dec 21 12:46:06 volumio volumio[1164]: info: CoreStateMachine::resetVolumioState Dec 21 12:46:06 volumio volumio[1164]: info: CoreStateMachine::getcurrentVolume Dec 21 12:46:06 volumio volumio[1164]: info: CoreCommandRouter::volumioRetrievevolume Dec 21 12:46:07 volumio volumio[1164]: info: CoreStateMachine::pushState Dec 21 12:46:07 volumio volumio[1164]: info: CoreStateMachine::getState Dec 21 12:46:07 volumio volumio[1164]: info: CorePlayQueue::getTrack 0 Dec 21 12:46:07 volumio volumio[1164]: info: CoreCommandRouter::volumioPushState Dec 21 12:46:07 volumio volumio[1164]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 21 12:46:07 volumio volumio[1164]: info: CoreStateMachine::updateTrackBlock Dec 21 12:46:07 volumio volumio[1164]: info: CorePlayQueue::getTrackBlock Dec 21 12:46:07 volumio volumio[1164]: info: CoreCommandRouter::volumioRetrievevolume Dec 21 12:46:07 volumio volumio[1164]: info: Setting Device type: Raspberry PI Dec 21 12:46:07 volumio volumio[1164]: info: MPD Permissions set Dec 21 12:46:07 volumio volumio-remote-updater[702]: [2025-12-21 12:46:07] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1766321162 101 Dec 21 12:46:07 volumio volumio[1164]: info: CoreStateMachine::pushState Dec 21 12:46:07 volumio volumio[1164]: info: CoreStateMachine::getState Dec 21 12:46:07 volumio volumio[1164]: info: CorePlayQueue::getTrack 0 Dec 21 12:46:07 volumio volumio[1164]: info: CoreCommandRouter::volumioPushState Dec 21 12:46:07 volumio volumio[1164]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 21 12:46:07 volumio volumio[1164]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 12:46:07 volumio volumio[1164]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 12:46:07 volumio volumio[1164]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 12:46:07 volumio volumio[1164]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 12:46:07 volumio volumio[1164]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 12:46:07 volumio volumio[1164]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 12:46:07 volumio volumio[1164]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 12:46:07 volumio volumio[1164]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 12:46:07 volumio volumio[1164]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 12:46:07 volumio volumio[1164]: info: Reloading queue from file Dec 21 12:46:07 volumio volumio[1164]: info: CoreStateMachine::setRepeat false single undefined Dec 21 12:46:07 volumio volumio[1164]: info: CoreStateMachine::pushState Dec 21 12:46:07 volumio volumio[1164]: info: CoreStateMachine::getState Dec 21 12:46:07 volumio volumio[1164]: info: CorePlayQueue::getTrack 0 Dec 21 12:46:07 volumio volumio[1164]: info: CoreCommandRouter::volumioPushState Dec 21 12:46:07 volumio volumio[1164]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 21 12:46:07 volumio volumio[1164]: info: CoreStateMachine::setRandom false Dec 21 12:46:07 volumio volumio[1164]: info: CoreStateMachine::pushState Dec 21 12:46:07 volumio volumio[1164]: info: CoreStateMachine::getState Dec 21 12:46:07 volumio volumio[1164]: info: CorePlayQueue::getTrack 0 Dec 21 12:46:07 volumio volumio[1164]: info: CoreCommandRouter::volumioPushState Dec 21 12:46:07 volumio volumio[1164]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 21 12:46:07 volumio volumio[1164]: info: Starting Shairport Sync Dec 21 12:46:07 volumio volumio[1164]: info: Starting Shairport Sync Dec 21 12:46:07 volumio sudo[1278]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 21 12:46:07 volumio sudo[1280]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 21 12:46:07 volumio sudo[1278]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 21 12:46:07 volumio sudo[1280]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 21 12:46:07 volumio volumio[1164]: Discovery: adding f7eb1f20-0f1b-472d-9783-ac9e08baf1e0 Dec 21 12:46:07 volumio volumio[1164]: info: mDNS: Found device Volumio Dec 21 12:46:07 volumio systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Dec 21 12:46:07 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Dec 21 12:46:07 volumio sudo[1278]: pam_unix(sudo:session): session closed for user root Dec 21 12:46:07 volumio sudo[1280]: pam_unix(sudo:session): session closed for user root Dec 21 12:46:07 volumio sudo[1291]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 21 12:46:07 volumio sudo[1291]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 21 12:46:07 volumio sudo[1291]: pam_unix(sudo:session): session closed for user root Dec 21 12:46:07 volumio sudo[1315]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 21 12:46:07 volumio volumio[1164]: Discovery: this is already registered, f7eb1f20-0f1b-472d-9783-ac9e08baf1e0 Dec 21 12:46:07 volumio volumio[1164]: info: mDNS: Found device Volumio Dec 21 12:46:07 volumio sudo[1315]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 21 12:46:07 volumio sudo[1315]: pam_unix(sudo:session): session closed for user root Dec 21 12:46:07 volumio sudo[1322]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 21 12:46:07 volumio sudo[1322]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 21 12:46:07 volumio sudo[1322]: pam_unix(sudo:session): session closed for user root Dec 21 12:46:07 volumio volumio[1164]: info: Shairport-Sync Started Dec 21 12:46:07 volumio volumio[1164]: Error adding Membership: Error: addMembership EINVAL Dec 21 12:46:07 volumio volumio[1164]: info: Shairport-Sync Started Dec 21 12:46:07 volumio volumio[1164]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Dec 21 12:46:08 volumio volumio[1164]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Dec 21 12:46:08 volumio volumio[1164]: info: CoreCommandRouter::volumioGetState Dec 21 12:46:08 volumio volumio[1164]: info: CoreStateMachine::getState Dec 21 12:46:08 volumio volumio[1164]: info: CorePlayQueue::getTrack 0 Dec 21 12:46:08 volumio sudo[1335]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 21 12:46:08 volumio sudo[1335]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 21 12:46:08 volumio sudo[1335]: pam_unix(sudo:session): session closed for user root Dec 21 12:46:08 volumio sudo[1344]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Dec 21 12:46:08 volumio sudo[1344]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 21 12:46:08 volumio systemd[1]: Starting UPnP Renderer front-end to MPD... Dec 21 12:46:08 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Dec 21 12:46:08 volumio sudo[1344]: pam_unix(sudo:session): session closed for user root Dec 21 12:46:08 volumio volumio[1164]: info: Upmpdcli Daemon Started Dec 21 12:46:09 volumio volumio[1164]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Dec 21 12:46:09 volumio volumio[1164]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Dec 21 12:46:09 volumio volumio[1164]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Dec 21 12:46:09 volumio volumio[1164]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Dec 21 12:46:09 volumio volumio[1164]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Dec 21 12:46:09 volumio volumio[1164]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Dec 21 12:46:09 volumio volumio[1164]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Dec 21 12:46:09 volumio volumio[1164]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Dec 21 12:46:09 volumio volumio[1164]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Dec 21 12:46:09 volumio volumio[1164]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Dec 21 12:46:09 volumio volumio[1164]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Dec 21 12:46:09 volumio volumio[1164]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Dec 21 12:46:09 volumio volumio[1164]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Dec 21 12:46:09 volumio volumio[1164]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Dec 21 12:46:09 volumio volumio[1164]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Dec 21 12:46:09 volumio volumio[1164]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Dec 21 12:46:09 volumio volumio[1164]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Dec 21 12:46:09 volumio volumio[1164]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Dec 21 12:46:09 volumio volumio[1164]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Dec 21 12:46:09 volumio volumio[1164]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Dec 21 12:46:09 volumio volumio[1164]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Dec 21 12:46:09 volumio volumio[1164]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Dec 21 12:46:09 volumio volumio[1164]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Dec 21 12:46:09 volumio volumio[1164]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Dec 21 12:46:09 volumio volumio[1164]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Dec 21 12:46:09 volumio volumio[1164]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Dec 21 12:46:09 volumio volumio[1164]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Dec 21 12:46:09 volumio volumio[1164]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Dec 21 12:46:09 volumio volumio[1164]: info: Adding plugin bluetooth to MyMusic Plugins Dec 21 12:46:09 volumio volumio[1164]: info: Adding plugin cd_controller to MyMusic Plugins Dec 21 12:46:09 volumio volumio[1164]: info: Adding plugin smart_inputs to MyMusic Plugins Dec 21 12:46:09 volumio volumio[1164]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Dec 21 12:46:12 volumio volumio[1164]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Dec 21 12:46:13 volumio volumio[1164]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Dec 21 12:46:13 volumio volumio[1164]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Dec 21 12:46:13 volumio volumio[1164]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 21 12:46:13 volumio volumio[1164]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 21 12:46:13 volumio volumio[1164]: info: Starting MyVolumio Remote Streaming Endpoints Dec 21 12:46:13 volumio volumio[1164]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Dec 21 12:46:13 volumio volumio[1164]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Dec 21 12:46:13 volumio volumio[1164]: info: Streaming services startup Dec 21 12:46:13 volumio volumio[1164]: info: Starting Streaming Daemon Dec 21 12:46:13 volumio volumio[1164]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Dec 21 12:46:13 volumio sudo[1355]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Dec 21 12:46:13 volumio sudo[1355]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 21 12:46:13 volumio systemd[1]: Stopping Volumio Streaming Daemon... Dec 21 12:46:13 volumio systemd[1]: Starting Volumio Streaming Daemon... Dec 21 12:46:13 volumio systemd[1]: Started Volumio Streaming Daemon. Dec 21 12:46:13 volumio sudo[1355]: pam_unix(sudo:session): session closed for user root Dec 21 12:46:13 volumio volumio-streaming-daemon[1361]: ############################ Dec 21 12:46:13 volumio volumio-streaming-daemon[1361]: # Volumio Streaming Daemon # Dec 21 12:46:13 volumio volumio-streaming-daemon[1361]: # Running on port 7777 # Dec 21 12:46:13 volumio volumio-streaming-daemon[1361]: ############################ Dec 21 12:46:15 volumio volumio[1164]: error: MyVolumio Custom Token format not valid, refreshing it Dec 21 12:46:16 volumio volumio[1164]: info: Fetching Streaming Services browse cache Dec 21 12:46:16 volumio volumio[1164]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesQOBUZ Dec 21 12:46:16 volumio volumio[1164]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 21 12:46:16 volumio volumio[1164]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesTIDAL Dec 21 12:46:16 volumio volumio[1164]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 21 12:46:17 volumio udisks-glue[699]: error: Timeout Dec 21 12:46:17 volumio volumio[1164]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=2.698&uuid=519eb2e19d0da735d08b86ec6fe57c18" http://updates.volumio.org:7070/downloader-v1/track-device Dec 21 12:46:17 volumio volumio[1164]: % Total % Received % Xferd Average Speed Time Time Time Current Dec 21 12:46:17 volumio volumio[1164]: Dload Upload Total Spent Left Speed Dec 21 12:46:17 volumio volumio[1164]: 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0curl: (7) Failed to connect to updates.volumio.org port 7070: Connection refused Dec 21 12:46:17 volumio volumio[1164]: retrying in 5 seconds, trial 0 Dec 21 12:46:17 volumio volumio[1164]: Volumio Calling Home Dec 21 12:46:17 volumio volumio[1164]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Dec 21 12:46:17 volumio volumio[1164]: info: MYVOLUMIO: Adding device Dec 21 12:46:17 volumio volumio[1164]: info: MYVOLUMIO: Evaluating Server Dec 21 12:46:19 volumio volumio[1164]: info: MyVolumio status changed Dec 21 12:46:19 volumio volumio[1164]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesQOBUZ Dec 21 12:46:19 volumio volumio[1164]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 21 12:46:19 volumio volumio[1164]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesTIDAL Dec 21 12:46:19 volumio volumio[1164]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 21 12:46:19 volumio volumio[1164]: info: Streaming services startup Dec 21 12:46:19 volumio volumio[1164]: info: Re-Starting Streaming Daemon Dec 21 12:46:19 volumio volumio[1164]: info: Removing browser output: myVolumio user plan is not superstar Dec 21 12:46:19 volumio volumio[1164]: info: Removing audio output: Dec 21 12:46:19 volumio volumio[1164]: info: Stoppping Tunnel 1 Dec 21 12:46:19 volumio sudo[1400]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Dec 21 12:46:19 volumio sudo[1400]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 21 12:46:19 volumio volumio-streaming-daemon[1361]: Restarting daemon Dec 21 12:46:19 volumio systemd[1]: Stopped MyVolumio SSH Tunnel. Dec 21 12:46:19 volumio sudo[1400]: pam_unix(sudo:session): session closed for user root Dec 21 12:46:19 volumio volumio[1164]: info: Remote SSH Stopped Dec 21 12:46:19 volumio volumio[1164]: info: Setting Geolocation for MyVolumio to as1 Dec 21 12:46:19 volumio volumio[1164]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 21 12:46:19 volumio volumio[1164]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 21 12:46:19 volumio volumio[1164]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 21 12:46:20 volumio volumio[1164]: info: Fetching Streaming Services browse cache Dec 21 12:46:20 volumio volumio[1164]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesTIDAL Dec 21 12:46:20 volumio volumio[1164]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 21 12:46:20 volumio volumio[1164]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesQOBUZ Dec 21 12:46:20 volumio volumio[1164]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 21 12:46:20 volumio volumio[1164]: info: Updating MyVolumio device info Dec 21 12:46:20 volumio volumio[1164]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 21 12:46:20 volumio volumio[1164]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 21 12:46:20 volumio volumio[1164]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 21 12:46:28 volumio volumio[1164]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=2.698&uuid=519eb2e19d0da735d08b86ec6fe57c18" http://updates.volumio.org:7070/downloader-v1/track-device Dec 21 12:46:28 volumio volumio[1164]: % Total % Received % Xferd Average Speed Time Time Time Current Dec 21 12:46:28 volumio volumio[1164]: Dload Upload Total Spent Left Speed Dec 21 12:46:28 volumio volumio[1164]: [235B blob data] Dec 21 12:46:28 volumio volumio[1164]: retrying in 5 seconds, trial 1 Dec 21 12:46:28 volumio volumio[1164]: Volumio Calling Home Dec 21 12:46:30 volumio volumio[1164]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 21 12:46:30 volumio volumio[1164]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 21 12:46:38 volumio volumio[1164]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=2.698&uuid=519eb2e19d0da735d08b86ec6fe57c18" http://updates.volumio.org:7070/downloader-v1/track-device Dec 21 12:46:38 volumio volumio[1164]: % Total % Received % Xferd Average Speed Time Time Time Current Dec 21 12:46:38 volumio volumio[1164]: Dload Upload Total Spent Left Speed Dec 21 12:46:38 volumio volumio[1164]: 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0curl: (7) Failed to connect to updates.volumio.org port 7070: Connection refused Dec 21 12:46:38 volumio volumio[1164]: retrying in 5 seconds, trial 2 Dec 21 12:46:38 volumio volumio[1164]: Volumio Calling Home Dec 21 12:46:44 volumio sudo[1418]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 21 12:46:44 volumio sudo[1418]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 21 12:46:44 volumio sudo[1421]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 21 12:46:44 volumio sudo[1418]: pam_unix(sudo:session): session closed for user root Dec 21 12:46:44 volumio sudo[1421]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 21 12:46:44 volumio sudo[1421]: pam_unix(sudo:session): session closed for user root Dec 21 12:46:45 volumio volumio[1164]: info: CoreCommandRouter::volumioGetVisibleSources Dec 21 12:46:45 volumio volumio[1164]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 21 12:46:45 volumio volumio[1164]: info: CoreCommandRouter::volumioGetState Dec 21 12:46:45 volumio volumio[1164]: info: CoreStateMachine::getState Dec 21 12:46:45 volumio volumio[1164]: info: CorePlayQueue::getTrack 0 Dec 21 12:46:45 volumio volumio[1164]: info: CoreCommandRouter::volumioGetQueue Dec 21 12:46:45 volumio volumio[1164]: info: CoreStateMachine::getQueue Dec 21 12:46:45 volumio volumio[1164]: info: CorePlayQueue::getQueue Dec 21 12:46:45 volumio volumio[1164]: info: Listing playlists Dec 21 12:46:45 volumio sudo[1436]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 21 12:46:45 volumio volumio[1164]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 21 12:46:45 volumio volumio[1164]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 21 12:46:45 volumio volumio[1164]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 21 12:46:45 volumio volumio[1164]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 21 12:46:45 volumio sudo[1436]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 21 12:46:45 volumio sudo[1436]: pam_unix(sudo:session): session closed for user root Dec 21 12:46:45 volumio volumio[1164]: info: No input data Dec 21 12:46:45 volumio volumio[1164]: info: No input data Dec 21 12:46:45 volumio volumio[1164]: info: No input data Dec 21 12:46:45 volumio volumio[1164]: info: No input data Dec 21 12:46:45 volumio volumio[1164]: info: No input data Dec 21 12:46:45 volumio volumio[1164]: info: No input data Dec 21 12:46:45 volumio volumio[1164]: info: No input data Dec 21 12:46:45 volumio volumio[1164]: info: No input data Dec 21 12:46:45 volumio volumio[1164]: info: No input data Dec 21 12:46:46 volumio volumio[1164]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 21 12:46:46 volumio volumio[1164]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Dec 21 12:46:46 volumio systemd[1]: Starting Music Player Daemon... Dec 21 12:46:48 volumio volumio[1164]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 21 12:46:48 volumio volumio[1164]: info: CURURI: playlists Dec 21 12:46:48 volumio volumio[1164]: info: Listing playlists Dec 21 12:46:52 volumio volumio[1164]: info: Play playlist Allan Taylor Dec 21 12:46:52 volumio volumio[1164]: info: CoreCommandRouter::volumioClearQueue Dec 21 12:46:52 volumio volumio[1164]: info: CoreStateMachine::ClearQueue Dec 21 12:46:52 volumio volumio[1164]: info: CoreStateMachine::stop Dec 21 12:46:52 volumio volumio[1164]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 21 12:46:52 volumio volumio[1164]: UNSET VOLATILE Dec 21 12:46:52 volumio volumio[1164]: info: CorePlayQueue::clearPlayQueue Dec 21 12:46:52 volumio volumio[1164]: info: CorePlayQueue::saveQueue Dec 21 12:46:52 volumio volumio[1164]: info: CoreStateMachine::pushEmptyState Dec 21 12:46:52 volumio volumio[1164]: info: CoreCommandRouter::volumioPushState Dec 21 12:46:52 volumio volumio[1164]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 21 12:46:52 volumio volumio[1164]: info: CoreCommandRouter::volumioPushQueue Dec 21 12:46:52 volumio volumio[1164]: info: CoreCommandRouter::volumioAddQueueItems Dec 21 12:46:52 volumio volumio[1164]: info: CoreStateMachine::addQueueItems Dec 21 12:46:52 volumio volumio[1164]: info: CorePlayQueue::addQueueItems Dec 21 12:46:52 volumio sudo[1452]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 21 12:46:52 volumio volumio[1164]: info: Adding Item to queue: USB/Music/2pPCM/Hi-Res/Allan Taylor - Live In Belgium (2009)/01. Introduction.flac Dec 21 12:46:52 volumio volumio[1164]: info: Exploding uri USB/Music/2pPCM/Hi-Res/Allan Taylor - Live In Belgium (2009)/01. Introduction.flac in service mpd Dec 21 12:46:52 volumio sudo[1452]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 21 12:46:52 volumio volumio[1164]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 21 12:46:52 volumio sudo[1452]: pam_unix(sudo:session): session closed for user root Dec 21 12:46:52 volumio volumio[1164]: TypeError: Cannot read property 'then' of undefined Dec 21 12:46:52 volumio volumio[1164]: at ControllerMpd.scanFolder (/volumio/app/plugins/music_service/mpd/index.js:2608:23) Dec 21 12:46:52 volumio volumio[1164]: at ControllerMpd.explodeUri (/volumio/app/plugins/music_service/mpd/index.js:2384:23) Dec 21 12:46:52 volumio volumio[1164]: at CoreCommandRouter.explodeUriFromService (/volumio/app/index.js:1326:22) Dec 21 12:46:52 volumio volumio[1164]: at CorePlayQueue.addQueueItems (/volumio/app/playqueue.js:151:58) Dec 21 12:46:52 volumio volumio[1164]: at CoreStateMachine.addQueueItems (/volumio/app/statemachine.js:249:24) Dec 21 12:46:52 volumio volumio[1164]: at CoreCommandRouter.addQueueItems (/volumio/app/index.js:463:27) Dec 21 12:46:52 volumio volumio[1164]: at /volumio/app/playlistManager.js:764:40 Dec 21 12:46:52 volumio volumio[1164]: at /volumio/node_modules/fs-extra/node_modules/jsonfile/index.js:46:5 Dec 21 12:46:52 volumio volumio[1164]: at /volumio/node_modules/graceful-fs/graceful-fs.js:90:16 Dec 21 12:46:52 volumio volumio[1164]: at FSReqWrap.readFileAfterClose [as oncomplete] (fs.js:511:3) Dec 21 12:46:52 volumio volumio[1164]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 21 12:46:53 volumio sudo[1468]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-21 12:45 Dec 21 12:46:53 volumio sudo[1468]: 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="80e3a7415791a01dac7cd7cc2cc0a3d3fc65ba9d" VOLUMIO_FE_VERSION="" VOLUMIO_BE_VERSION="a5d5fb6aa4e4c71be85580a005adf6b2009366a5" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Jan 16 20:23:20 CET 2020" VOLUMIO_VERSION="2.698" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="3dcbb012a2043e1c4181cb54ce618cae"