-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Sat 2025-03-08 10:23:57 CET. -- Mar 08 10:22:00 dorsz-connect dhcpcd[883]: wlan0: rebinding lease of 192.168.1.139 Mar 08 10:22:00 dorsz-connect dhcpcd[883]: wlan0: probing address 192.168.1.139/24 Mar 08 10:22:00 dorsz-connect dhcpcd[883]: wlan0: soliciting an IPv6 router Mar 08 10:22:00 dorsz-connect wireless.js[595]: trying... Mar 08 10:22:00 dorsz-connect sudo[921]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 08 10:22:00 dorsz-connect sudo[921]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 10:22:00 dorsz-connect sudo[921]: pam_unix(sudo:session): session closed for user root Mar 08 10:22:01 dorsz-connect volumio-time-update[604]: volumio-time-update-util: Fetching time from Volumio... Mar 08 10:22:01 dorsz-connect volumio-time-update[604]: volumio-time-update-util: Date not found in response Mar 08 10:22:01 dorsz-connect volumio-time-update[604]: volumio-time-update-util: Retrying in 5 seconds... Mar 08 10:22:01 dorsz-connect wireless.js[595]: trying... Mar 08 10:22:01 dorsz-connect sudo[929]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 08 10:22:01 dorsz-connect sudo[929]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 10:22:01 dorsz-connect sudo[929]: pam_unix(sudo:session): session closed for user root Mar 08 10:22:02 dorsz-connect wireless.js[595]: trying... Mar 08 10:22:02 dorsz-connect sudo[932]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 08 10:22:02 dorsz-connect sudo[932]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 10:22:02 dorsz-connect sudo[932]: pam_unix(sudo:session): session closed for user root Mar 08 10:22:03 dorsz-connect wireless.js[595]: trying... Mar 08 10:22:03 dorsz-connect sudo[935]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 08 10:22:03 dorsz-connect sudo[935]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 10:22:03 dorsz-connect sudo[935]: pam_unix(sudo:session): session closed for user root Mar 08 10:22:04 dorsz-connect wireless.js[595]: trying... Mar 08 10:22:04 dorsz-connect sudo[938]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 08 10:22:04 dorsz-connect sudo[938]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 10:22:04 dorsz-connect sudo[938]: pam_unix(sudo:session): session closed for user root Mar 08 10:22:05 dorsz-connect wireless.js[595]: trying... Mar 08 10:22:05 dorsz-connect sudo[941]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 08 10:22:05 dorsz-connect sudo[941]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 10:22:05 dorsz-connect sudo[941]: pam_unix(sudo:session): session closed for user root Mar 08 10:22:05 dorsz-connect dhcpcd[883]: wlan0: leased 192.168.1.139 for 86400 seconds Mar 08 10:22:05 dorsz-connect avahi-daemon[607]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.139. Mar 08 10:22:05 dorsz-connect avahi-daemon[607]: New relevant interface wlan0.IPv4 for mDNS. Mar 08 10:22:05 dorsz-connect avahi-daemon[607]: Registering new address record for 192.168.1.139 on wlan0.IPv4. Mar 08 10:22:05 dorsz-connect dhcpcd[883]: wlan0: adding route to 192.168.1.0/24 Mar 08 10:22:05 dorsz-connect dhcpcd[883]: wlan0: adding default route via 192.168.1.1 Mar 08 10:22:06 dorsz-connect volumio-time-update[604]: volumio-time-update-util: Fetching time from Volumio... Mar 08 10:22:06 dorsz-connect volumio-time-update[604]: volumio-time-update-util: Setting system time to: 2025-03-08 10:22:29 Mar 08 10:22:06 dorsz-connect sudo[968]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-time 2025-03-08 10:22:29 Mar 08 10:22:06 dorsz-connect sudo[968]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 10:22:06 dorsz-connect wireless.js[595]: trying... Mar 08 10:22:06 dorsz-connect sudo[971]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 08 10:22:06 dorsz-connect sudo[971]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 10:22:06 dorsz-connect sudo[971]: pam_unix(sudo:session): session closed for user root Mar 08 10:22:06 dorsz-connect wireless.js[595]: Connected to: ----**** Mar 08 10:22:06 dorsz-connect wireless.js[595]: ---- Mar 08 10:22:06 dorsz-connect dbus-daemon[592]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.9' (uid=0 pid=969 comm="timedatectl set-time 2025-03-08 10:22:29 ") Mar 08 10:22:06 dorsz-connect sudo[974]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 08 10:22:06 dorsz-connect sudo[974]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 10:22:06 dorsz-connect wireless.js[595]: ... joined AP, wlan0 IPv4 is 192.168.1.139, ipV6 is undefined Mar 08 10:22:06 dorsz-connect wireless.js[595]: It's done! AP Mar 08 10:22:06 dorsz-connect sudo[974]: pam_unix(sudo:session): session closed for user root Mar 08 10:22:06 dorsz-connect systemd[1]: Starting Time & Date Service... Mar 08 10:22:06 dorsz-connect kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Mar 08 10:22:06 dorsz-connect systemd[1]: Started Wireless Services. Mar 08 10:22:06 dorsz-connect systemd[1]: Started Volumio Backend Module. Mar 08 10:22:06 dorsz-connect systemd[1]: Started Volumio Cpu Tweaker. Mar 08 10:22:06 dorsz-connect volumio-cpu-tweak[981]: Setting RT Priority for mpd Mar 08 10:22:06 dorsz-connect volumio-cpu-tweak[981]: Setting MPD Affinity Mar 08 10:22:06 dorsz-connect volumio-cpu-tweak[981]: pid 787's current affinity mask: f Mar 08 10:22:06 dorsz-connect volumio-cpu-tweak[981]: pid 787's new affinity mask: 3 Mar 08 10:22:06 dorsz-connect volumio-cpu-tweak[981]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input Mar 08 10:22:06 dorsz-connect volumio-cpu-tweak[981]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance Mar 08 10:22:06 dorsz-connect dbus-daemon[592]: [system] Successfully activated service 'org.freedesktop.timedate1' Mar 08 10:22:06 dorsz-connect systemd[1]: Started Time & Date Service. Mar 08 10:22:29 dorsz-connect systemd-timedated[975]: Changed local time to Sat Mar 8 10:22:29 2025 Mar 08 10:22:29 dorsz-connect sudo[968]: pam_unix(sudo:session): session closed for user root Mar 08 10:22:29 dorsz-connect volumio-time-update[604]: volumio-time-update-util: System time updated successfully. Mar 08 10:22:29 dorsz-connect systemd[1]: Started Volumio Time Update Utility. Mar 08 10:22:29 dorsz-connect systemd[1]: volumio_cpu_tweak.service: Succeeded. Mar 08 10:22:29 dorsz-connect ntpd[730]: Listen normally on 3 wlan0 192.168.1.139:123 Mar 08 10:22:29 dorsz-connect ntpd[730]: new interface(s) found: waking up resolver Mar 08 10:22:30 dorsz-connect volumio-remote-updater[596]: [2025-03-08 10:22:30] [connect] Successful connection Mar 08 10:22:30 dorsz-connect nmbd[700]: [2025/03/08 10:22:30.992362, 0] ../lib/util/become_daemon.c:138(daemon_ready) Mar 08 10:22:30 dorsz-connect systemd[1]: Started Samba NMB Daemon. Mar 08 10:22:30 dorsz-connect nmbd[700]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Mar 08 10:22:31 dorsz-connect systemd[1]: Starting Samba Winbind Daemon... Mar 08 10:22:31 dorsz-connect winbindd[997]: [2025/03/08 10:22:31.380338, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Mar 08 10:22:31 dorsz-connect winbindd[997]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Mar 08 10:22:31 dorsz-connect winbindd[997]: [2025/03/08 10:22:31.425828, 0] ../lib/util/become_daemon.c:138(daemon_ready) Mar 08 10:22:31 dorsz-connect winbindd[997]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Mar 08 10:22:31 dorsz-connect systemd[1]: Started Samba Winbind Daemon. Mar 08 10:22:31 dorsz-connect systemd[1]: Starting Samba SMB Daemon... Mar 08 10:22:31 dorsz-connect volumio[980]: info: ------------------------------------------- Mar 08 10:22:31 dorsz-connect volumio[980]: info: ----- Volumio3 ---- Mar 08 10:22:31 dorsz-connect volumio[980]: info: ------------------------------------------- Mar 08 10:22:31 dorsz-connect volumio[980]: info: ----- System startup ---- Mar 08 10:22:31 dorsz-connect volumio[980]: info: ------------------------------------------- Mar 08 10:22:32 dorsz-connect winbindd[997]: [2025/03/08 10:22:32.010309, 0] ../source3/winbindd/wb_lookupsids.c:659(wb_lookupsids_recv) Mar 08 10:22:32 dorsz-connect winbindd[997]: res_names->count = 3, expected 4 Mar 08 10:22:32 dorsz-connect smbd[1010]: [2025/03/08 10:22:32.105927, 0] ../lib/util/become_daemon.c:138(daemon_ready) Mar 08 10:22:32 dorsz-connect smbd[1010]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Mar 08 10:22:32 dorsz-connect systemd[1]: Started Samba SMB Daemon. Mar 08 10:22:32 dorsz-connect systemd[1]: Reached target Multi-User System. Mar 08 10:22:32 dorsz-connect systemd[1]: Reached target Graphical Interface. Mar 08 10:22:32 dorsz-connect systemd[1]: Starting Update UTMP about System Runlevel Changes... Mar 08 10:22:32 dorsz-connect systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Mar 08 10:22:32 dorsz-connect systemd[1]: Started Update UTMP about System Runlevel Changes. Mar 08 10:22:32 dorsz-connect systemd[1]: Startup finished in 13.994s (kernel) + 31.343s (userspace) = 45.337s. Mar 08 10:22:32 dorsz-connect volumio[980]: info: MYVOLUMIO Environment detected Mar 08 10:22:33 dorsz-connect volumio[980]: info: Plugin folders cleanup Mar 08 10:22:33 dorsz-connect volumio[980]: info: Scanning into folder /volumio/app/plugins/ Mar 08 10:22:33 dorsz-connect volumio[980]: info: Scanning category audio_interface Mar 08 10:22:33 dorsz-connect volumio[980]: info: Scanning category miscellanea Mar 08 10:22:33 dorsz-connect volumio[980]: info: Scanning category music_service Mar 08 10:22:33 dorsz-connect volumio[980]: info: Scanning category plugins.json Mar 08 10:22:33 dorsz-connect volumio[980]: info: Scanning category system_controller Mar 08 10:22:33 dorsz-connect volumio[980]: info: Scanning category user_interface Mar 08 10:22:33 dorsz-connect volumio[980]: info: Scanning into folder /data/plugins/ Mar 08 10:22:33 dorsz-connect volumio[980]: info: Plugin folders cleanup completed Mar 08 10:22:33 dorsz-connect volumio[980]: info: ------------------------------------------- Mar 08 10:22:33 dorsz-connect volumio[980]: info: ----- Core plugins startup ---- Mar 08 10:22:33 dorsz-connect volumio[980]: info: ------------------------------------------- Mar 08 10:22:33 dorsz-connect volumio[980]: info: Loading plugins from folder /volumio/app/plugins/ Mar 08 10:22:33 dorsz-connect volumio[980]: info: Adding plugin upnp to MyMusic Plugins Mar 08 10:22:33 dorsz-connect volumio[980]: info: Adding plugin airplay_emulation to MyMusic Plugins Mar 08 10:22:33 dorsz-connect volumio[980]: info: Adding plugin upnp_browser to MyMusic Plugins Mar 08 10:22:33 dorsz-connect volumio[980]: info: Loading plugins from folder /data/plugins/ Mar 08 10:22:33 dorsz-connect volumio[980]: info: Loading plugin "system"... Mar 08 10:22:33 dorsz-connect volumio[980]: info: Loading plugin "appearance"... Mar 08 10:22:34 dorsz-connect volumio[980]: info: Loading plugin "network"... Mar 08 10:22:34 dorsz-connect volumio[980]: info: Refreshing Cached IP Addresses Mar 08 10:22:34 dorsz-connect sudo[1028]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 08 10:22:34 dorsz-connect sudo[1028]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 10:22:34 dorsz-connect sudo[1028]: pam_unix(sudo:session): session closed for user root Mar 08 10:22:34 dorsz-connect sudo[1030]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 08 10:22:34 dorsz-connect sudo[1030]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 10:22:34 dorsz-connect sudo[1030]: pam_unix(sudo:session): session closed for user root Mar 08 10:22:34 dorsz-connect volumio[980]: info: Loading plugin "services"... Mar 08 10:22:34 dorsz-connect volumio[980]: info: Loading plugin "alsa_controller"... Mar 08 10:22:34 dorsz-connect sudo[1039]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Mar 08 10:22:34 dorsz-connect sudo[1039]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 10:22:34 dorsz-connect systemd[1]: systemd-fsckd.service: Succeeded. Mar 08 10:22:34 dorsz-connect volumio[980]: warn: Unable to locate the audio output device HiFiBerry DAC2 HD. Please configure a valid output device. Mar 08 10:22:35 dorsz-connect volumio[980]: Invalid card number. Mar 08 10:22:35 dorsz-connect volumio[980]: info: Hardware Mixer selected but no Hardware mixer available, detecting default mixer Mar 08 10:22:35 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 08 10:22:35 dorsz-connect volumio[980]: Invalid card number. Mar 08 10:22:35 dorsz-connect volumio[980]: info: CoreCommandRouter::volumioUpdateVolumeSettings Mar 08 10:22:35 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 08 10:22:35 dorsz-connect volumio[980]: info: Loading plugin "wizard"... Mar 08 10:22:35 dorsz-connect volumio[980]: info: Loading plugin "networkfs"... Mar 08 10:22:35 dorsz-connect volumio[980]: info: Starting Udev Watcher for removable devices Mar 08 10:22:35 dorsz-connect volumio[980]: info: Ignoring mount for partition: boot Mar 08 10:22:35 dorsz-connect volumio[980]: info: Ignoring mount for partition: volumio Mar 08 10:22:35 dorsz-connect volumio[980]: info: Ignoring mount for partition: volumio_data Mar 08 10:22:35 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 08 10:22:35 dorsz-connect volumio[980]: info: Loading plugin "volumio_command_line_client"... Mar 08 10:22:35 dorsz-connect volumio[980]: info: Loading plugin "upnp"... Mar 08 10:22:35 dorsz-connect volumio[980]: info: [1741425755199] Starting Upmpd Daemon Mar 08 10:22:35 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 08 10:22:35 dorsz-connect volumio[980]: info: Loading plugin "my_music"... Mar 08 10:22:35 dorsz-connect volumio[980]: info: Loading plugin "mpd"... Mar 08 10:22:35 dorsz-connect volumio[980]: info: Loading plugin "upnp_browser"... Mar 08 10:22:36 dorsz-connect volumio[980]: info: Loading plugin "alarm-clock"... Mar 08 10:22:36 dorsz-connect volumio[980]: info: Plugin airplay_emulation is not enabled Mar 08 10:22:36 dorsz-connect volumio[980]: info: Loading plugin "last_100"... Mar 08 10:22:36 dorsz-connect volumio[980]: info: Loading plugin "webradio"... Mar 08 10:22:36 dorsz-connect volumio[980]: info: Loading plugin "i2s_dacs"... Mar 08 10:22:36 dorsz-connect volumio[980]: info: Loading plugin "volumiodiscovery"... Mar 08 10:22:36 dorsz-connect volumio[980]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Mar 08 10:22:36 dorsz-connect volumio[980]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 08 10:22:36 dorsz-connect volumio[980]: *** WARNING *** For more information see Mar 08 10:22:36 dorsz-connect node[980]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Mar 08 10:22:36 dorsz-connect volumio[980]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Mar 08 10:22:36 dorsz-connect volumio[980]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 08 10:22:36 dorsz-connect volumio[980]: *** WARNING *** For more information see Mar 08 10:22:36 dorsz-connect node[980]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 08 10:22:36 dorsz-connect node[980]: *** WARNING *** For more information see Mar 08 10:22:36 dorsz-connect node[980]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Mar 08 10:22:36 dorsz-connect node[980]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 08 10:22:36 dorsz-connect node[980]: *** WARNING *** For more information see Mar 08 10:22:36 dorsz-connect volumio[980]: info: Applying required configuration parameters for plugin volumiodiscovery Mar 08 10:22:36 dorsz-connect volumio[980]: info: Discovery: Started advertising with name: Dorsz Connect Mar 08 10:22:36 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 08 10:22:36 dorsz-connect volumio[980]: info: Loading plugin "outputs"... Mar 08 10:22:36 dorsz-connect volumio[980]: info: Loading plugin "albumart"... Mar 08 10:22:36 dorsz-connect volumio[980]: info: Plugin example_plugin is not enabled Mar 08 10:22:36 dorsz-connect volumio[980]: info: Loading plugin "inputs"... Mar 08 10:22:36 dorsz-connect volumio[980]: info: Loading plugin "updater_comm"... Mar 08 10:22:36 dorsz-connect volumio[980]: info: Plugin mpdemulation is not enabled Mar 08 10:22:36 dorsz-connect volumio[980]: info: Loading plugin "rest_api"... Mar 08 10:22:36 dorsz-connect volumio[980]: info: Loading plugin "websocket"... Mar 08 10:22:36 dorsz-connect volumio[980]: info: Starting Socket.io Server version 2.3.0 Mar 08 10:22:37 dorsz-connect volumio[980]: info: Loading i18n strings for locale en Mar 08 10:22:37 dorsz-connect volumio[980]: Updating browse sources language Mar 08 10:22:37 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 08 10:22:37 dorsz-connect volumio[980]: Forking 3 albumart workers Mar 08 10:22:37 dorsz-connect sh[495]: timed out Mar 08 10:22:37 dorsz-connect dhcpcd[547]: timed out Mar 08 10:22:37 dorsz-connect sh[495]: dhcpcd exited Mar 08 10:22:37 dorsz-connect dhcpcd[547]: dhcpcd exited Mar 08 10:22:37 dorsz-connect sh[495]: ifup: failed to bring up eth0 Mar 08 10:22:37 dorsz-connect systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE Mar 08 10:22:37 dorsz-connect systemd[1]: ifup@eth0.service: Failed with result 'exit-code'. Mar 08 10:22:37 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 08 10:22:37 dorsz-connect volumio[980]: info: CoreCommandRouter::initPlayerControls Mar 08 10:22:37 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 10:22:37 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 10:22:37 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 10:22:37 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 10:22:37 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 10:22:37 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 10:22:37 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 10:22:37 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 10:22:37 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 08 10:22:37 dorsz-connect volumio[980]: Express server listening on port 3000 Mar 08 10:22:37 dorsz-connect volumio[980]: [Metrics] WebUI: 7s 26.22ms Mar 08 10:22:37 dorsz-connect volumio[980]: info: CoreStateMachine::resetVolumioState Mar 08 10:22:37 dorsz-connect volumio[980]: info: CoreStateMachine::getcurrentVolume Mar 08 10:22:37 dorsz-connect volumio[980]: info: CoreCommandRouter::volumioRetrievevolume Mar 08 10:22:37 dorsz-connect volumio[980]: info: Volumio Network Manager: Network status updated: 2 Mar 08 10:22:37 dorsz-connect volumio[980]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Mar 08 10:22:38 dorsz-connect volumio[980]: verbose: New Socket.io Connection to 192.168.1.139 from 192.168.1.178 UA: Mozilla/5.0 (Linux; Android 14; SM-S916B Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/133.0.6943.138 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 Mar 08 10:22:38 dorsz-connect volumio[980]: info: VolumeController:: Volume=undefined Mute =false Mar 08 10:22:38 dorsz-connect volumio[980]: info: CoreStateMachine::pushState Mar 08 10:22:38 dorsz-connect volumio[980]: info: CorePlayQueue::getTrack 0 Mar 08 10:22:38 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 08 10:22:38 dorsz-connect volumio[980]: info: CoreCommandRouter::volumioPushState Mar 08 10:22:38 dorsz-connect volumio[980]: info: CoreStateMachine::updateTrackBlock Mar 08 10:22:38 dorsz-connect volumio[980]: info: CorePlayQueue::getTrackBlock Mar 08 10:22:38 dorsz-connect volumio[980]: info: CoreCommandRouter::volumioRetrievevolume Mar 08 10:22:38 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 08 10:22:38 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 08 10:22:38 dorsz-connect volumio[980]: info: Discovery: Getting this device information Mar 08 10:22:38 dorsz-connect volumio[980]: info: CoreCommandRouter::volumioGetState Mar 08 10:22:38 dorsz-connect volumio[980]: info: CorePlayQueue::getTrack 0 Mar 08 10:22:38 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 08 10:22:38 dorsz-connect volumio[980]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Mar 08 10:22:38 dorsz-connect volumio[980]: info: Reloading queue from file Mar 08 10:22:38 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 08 10:22:38 dorsz-connect volumio[980]: info: VolumeController:: Volume=undefined Mute =false Mar 08 10:22:38 dorsz-connect volumio[980]: info: CoreStateMachine::pushState Mar 08 10:22:38 dorsz-connect volumio[980]: info: CorePlayQueue::getTrack 0 Mar 08 10:22:38 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 08 10:22:38 dorsz-connect volumio[980]: info: CoreCommandRouter::volumioPushState Mar 08 10:22:38 dorsz-connect volumio[980]: info: CoreStateMachine::setRepeat null single undefined Mar 08 10:22:38 dorsz-connect volumio[980]: info: CoreStateMachine::pushState Mar 08 10:22:38 dorsz-connect volumio[980]: info: CorePlayQueue::getTrack 0 Mar 08 10:22:38 dorsz-connect volumio[980]: info: CoreCommandRouter::volumioPushState Mar 08 10:22:38 dorsz-connect volumio[980]: info: CoreStateMachine::setRandom false Mar 08 10:22:38 dorsz-connect volumio[980]: info: CoreStateMachine::pushState Mar 08 10:22:38 dorsz-connect volumio[980]: info: CorePlayQueue::getTrack 0 Mar 08 10:22:38 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 08 10:22:38 dorsz-connect volumio[980]: info: CoreCommandRouter::volumioPushState Mar 08 10:22:38 dorsz-connect volumio[980]: info: Setting Device type: Raspberry PI Mar 08 10:22:38 dorsz-connect volumio[980]: info: Completed loading Core Plugins Mar 08 10:22:38 dorsz-connect volumio[980]: info: Preparing to generate the ALSA configuration file Mar 08 10:22:38 dorsz-connect sudo[1039]: pam_unix(sudo:session): session closed for user root Mar 08 10:22:38 dorsz-connect volumio[980]: verbose: New Socket.io Connection to 192.168.1.139:3000 from 192.168.1.178 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 2 Mar 08 10:22:38 dorsz-connect volumio[980]: Starting albumart workers Mar 08 10:22:38 dorsz-connect volumio[980]: info: CoreCommandRouter::volumioGetState Mar 08 10:22:38 dorsz-connect volumio[980]: info: CorePlayQueue::getTrack 0 Mar 08 10:22:38 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Mar 08 10:22:38 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Mar 08 10:22:38 dorsz-connect volumio[980]: verbose: New Socket.io Connection to 192.168.1.139 from 192.168.1.178 UA: Mozilla/5.0 (Linux; Android 14; SM-S916B Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/133.0.6943.138 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3 Mar 08 10:22:38 dorsz-connect volumio[980]: Starting albumart workers Mar 08 10:22:38 dorsz-connect volumio[980]: info: Discovery: adding 7d8f72f1-cb86-4513-95af-532a463cd092 Mar 08 10:22:38 dorsz-connect volumio[980]: info: Discovery: Found device Dorsz Connect Mar 08 10:22:38 dorsz-connect volumio[980]: info: CoreCommandRouter::volumioGetState Mar 08 10:22:38 dorsz-connect volumio[980]: info: CorePlayQueue::getTrack 0 Mar 08 10:22:38 dorsz-connect volumio[980]: Starting albumart workers Mar 08 10:22:38 dorsz-connect volumio[980]: info: Asound.conf file unchanged, so no further update is needed Mar 08 10:22:38 dorsz-connect volumio[980]: info: Output device has changed, restarting MPD Mar 08 10:22:38 dorsz-connect volumio[980]: info: ___________ START PLUGINS ___________ Mar 08 10:22:38 dorsz-connect volumio[980]: info: ControllerMpd::onStart: Initializing MPD Mar 08 10:22:38 dorsz-connect volumio[980]: info: Creating MPD Configuration file Mar 08 10:22:38 dorsz-connect sudo[1105]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 08 10:22:38 dorsz-connect sudo[1105]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 10:22:38 dorsz-connect sudo[1105]: pam_unix(sudo:session): session closed for user root Mar 08 10:22:38 dorsz-connect sudo[1107]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 08 10:22:38 dorsz-connect sudo[1107]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 10:22:38 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 08 10:22:38 dorsz-connect volumio[980]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 08 10:22:38 dorsz-connect volumio[980]: info: [1741425758991] CoreMusicLibrary::Adding element Media Servers Mar 08 10:22:38 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 08 10:22:39 dorsz-connect sudo[1110]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 08 10:22:39 dorsz-connect sudo[1110]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 10:22:39 dorsz-connect sudo[1110]: pam_unix(sudo:session): session closed for user root Mar 08 10:22:39 dorsz-connect sudo[1112]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 08 10:22:39 dorsz-connect sudo[1112]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 10:22:39 dorsz-connect volumio[980]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 08 10:22:39 dorsz-connect volumio[980]: info: [1741425759061] CoreMusicLibrary::Adding element Last_100 Mar 08 10:22:39 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 08 10:22:39 dorsz-connect systemd[1]: Stopping Music Player Daemon... Mar 08 10:22:39 dorsz-connect volumio[980]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 08 10:22:39 dorsz-connect volumio[980]: info: [1741425759082] CoreMusicLibrary::Adding element Webradio Mar 08 10:22:39 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 08 10:22:39 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 08 10:22:39 dorsz-connect kernel: hwmon hwmon1: Undervoltage detected! Mar 08 10:22:39 dorsz-connect volumio[980]: info: Initializing BBC Radios Mar 08 10:22:39 dorsz-connect systemd[1]: mpd.service: Succeeded. Mar 08 10:22:39 dorsz-connect systemd[1]: Stopped Music Player Daemon. Mar 08 10:22:39 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 08 10:22:39 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 08 10:22:39 dorsz-connect volumio[980]: info: Volumio Calling Home Mar 08 10:22:39 dorsz-connect systemd[1]: Starting Music Player Daemon... Mar 08 10:22:39 dorsz-connect sudo[1127]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 08 10:22:39 dorsz-connect sudo[1127]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 10:22:39 dorsz-connect sudo[1127]: pam_unix(sudo:session): session closed for user root Mar 08 10:22:40 dorsz-connect systemd[1]: systemd-hostnamed.service: Succeeded. Mar 08 10:22:40 dorsz-connect volumio[980]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Mar 08 10:22:40 dorsz-connect volumio[980]: info: CoreStateMachine::getcurrentVolume Mar 08 10:22:40 dorsz-connect volumio[980]: info: CoreCommandRouter::volumioRetrievevolume Mar 08 10:22:40 dorsz-connect volumio[980]: info: Received Get System Info Mar 08 10:22:40 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 08 10:22:40 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 08 10:22:40 dorsz-connect volumio[980]: info: Discovery: Getting this device information Mar 08 10:22:40 dorsz-connect volumio[980]: info: CoreCommandRouter::volumioGetState Mar 08 10:22:40 dorsz-connect volumio[980]: info: CorePlayQueue::getTrack 0 Mar 08 10:22:40 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 08 10:22:40 dorsz-connect volumio[980]: info: CoreCommandRouter::volumioGetState Mar 08 10:22:40 dorsz-connect volumio[980]: info: CorePlayQueue::getTrack 0 Mar 08 10:22:40 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 08 10:22:40 dorsz-connect volumio[980]: info: CoreCommandRouter::volumioGetVisibleSources Mar 08 10:22:40 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 08 10:22:40 dorsz-connect volumio[980]: info: CoreCommandRouter::volumioGetState Mar 08 10:22:40 dorsz-connect volumio[980]: info: CorePlayQueue::getTrack 0 Mar 08 10:22:40 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Mar 08 10:22:40 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Mar 08 10:22:40 dorsz-connect volumio[980]: info: Received Get System Info Mar 08 10:22:40 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 08 10:22:40 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 08 10:22:40 dorsz-connect volumio[980]: info: Discovery: Getting this device information Mar 08 10:22:40 dorsz-connect volumio[980]: info: CoreCommandRouter::volumioGetState Mar 08 10:22:40 dorsz-connect volumio[980]: info: CorePlayQueue::getTrack 0 Mar 08 10:22:40 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 08 10:22:40 dorsz-connect volumio[980]: info: CoreCommandRouter::volumioGetState Mar 08 10:22:40 dorsz-connect volumio[980]: info: CorePlayQueue::getTrack 0 Mar 08 10:22:40 dorsz-connect volumio[980]: info: Listing playlists Mar 08 10:22:40 dorsz-connect volumio[980]: info: CoreCommandRouter::volumioGetQueue Mar 08 10:22:40 dorsz-connect volumio[980]: info: CoreStateMachine::getQueue Mar 08 10:22:40 dorsz-connect volumio[980]: info: CorePlayQueue::getQueue Mar 08 10:22:40 dorsz-connect volumio[980]: info: MPD Permissions set Mar 08 10:22:40 dorsz-connect volumio[980]: info: MPD Permissions set Mar 08 10:22:40 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 08 10:22:40 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 08 10:22:40 dorsz-connect volumio[980]: info: Discovery: Getting this device information Mar 08 10:22:40 dorsz-connect volumio[980]: info: CoreCommandRouter::volumioGetState Mar 08 10:22:40 dorsz-connect volumio[980]: info: CorePlayQueue::getTrack 0 Mar 08 10:22:40 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 08 10:22:40 dorsz-connect volumio[980]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Mar 08 10:22:40 dorsz-connect volumio[980]: info: Volumio called home Mar 08 10:22:40 dorsz-connect volumio[980]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Mar 08 10:22:40 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 10:22:40 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 10:22:40 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 10:22:40 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 10:22:40 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 10:22:40 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 10:22:40 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 10:22:40 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 10:22:40 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 08 10:22:40 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 10:22:40 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 10:22:40 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 10:22:40 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 10:22:40 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 10:22:41 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 10:22:41 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 10:22:41 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 10:22:41 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 10:22:41 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 08 10:22:41 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 10:22:41 dorsz-connect volumio[980]: info: VolumeController:: Volume=undefined Mute =false Mar 08 10:22:41 dorsz-connect volumio[980]: info: CoreStateMachine::pushState Mar 08 10:22:41 dorsz-connect volumio[980]: info: CorePlayQueue::getTrack 0 Mar 08 10:22:41 dorsz-connect volumio[980]: info: CoreCommandRouter::volumioPushState Mar 08 10:22:41 dorsz-connect volumio[980]: info: CoreStateMachine::updateTrackBlock Mar 08 10:22:41 dorsz-connect volumio[980]: info: CorePlayQueue::getTrackBlock Mar 08 10:22:41 dorsz-connect volumio[980]: info: CoreCommandRouter::volumioRetrievevolume Mar 08 10:22:41 dorsz-connect volumio[980]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Mar 08 10:22:41 dorsz-connect volumio[980]: info: VolumeController::SetAlsaVolume0 Mar 08 10:22:41 dorsz-connect volumio[980]: info: CoreStateMachine::pushState Mar 08 10:22:41 dorsz-connect volumio[980]: info: CorePlayQueue::getTrack 0 Mar 08 10:22:41 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 08 10:22:41 dorsz-connect volumio[980]: info: CoreCommandRouter::volumioPushState Mar 08 10:22:41 dorsz-connect volumio[980]: info: CoreCommandRouter::volumioGetState Mar 08 10:22:41 dorsz-connect volumio[980]: info: CorePlayQueue::getTrack 0 Mar 08 10:22:41 dorsz-connect volumio[980]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Mar 08 10:22:41 dorsz-connect volumio[980]: info: VolumeController:: Volume=undefined Mute =false Mar 08 10:22:41 dorsz-connect volumio[980]: info: CoreStateMachine::pushState Mar 08 10:22:41 dorsz-connect volumio[980]: info: CorePlayQueue::getTrack 0 Mar 08 10:22:41 dorsz-connect volumio[980]: info: CoreCommandRouter::volumioPushState Mar 08 10:22:41 dorsz-connect mpd[1132]: Mar 08 10:22 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Mar 08 10:22:41 dorsz-connect systemd[1]: Started Music Player Daemon. Mar 08 10:22:41 dorsz-connect sudo[1107]: pam_unix(sudo:session): session closed for user root Mar 08 10:22:41 dorsz-connect sudo[1112]: pam_unix(sudo:session): session closed for user root Mar 08 10:22:41 dorsz-connect volumio[980]: info: Completed starting Core Plugins Mar 08 10:22:41 dorsz-connect volumio[980]: info: ------------------------------------------- Mar 08 10:22:41 dorsz-connect volumio[980]: info: ----- MyVolumio plugins startup ---- Mar 08 10:22:41 dorsz-connect volumio[980]: info: ------------------------------------------- Mar 08 10:22:41 dorsz-connect volumio[980]: info: [MyVolumio PluginManager] Fetching plans data.... Mar 08 10:22:41 dorsz-connect volumio[980]: error: MPD error: The expression evaluated to a falsy value: Mar 08 10:22:41 dorsz-connect volumio[980]: assert.ok(self.idling) Mar 08 10:22:41 dorsz-connect volumio[980]: error: The expression evaluated to a falsy value: Mar 08 10:22:41 dorsz-connect volumio[980]: assert.ok(self.idling) Mar 08 10:22:41 dorsz-connect volumio[980]: info: MPD running with PID1132 Mar 08 10:22:41 dorsz-connect volumio[980]: ,establishing connection Mar 08 10:22:41 dorsz-connect volumio[980]: error: updateQueue error: null Mar 08 10:22:41 dorsz-connect volumio[980]: error: updateQueue error: null Mar 08 10:22:43 dorsz-connect kernel: hwmon hwmon1: Voltage normalised Mar 08 10:22:45 dorsz-connect sudo[1192]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 08 10:22:45 dorsz-connect sudo[1192]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 10:22:45 dorsz-connect sudo[1192]: pam_unix(sudo:session): session closed for user root Mar 08 10:22:45 dorsz-connect sudo[1194]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 08 10:22:45 dorsz-connect sudo[1194]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 10:22:45 dorsz-connect sudo[1194]: pam_unix(sudo:session): session closed for user root Mar 08 10:22:45 dorsz-connect sudo[1198]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Mar 08 10:22:45 dorsz-connect sudo[1198]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 10:22:45 dorsz-connect systemd[1]: Started UPnP Renderer front-end to MPD. Mar 08 10:22:45 dorsz-connect sudo[1198]: pam_unix(sudo:session): session closed for user root Mar 08 10:22:45 dorsz-connect volumio[980]: info: Upmpdcli Daemon Started Mar 08 10:22:45 dorsz-connect volumio[1200]: Generating RSA private key, 4096 bit long modulus (2 primes) Mar 08 10:22:45 dorsz-connect volumio-remote-updater[596]: [2025-03-08 10:22:45] [connect] Successful connection Mar 08 10:22:45 dorsz-connect volumio-remote-updater[596]: [2025-03-08 10:22:45] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1741425765 101 Mar 08 10:22:45 dorsz-connect volumio[980]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 5 Mar 08 10:22:46 dorsz-connect volumio[980]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Mar 08 10:22:50 dorsz-connect volumio[980]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Mar 08 10:22:50 dorsz-connect volumio[980]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Mar 08 10:22:50 dorsz-connect volumio[980]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Mar 08 10:22:50 dorsz-connect volumio[980]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Mar 08 10:22:50 dorsz-connect volumio[980]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Mar 08 10:22:50 dorsz-connect volumio[980]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Mar 08 10:22:50 dorsz-connect volumio[980]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Mar 08 10:22:50 dorsz-connect volumio[980]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Mar 08 10:22:50 dorsz-connect volumio[980]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Mar 08 10:22:50 dorsz-connect volumio[980]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Mar 08 10:22:50 dorsz-connect volumio[980]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Mar 08 10:22:50 dorsz-connect volumio[980]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Mar 08 10:22:50 dorsz-connect volumio[980]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Mar 08 10:22:50 dorsz-connect volumio[980]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Mar 08 10:22:50 dorsz-connect volumio[980]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Mar 08 10:22:50 dorsz-connect volumio[980]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Mar 08 10:22:50 dorsz-connect volumio[980]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Mar 08 10:22:50 dorsz-connect volumio[980]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Mar 08 10:22:50 dorsz-connect volumio[980]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Mar 08 10:22:50 dorsz-connect volumio[980]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Mar 08 10:22:50 dorsz-connect volumio[980]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Mar 08 10:22:50 dorsz-connect volumio[980]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Mar 08 10:22:50 dorsz-connect volumio[980]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Mar 08 10:22:50 dorsz-connect volumio[980]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Mar 08 10:22:50 dorsz-connect volumio[980]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Mar 08 10:22:50 dorsz-connect volumio[980]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Mar 08 10:22:50 dorsz-connect volumio[980]: info: Adding plugin bluetooth to MyMusic Plugins Mar 08 10:22:50 dorsz-connect volumio[980]: info: Adding plugin multiroom to MyMusic Plugins Mar 08 10:22:50 dorsz-connect volumio[980]: info: Adding plugin metavolumio to MyMusic Plugins Mar 08 10:22:50 dorsz-connect volumio[980]: info: Adding plugin cd_controller to MyMusic Plugins Mar 08 10:22:50 dorsz-connect volumio[980]: info: Adding plugin smart_inputs to MyMusic Plugins Mar 08 10:22:50 dorsz-connect volumio[980]: info: Adding plugin tidalconnect to MyMusic Plugins Mar 08 10:22:50 dorsz-connect volumio[980]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Mar 08 10:22:50 dorsz-connect volumio[1200]: ............................................++++ Mar 08 10:22:51 dorsz-connect volumio[980]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Mar 08 10:22:51 dorsz-connect volumio[980]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Mar 08 10:22:51 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 08 10:22:51 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 08 10:22:51 dorsz-connect volumio[980]: info: Starting MyVolumio Remote Streaming Endpoints Mar 08 10:22:51 dorsz-connect volumio[980]: info: MyVolumio login type: Token Mar 08 10:22:51 dorsz-connect volumio[980]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Mar 08 10:22:51 dorsz-connect volumio[980]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Mar 08 10:22:52 dorsz-connect volumio[980]: info: Starting Streaming Service Transparent Proxy Mar 08 10:22:52 dorsz-connect volumio[980]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Mar 08 10:22:52 dorsz-connect volumio[980]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Mar 08 10:22:52 dorsz-connect volumio[980]: info: Streaming services startup Mar 08 10:22:52 dorsz-connect volumio[980]: info: Starting Streaming Daemon Mar 08 10:22:53 dorsz-connect sudo[1223]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Mar 08 10:22:53 dorsz-connect sudo[1223]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 10:22:53 dorsz-connect volumio[980]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Mar 08 10:22:53 dorsz-connect sudo[1223]: pam_unix(sudo:session): session closed for user root Mar 08 10:22:53 dorsz-connect volumio[980]: error: Cannot start Volumio Streaming Daemon Mar 08 10:22:53 dorsz-connect volumio[980]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Mar 08 10:22:53 dorsz-connect volumio[980]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Mar 08 10:22:53 dorsz-connect kernel: hwmon hwmon1: Undervoltage detected! Mar 08 10:22:53 dorsz-connect volumio[980]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Mar 08 10:22:54 dorsz-connect volumio[980]: info: MyVolumio token set successfully Mar 08 10:22:54 dorsz-connect volumio[980]: info: MYVOLUMIO: Adding device Mar 08 10:22:54 dorsz-connect volumio[980]: info: MYVOLUMIO: Evaluating Server Mar 08 10:22:54 dorsz-connect volumio[980]: STREAMING PROXY: Starting server on port 3245 Mar 08 10:22:54 dorsz-connect volumio[980]: Node JS runtime: 14 Mar 08 10:22:54 dorsz-connect volumio[980]: info: MyVolumio Plan changed: premium Mar 08 10:22:54 dorsz-connect volumio[980]: info: [MyVolumio PluginManager] Subscribed plan changed to premium Mar 08 10:22:54 dorsz-connect volumio[980]: info: Removing browser output: myVolumio user plan is not superstar Mar 08 10:22:54 dorsz-connect volumio[980]: info: Removing audio output: Mar 08 10:22:54 dorsz-connect volumio[980]: info: MYVOLUMIO: Adding device Mar 08 10:22:54 dorsz-connect volumio[980]: info: MYVOLUMIO: Evaluating Server Mar 08 10:22:54 dorsz-connect volumio[980]: info: Remote config written successfully Mar 08 10:22:54 dorsz-connect volumio[980]: info: Starting Tunnel 1 Mar 08 10:22:54 dorsz-connect volumio[980]: info: Starting Tunnel Connection Checker Mar 08 10:22:54 dorsz-connect volumio[980]: info: Completed starting MyVolumio Plugin Mar 08 10:22:55 dorsz-connect volumio[980]: info: MYVolumio Device enabled Mar 08 10:22:55 dorsz-connect volumio[980]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins... Mar 08 10:22:55 dorsz-connect volumio[980]: info: MyVolumio status changed Mar 08 10:22:55 dorsz-connect volumio[980]: info: Streaming services startup Mar 08 10:22:55 dorsz-connect volumio[980]: info: Starting Streaming Daemon Mar 08 10:22:55 dorsz-connect sudo[1281]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Mar 08 10:22:55 dorsz-connect volumio[980]: info: Setting Geolocation for MyVolumio to eu4 Mar 08 10:22:55 dorsz-connect sudo[1281]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 10:22:55 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 08 10:22:55 dorsz-connect sudo[1281]: pam_unix(sudo:session): session closed for user root Mar 08 10:22:55 dorsz-connect volumio[980]: error: Cannot start Volumio Streaming Daemon Mar 08 10:22:55 dorsz-connect volumio[980]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Mar 08 10:22:55 dorsz-connect volumio[980]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Mar 08 10:22:55 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid Mar 08 10:22:55 dorsz-connect volumio[980]: info: [MyVolumio PluginManager] Loading plugin "bluetooth"... Mar 08 10:22:56 dorsz-connect volumio[980]: info: [1741425776120] Starting BluetoothController Mar 08 10:22:56 dorsz-connect volumio[980]: info: [MyVolumio PluginManager] Loading plugin "multiroom"... Mar 08 10:22:58 dorsz-connect volumio[980]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin multiroom Mar 08 10:22:58 dorsz-connect sudo[1284]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom Mar 08 10:22:58 dorsz-connect sudo[1284]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 10:22:58 dorsz-connect sudo[1284]: pam_unix(sudo:session): session closed for user root Mar 08 10:22:58 dorsz-connect volumio[980]: info: MRS: MultiRoom plugin initialized Mar 08 10:22:58 dorsz-connect volumio[980]: info: MRS: STOPPING SNAPCLIENT Mar 08 10:22:58 dorsz-connect volumio[980]: info: MRS: Snap server stop Mar 08 10:22:58 dorsz-connect sudo[1300]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient Mar 08 10:22:58 dorsz-connect volumio[980]: info: MRS: STOPPING volumioStreaming Mar 08 10:22:58 dorsz-connect sudo[1300]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 10:22:58 dorsz-connect sudo[1302]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver Mar 08 10:22:58 dorsz-connect sudo[1302]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 10:22:58 dorsz-connect sudo[1305]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming Mar 08 10:22:58 dorsz-connect volumio[980]: info: [MyVolumio PluginManager] Loading plugin "metavolumio"... Mar 08 10:22:58 dorsz-connect sudo[1305]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 10:22:58 dorsz-connect sudo[1300]: pam_unix(sudo:session): session closed for user root Mar 08 10:22:58 dorsz-connect sudo[1308]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Mar 08 10:22:58 dorsz-connect sudo[1308]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 10:22:58 dorsz-connect sudo[1308]: pam_unix(sudo:session): session closed for user root Mar 08 10:22:58 dorsz-connect sudo[1305]: pam_unix(sudo:session): session closed for user root Mar 08 10:22:58 dorsz-connect sudo[1302]: pam_unix(sudo:session): session closed for user root Mar 08 10:22:58 dorsz-connect volumio[980]: info: [MyVolumio PluginManager] Loading plugin "manifestui"... Mar 08 10:22:58 dorsz-connect volumio[980]: info: [MyVolumio PluginManager] Loading plugin "cd_controller"... Mar 08 10:22:58 dorsz-connect volumio[980]: info: [MyVolumio PluginManager] Loading plugin "smart_inputs"... Mar 08 10:22:58 dorsz-connect volumio[980]: info: [MyVolumio PluginManager] Loading plugin "hi_res_audio"... Mar 08 10:22:58 dorsz-connect volumio[980]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin hi_res_audio Mar 08 10:22:58 dorsz-connect volumio[980]: info: [MyVolumio PluginManager] Loading plugin "tidal"... Mar 08 10:22:58 dorsz-connect volumio[980]: info: [MyVolumio PluginManager] Loading plugin "qobuz"... Mar 08 10:22:58 dorsz-connect volumio[980]: info: [MyVolumio PluginManager] Loading plugin "tidalconnect"... Mar 08 10:22:58 dorsz-connect volumio[980]: info: Preparing to generate the ALSA configuration file Mar 08 10:22:58 dorsz-connect volumio[980]: info: Updating MyVolumio device info Mar 08 10:22:58 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 08 10:22:58 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 08 10:22:58 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 08 10:22:58 dorsz-connect volumio[980]: info: Setting Geolocation for MyVolumio to eu4 Mar 08 10:22:58 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 08 10:22:58 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 08 10:22:58 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 08 10:22:58 dorsz-connect volumio[980]: info: MRS: Removed streaming files Mar 08 10:22:58 dorsz-connect volumio[980]: info: MRS: volumioStreaming STOPPED Mar 08 10:22:58 dorsz-connect volumio[980]: info: MRS: SNAPSERVER STOPPED Mar 08 10:22:58 dorsz-connect volumio[980]: info: MRS: SNAPCLIENT STOPPED Mar 08 10:22:58 dorsz-connect volumio[980]: info: Asound.conf file unchanged, so no further update is needed Mar 08 10:22:58 dorsz-connect volumio[980]: info: Output device has changed, restarting MPD Mar 08 10:22:58 dorsz-connect sudo[1312]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 08 10:22:58 dorsz-connect volumio[980]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Mar 08 10:22:58 dorsz-connect sudo[1312]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 10:22:58 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 10:22:58 dorsz-connect sudo[1312]: pam_unix(sudo:session): session closed for user root Mar 08 10:22:58 dorsz-connect sudo[1314]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 08 10:22:58 dorsz-connect sudo[1314]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 10:22:58 dorsz-connect volumio[980]: info: [MyVolumio PluginManager] Starting plugin audio_interface.bluetooth Mar 08 10:22:58 dorsz-connect volumio[980]: info: [MyVolumio PluginManager] Plugin bluetooth disabled by user. Not starting Mar 08 10:22:58 dorsz-connect volumio[980]: info: [MyVolumio PluginManager] Starting plugin audio_interface.multiroom Mar 08 10:22:58 dorsz-connect volumio[980]: info: [MyVolumio PluginManager] Plugin multiroom disabled by user. Not starting Mar 08 10:22:58 dorsz-connect volumio[980]: info: [MyVolumio PluginManager] Starting plugin miscellanea.metavolumio Mar 08 10:22:58 dorsz-connect volumio[980]: info: Adding METAVOLUMIO REST API Endpoints Mar 08 10:22:58 dorsz-connect volumio[980]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Mar 08 10:22:58 dorsz-connect volumio[980]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio Mar 08 10:22:58 dorsz-connect volumio[980]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio Mar 08 10:22:58 dorsz-connect volumio[980]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio Mar 08 10:22:58 dorsz-connect volumio[980]: info: [MyVolumio PluginManager] Starting plugin miscellanea.manifestui Mar 08 10:22:58 dorsz-connect volumio[980]: info: [MyVolumio PluginManager] Starting plugin music_service.cd_controller Mar 08 10:22:58 dorsz-connect volumio[980]: info: [MyVolumio PluginManager] Plugin cd_controller disabled by user. Not starting Mar 08 10:22:58 dorsz-connect volumio[980]: info: [MyVolumio PluginManager] Starting plugin music_service.smart_inputs Mar 08 10:22:58 dorsz-connect volumio[980]: info: Adding inputs REST Endpoints Mar 08 10:22:58 dorsz-connect volumio[980]: info: Adding scanAudioInputs REST Endpoint for plugin: music_service/smart_inputs Mar 08 10:22:58 dorsz-connect volumio[980]: info: Scanning Audio Inputs Mar 08 10:22:58 dorsz-connect systemd[1]: Stopping Music Player Daemon... Mar 08 10:22:58 dorsz-connect systemd[1]: mpd.service: Succeeded. Mar 08 10:22:58 dorsz-connect systemd[1]: Stopped Music Player Daemon. Mar 08 10:22:58 dorsz-connect volumio[980]: info: Checking against Known Cards name Mar 08 10:22:58 dorsz-connect volumio[980]: info: Adding Server instance for streaming Mar 08 10:22:58 dorsz-connect volumio[980]: info: [MyVolumio PluginManager] Starting plugin music_service.hi_res_audio Mar 08 10:22:58 dorsz-connect volumio[980]: error: Hi Res Audio Failed Login: Missing Login Data Mar 08 10:22:58 dorsz-connect volumio[980]: info: Adding HIGHRESAUDIO REST API Endpoints Mar 08 10:22:58 dorsz-connect volumio[980]: info: Adding getStreamUrlhi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Mar 08 10:22:58 dorsz-connect volumio[980]: info: [MyVolumio PluginManager] Starting plugin music_service.tidal Mar 08 10:22:58 dorsz-connect volumio[980]: info: Refreshing TIDAL token Mar 08 10:22:58 dorsz-connect volumio[980]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuz Mar 08 10:22:58 dorsz-connect volumio[980]: info: [MyVolumio PluginManager] Starting plugin music_service.tidalconnect Mar 08 10:22:58 dorsz-connect systemd[1]: Starting Music Player Daemon... Mar 08 10:22:58 dorsz-connect volumio[980]: info: Stopping AccessToken refresher cron for QOBUZ Mar 08 10:22:58 dorsz-connect sudo[1323]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Mar 08 10:22:58 dorsz-connect sudo[1323]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 10:22:58 dorsz-connect sudo[1323]: pam_unix(sudo:session): session closed for user root Mar 08 10:22:58 dorsz-connect volumio[980]: info: AccessToken refresher cron started for QOBUZ Mar 08 10:22:58 dorsz-connect volumio[980]: info: Adding QOBUZ REST API Endpoints Mar 08 10:22:58 dorsz-connect volumio[980]: info: Adding getStreamUrlqobuz REST Endpoint for plugin: music_service/qobuz Mar 08 10:22:59 dorsz-connect volumio[980]: info: Successfully Added MyVolumio device Mar 08 10:22:59 dorsz-connect volumio[980]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined Mar 08 10:22:59 dorsz-connect volumio[980]: info: MPD Permissions set Mar 08 10:22:59 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 10:22:59 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 10:22:59 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 10:22:59 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 10:22:59 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 10:22:59 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 10:22:59 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 10:22:59 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 10:22:59 dorsz-connect sudo[1321]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 08 10:22:59 dorsz-connect sudo[1321]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 10:22:59 dorsz-connect systemd[1]: systemd-timedated.service: Succeeded. Mar 08 10:22:59 dorsz-connect sudo[1321]: pam_unix(sudo:session): session closed for user root Mar 08 10:22:59 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 08 10:22:59 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 10:22:59 dorsz-connect volumio[980]: info: Successfully Updated MyVolumio device Mar 08 10:22:59 dorsz-connect volumio[980]: info: Access Token successfully retrieved Mar 08 10:22:59 dorsz-connect volumio[980]: info: Updating MyVolumio device info Mar 08 10:22:59 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 08 10:22:59 dorsz-connect volumio[1200]: ..........................................................++++ Mar 08 10:22:59 dorsz-connect volumio[1200]: e is 65537 (0x010001) Mar 08 10:22:59 dorsz-connect volumio[1200]: writing RSA key Mar 08 10:22:59 dorsz-connect volumio[980]: info: Successfully Added MyVolumio device Mar 08 10:22:59 dorsz-connect volumio[980]: info: Successfully retrieved User Session From TIDAL Mar 08 10:22:59 dorsz-connect kernel: hwmon hwmon1: Voltage normalised Mar 08 10:23:00 dorsz-connect volumio[980]: info: Successfully Updated MyVolumio device Mar 08 10:23:00 dorsz-connect sudo[1357]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service Mar 08 10:23:00 dorsz-connect sudo[1357]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 10:23:00 dorsz-connect systemd[1]: Started MyVolumio SSH Tunnel. Mar 08 10:23:00 dorsz-connect sudo[1357]: pam_unix(sudo:session): session closed for user root Mar 08 10:23:00 dorsz-connect volumio[980]: info: Successfully retrieved User Subscription From TIDAL Mar 08 10:23:00 dorsz-connect volumio[980]: info: Adding TIDAL to Browse Sources Mar 08 10:23:00 dorsz-connect volumio[980]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 08 10:23:00 dorsz-connect volumio[980]: info: [1741425780167] CoreMusicLibrary::Adding element TIDAL Mar 08 10:23:00 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 08 10:23:00 dorsz-connect volumio[980]: Cannot find translation for source TIDAL Mar 08 10:23:00 dorsz-connect volumio[980]: info: Stopping AccessToken refresher cron Mar 08 10:23:00 dorsz-connect autossh[1360]: port set to 0, monitoring disabled Mar 08 10:23:00 dorsz-connect autossh[1360]: starting ssh (count 1) Mar 08 10:23:00 dorsz-connect autossh[1360]: ssh child pid is 1363 Mar 08 10:23:00 dorsz-connect volumio[980]: info: AccessToken refresher cron started Mar 08 10:23:00 dorsz-connect volumio[980]: info: Adding TIDAL REST API Endpoints Mar 08 10:23:00 dorsz-connect volumio[980]: info: Adding getStreamUrltidal REST Endpoint for plugin: music_service/tidal Mar 08 10:23:00 dorsz-connect volumio[980]: info: Remote SSH Started Mar 08 10:23:00 dorsz-connect volumio[980]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Mar 08 10:23:00 dorsz-connect volumio[980]: info: CoreCommandRouter::volumioGetState Mar 08 10:23:00 dorsz-connect volumio[980]: info: CorePlayQueue::getTrack 0 Mar 08 10:23:00 dorsz-connect mpd[1330]: Mar 08 10:23 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Mar 08 10:23:00 dorsz-connect systemd[1]: Started Music Player Daemon. Mar 08 10:23:00 dorsz-connect sudo[1314]: pam_unix(sudo:session): session closed for user root Mar 08 10:23:00 dorsz-connect volumio[980]: error: updateQueue error: null Mar 08 10:23:01 dorsz-connect volumio[980]: info: TidalConnect service stoped! Mar 08 10:23:02 dorsz-connect volumio[980]: info: Adding tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Mar 08 10:23:02 dorsz-connect volumio[980]: info: Adding tc_connect REST Endpoint for plugin: music_service/tidalconnect Mar 08 10:23:02 dorsz-connect sudo[1375]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Mar 08 10:23:02 dorsz-connect sudo[1375]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 10:23:02 dorsz-connect systemd[1]: Started Volumio Tidal Connect Service. Mar 08 10:23:02 dorsz-connect sudo[1375]: pam_unix(sudo:session): session closed for user root Mar 08 10:23:02 dorsz-connect volumio[980]: info: Executing endpoint tc_getconfig Mar 08 10:23:02 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Mar 08 10:23:02 dorsz-connect vtcs[1377]: STARTING TidalConnect services, version: 1.4.0.34 Mar 08 10:23:02 dorsz-connect vtcs[1377]: STARTED TidalConnect services. Mar 08 10:23:02 dorsz-connect volumio[980]: info: Executing endpoint tc_connect Mar 08 10:23:02 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Mar 08 10:23:02 dorsz-connect volumio[980]: info: Connecting to TidalConnect Mar 08 10:23:02 dorsz-connect volumio[980]: info: CoreCommandRouter::servicePushState Mar 08 10:23:02 dorsz-connect volumio[980]: info: CoreStateMachine::pushState Mar 08 10:23:02 dorsz-connect volumio[980]: info: CorePlayQueue::getTrack 0 Mar 08 10:23:02 dorsz-connect volumio[980]: info: CoreCommandRouter::volumioPushState Mar 08 10:23:02 dorsz-connect volumio[980]: info: CorePlayQueue::getTrack 0 Mar 08 10:23:02 dorsz-connect volumio[980]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received tidalconnect Mar 08 10:23:02 dorsz-connect volumio[980]: info: CoreCommandRouter::servicePushState Mar 08 10:23:02 dorsz-connect volumio[980]: info: CoreStateMachine::pushState Mar 08 10:23:02 dorsz-connect volumio[980]: info: CorePlayQueue::getTrack 0 Mar 08 10:23:02 dorsz-connect volumio[980]: info: CoreCommandRouter::volumioPushState Mar 08 10:23:02 dorsz-connect volumio[980]: info: CorePlayQueue::getTrack 0 Mar 08 10:23:02 dorsz-connect volumio[980]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received tidalconnect Mar 08 10:23:04 dorsz-connect volumio[980]: info: CoreCommandRouter::volumioPlay Mar 08 10:23:04 dorsz-connect volumio[980]: info: CoreStateMachine::play index undefined Mar 08 10:23:04 dorsz-connect volumio[980]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 08 10:23:04 dorsz-connect volumio[980]: info: CorePlayQueue::getTrack 0 Mar 08 10:23:04 dorsz-connect volumio[980]: info: CoreStateMachine::startPlaybackTimer Mar 08 10:23:04 dorsz-connect volumio[980]: info: CorePlayQueue::getTrack 0 Mar 08 10:23:04 dorsz-connect volumio[980]: info: CoreCommandRouter::volumioGetVisibleSources Mar 08 10:23:04 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 08 10:23:04 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Mar 08 10:23:04 dorsz-connect volumio[980]: info: [1741425784424] ControllerWebradio::clearAddPlayTrack Mar 08 10:23:04 dorsz-connect volumio[980]: verbose: ControllerMpd::sendMpdCommand stop Mar 08 10:23:04 dorsz-connect volumio[980]: info: sendMpdCommand stop took 2 milliseconds Mar 08 10:23:04 dorsz-connect volumio[980]: verbose: ControllerMpd::sendMpdCommand clear Mar 08 10:23:04 dorsz-connect volumio[980]: info: Mar 08 10:23:04 dorsz-connect volumio[980]: ---------------------------- MPD announces system playlist update Mar 08 10:23:04 dorsz-connect volumio[980]: info: Ignoring MPD Status Update Mar 08 10:23:04 dorsz-connect volumio[980]: info: sendMpdCommand clear took 3 milliseconds Mar 08 10:23:04 dorsz-connect volumio[980]: verbose: ControllerMpd::sendMpdCommand load "https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3" Mar 08 10:23:04 dorsz-connect volumio[980]: error: updateQueue error: null Mar 08 10:23:04 dorsz-connect volumio[980]: info: ------------------------------ 6ms Mar 08 10:23:05 dorsz-connect volumio[980]: info: TidalConnect service started! Mar 08 10:23:05 dorsz-connect volumio[980]: [Metrics] CommandRouter: 33s 424.97ms Mar 08 10:23:05 dorsz-connect volumio[980]: info: CoreCommandRouter::volumiosetStartupVolume Mar 08 10:23:05 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 10:23:05 dorsz-connect volumio[980]: info: VolumeController:: Setting startup Volume 100 Mar 08 10:23:05 dorsz-connect volumio[980]: info: VolumeController::SetAlsaVolume100 Mar 08 10:23:05 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 08 10:23:05 dorsz-connect volumio[980]: info: CoreCommandRouter::Close All Modals sent Mar 08 10:23:05 dorsz-connect volumio[980]: info: CoreCommandRouter::Close All Modals sent Mar 08 10:23:05 dorsz-connect volumio[980]: info: CoreStateMachine::pushState Mar 08 10:23:05 dorsz-connect volumio[980]: info: CorePlayQueue::getTrack 0 Mar 08 10:23:05 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 08 10:23:05 dorsz-connect volumio[980]: info: CoreCommandRouter::volumioPushState Mar 08 10:23:05 dorsz-connect volumio[980]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Mar 08 10:23:05 dorsz-connect volumio[980]: info: Cannot play startup sound: Error: Command failed: /usr/bin/aplay -D volumio /volumio/app/startup.wav Mar 08 10:23:05 dorsz-connect volumio[980]: ALSA lib pcm_hw.c:1822:(_snd_pcm_hw_open) Invalid value for card Mar 08 10:23:05 dorsz-connect volumio[980]: aplay: main:828: audio open error: No such device Mar 08 10:23:06 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Mar 08 10:23:06 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 08 10:23:06 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Mar 08 10:23:06 dorsz-connect volumio[980]: verbose: ControllerMpd::sendMpdCommand add "https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3" Mar 08 10:23:06 dorsz-connect volumio[980]: info: Mar 08 10:23:06 dorsz-connect volumio[980]: ---------------------------- MPD announces system playlist update Mar 08 10:23:06 dorsz-connect volumio[980]: info: Ignoring MPD Status Update Mar 08 10:23:06 dorsz-connect volumio[980]: info: sendMpdCommand add "https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3" took 2 milliseconds Mar 08 10:23:06 dorsz-connect volumio[980]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 08 10:23:06 dorsz-connect volumio[980]: verbose: ControllerMpd::sendMpdCommand play Mar 08 10:23:06 dorsz-connect volumio[980]: info: ------------------------------ 6ms Mar 08 10:23:06 dorsz-connect volumio[980]: info: sendMpdCommand play took 4 milliseconds Mar 08 10:23:06 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 08 10:23:06 dorsz-connect volumio[980]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Mar 08 10:23:06 dorsz-connect volumio[980]: info: CoreCommandRouter::volumioGetState Mar 08 10:23:06 dorsz-connect volumio[980]: info: Mar 08 10:23:06 dorsz-connect volumio[980]: ---------------------------- MPD announces state update: player Mar 08 10:23:06 dorsz-connect volumio[980]: info: ControllerMpd::getState Mar 08 10:23:06 dorsz-connect volumio[980]: verbose: ControllerMpd::sendMpdCommand status Mar 08 10:23:07 dorsz-connect volumio[980]: info: Mar 08 10:23:07 dorsz-connect volumio[980]: ---------------------------- MPD announces state update: player Mar 08 10:23:07 dorsz-connect volumio[980]: verbose: ControllerMpd::sendMpdCommand clearerror Mar 08 10:23:07 dorsz-connect volumio[980]: info: sendMpdCommand status took 29 milliseconds Mar 08 10:23:07 dorsz-connect volumio[980]: info: ControllerMpd::getState Mar 08 10:23:07 dorsz-connect volumio[980]: verbose: ControllerMpd::sendMpdCommand status Mar 08 10:23:07 dorsz-connect volumio[980]: verbose: ControllerMpd::parseState Mar 08 10:23:07 dorsz-connect volumio[980]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 10:23:07 dorsz-connect volumio[980]: info: sendMpdCommand clearerror took 9 milliseconds Mar 08 10:23:07 dorsz-connect volumio[980]: info: sendMpdCommand status took 11 milliseconds Mar 08 10:23:07 dorsz-connect volumio[980]: info: sendMpdCommand playlistinfo took 9 milliseconds Mar 08 10:23:07 dorsz-connect volumio[980]: verbose: ControllerMpd::parseState Mar 08 10:23:07 dorsz-connect volumio[980]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 10:23:07 dorsz-connect volumio[980]: verbose: ControllerMpd::parseTrackInfo Mar 08 10:23:07 dorsz-connect volumio[980]: info: ControllerMpd::pushState Mar 08 10:23:07 dorsz-connect volumio[980]: info: CoreCommandRouter::servicePushState Mar 08 10:23:07 dorsz-connect volumio[980]: info: CorePlayQueue::getTrack 0 Mar 08 10:23:07 dorsz-connect volumio[980]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"mp3","artist":null,"album":null,"uri":"https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3","trackType":""} Mar 08 10:23:07 dorsz-connect volumio[980]: verbose: CURRENT POSITION 0 Mar 08 10:23:07 dorsz-connect volumio[980]: info: CoreStateMachine::syncState stateService pause Mar 08 10:23:07 dorsz-connect volumio[980]: info: CoreStateMachine::syncState currentStatus stop Mar 08 10:23:07 dorsz-connect volumio[980]: info: CoreStateMachine::pushState Mar 08 10:23:07 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 08 10:23:07 dorsz-connect volumio[980]: info: CoreCommandRouter::volumioPushState Mar 08 10:23:07 dorsz-connect volumio[980]: info: ------------------------------ 79ms Mar 08 10:23:07 dorsz-connect volumio[980]: info: sendMpdCommand playlistinfo took 33 milliseconds Mar 08 10:23:07 dorsz-connect volumio[980]: verbose: ControllerMpd::parseTrackInfo Mar 08 10:23:07 dorsz-connect volumio[980]: info: ControllerMpd::pushState Mar 08 10:23:07 dorsz-connect volumio[980]: info: CoreCommandRouter::servicePushState Mar 08 10:23:07 dorsz-connect volumio[980]: info: CorePlayQueue::getTrack 0 Mar 08 10:23:07 dorsz-connect volumio[980]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"mp3","artist":null,"album":null,"uri":"https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3","trackType":""} Mar 08 10:23:07 dorsz-connect volumio[980]: verbose: CURRENT POSITION 0 Mar 08 10:23:07 dorsz-connect volumio[980]: info: CoreStateMachine::syncState stateService pause Mar 08 10:23:07 dorsz-connect volumio[980]: info: CoreStateMachine::syncState currentStatus stop Mar 08 10:23:07 dorsz-connect volumio[980]: info: CoreStateMachine::pushState Mar 08 10:23:07 dorsz-connect volumio[980]: info: CoreCommandRouter::volumioPushState Mar 08 10:23:07 dorsz-connect volumio[980]: info: ------------------------------ 91ms Mar 08 10:23:07 dorsz-connect volumio[980]: error: Cannot update RT Device info: Error: Reference.set failed: First argument contains undefined in property 'user_devices.Li2NoLGw9hXhWycWU5VURVea9Mn1.eb46e3190c7f0b6e8a6fc735d674cb13.state.status' Mar 08 10:23:07 dorsz-connect volumiologrotate[600]: ls: cannot access '/var/log/samba/log.wb-DORSZ': No such file or directory Mar 08 10:23:07 dorsz-connect volumiologrotate[600]: ls: cannot access 'CONNECT': No such file or directory Mar 08 10:23:09 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 08 10:23:09 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 08 10:23:09 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 08 10:23:09 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Mar 08 10:23:09 dorsz-connect volumio-remote-updater[596]: No test mode Mar 08 10:23:09 dorsz-connect volumio-remote-updater[596]: No alpha test mode Mar 08 10:23:09 dorsz-connect volumio[980]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Mar 08 10:23:09 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Mar 08 10:23:09 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 08 10:23:09 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 08 10:23:09 dorsz-connect volumio[980]: info: Discovery: Getting this device information Mar 08 10:23:09 dorsz-connect volumio[980]: info: CoreCommandRouter::volumioGetState Mar 08 10:23:09 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 08 10:23:11 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 10:23:11 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 08 10:23:11 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Mar 08 10:23:11 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Mar 08 10:23:11 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Mar 08 10:23:11 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Mar 08 10:23:11 dorsz-connect volumio[980]: info: CoreCommandRouter::volumioGetBrowseSources Mar 08 10:23:11 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 08 10:23:12 dorsz-connect volumio[980]: info: BOOT COMPLETED Mar 08 10:23:15 dorsz-connect ntpd[730]: Soliciting pool server 195.46.37.22 Mar 08 10:23:16 dorsz-connect ntpd[730]: Soliciting pool server 213.135.57.60 Mar 08 10:23:16 dorsz-connect ntpd[730]: Soliciting pool server 162.159.200.123 Mar 08 10:23:17 dorsz-connect ntpd[730]: Soliciting pool server 109.206.205.233 Mar 08 10:23:17 dorsz-connect ntpd[730]: Soliciting pool server 46.171.0.154 Mar 08 10:23:17 dorsz-connect ntpd[730]: Soliciting pool server 193.219.28.60 Mar 08 10:23:17 dorsz-connect ntpd[730]: Soliciting pool server 212.127.78.21 Mar 08 10:23:18 dorsz-connect ntpd[730]: Soliciting pool server 178.215.228.24 Mar 08 10:23:18 dorsz-connect ntpd[730]: Soliciting pool server 91.212.242.20 Mar 08 10:23:18 dorsz-connect ntpd[730]: Soliciting pool server 91.227.212.78 Mar 08 10:23:18 dorsz-connect ntpd[730]: Soliciting pool server 89.161.47.131 Mar 08 10:23:19 dorsz-connect ntpd[730]: Soliciting pool server 89.250.197.242 Mar 08 10:23:19 dorsz-connect ntpd[730]: Soliciting pool server 46.175.224.7 Mar 08 10:23:19 dorsz-connect ntpd[730]: Soliciting pool server 89.161.47.136 Mar 08 10:23:19 dorsz-connect ntpd[730]: Soliciting pool server 212.127.95.218 Mar 08 10:23:20 dorsz-connect ntpd[730]: Soliciting pool server 51.68.141.5 Mar 08 10:23:20 dorsz-connect ntpd[730]: Soliciting pool server 2001:678:8::123 Mar 08 10:23:20 dorsz-connect ntpd[730]: Soliciting pool server 188.241.28.254 Mar 08 10:23:20 dorsz-connect ntpd[730]: Soliciting pool server 213.222.217.10 Mar 08 10:23:26 dorsz-connect ntpd[730]: receive: Unexpected origin timestamp 0xeb768b0d.941b21a1 does not match aorg 0000000000.00000000 from server@195.46.37.22 xmt 0xeb768b0e.a0c0be26 Mar 08 10:23:37 dorsz-connect volumiossh-tunnel[1359]: Warning: Permanently added '[eu4.myvolumio.org]:2222,[167.172.103.77]:2222' (RSA) to the list of known hosts. Mar 08 10:23:41 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 08 10:23:41 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 08 10:23:41 dorsz-connect volumio[980]: info: Discovery: Getting this device information Mar 08 10:23:41 dorsz-connect volumio[980]: info: CoreCommandRouter::volumioGetState Mar 08 10:23:41 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 08 10:23:44 dorsz-connect volumio[980]: info: CoreCommandRouter::volumioPlay Mar 08 10:23:44 dorsz-connect volumio[980]: info: CoreStateMachine::play index undefined Mar 08 10:23:44 dorsz-connect volumio[980]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 08 10:23:44 dorsz-connect volumio[980]: info: CorePlayQueue::getTrack 0 Mar 08 10:23:44 dorsz-connect volumio[980]: info: CoreStateMachine::startPlaybackTimer Mar 08 10:23:44 dorsz-connect volumio[980]: info: CorePlayQueue::getTrack 0 Mar 08 10:23:44 dorsz-connect volumio[980]: info: CoreCommandRouter::volumioGetVisibleSources Mar 08 10:23:44 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 08 10:23:44 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Mar 08 10:23:44 dorsz-connect volumio[980]: info: [1741425824713] ControllerWebradio::clearAddPlayTrack Mar 08 10:23:44 dorsz-connect volumio[980]: verbose: ControllerMpd::sendMpdCommand stop Mar 08 10:23:44 dorsz-connect volumio[980]: info: Mar 08 10:23:44 dorsz-connect volumio[980]: ---------------------------- MPD announces state update: player Mar 08 10:23:44 dorsz-connect volumio[980]: info: sendMpdCommand stop took 4 milliseconds Mar 08 10:23:44 dorsz-connect volumio[980]: info: ControllerMpd::getState Mar 08 10:23:44 dorsz-connect volumio[980]: verbose: ControllerMpd::sendMpdCommand status Mar 08 10:23:44 dorsz-connect volumio[980]: verbose: ControllerMpd::sendMpdCommand clear Mar 08 10:23:44 dorsz-connect volumio[980]: info: Mar 08 10:23:44 dorsz-connect volumio[980]: ---------------------------- MPD announces system playlist update Mar 08 10:23:44 dorsz-connect volumio[980]: info: Ignoring MPD Status Update Mar 08 10:23:44 dorsz-connect volumio[980]: info: sendMpdCommand status took 3 milliseconds Mar 08 10:23:44 dorsz-connect volumio[980]: info: sendMpdCommand clear took 3 milliseconds Mar 08 10:23:44 dorsz-connect volumio[980]: verbose: ControllerMpd::parseState Mar 08 10:23:44 dorsz-connect volumio[980]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 10:23:44 dorsz-connect volumio[980]: verbose: ControllerMpd::sendMpdCommand load "https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3" Mar 08 10:23:44 dorsz-connect volumio[980]: error: updateQueue error: null Mar 08 10:23:44 dorsz-connect volumio[980]: info: ------------------------------ 6ms Mar 08 10:23:44 dorsz-connect volumio[980]: info: sendMpdCommand playlistinfo took 3 milliseconds Mar 08 10:23:44 dorsz-connect volumio[980]: verbose: ControllerMpd::parseTrackInfo Mar 08 10:23:44 dorsz-connect volumio[980]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Mar 08 10:23:44 dorsz-connect volumio[980]: info: ------------------------------ 11ms Mar 08 10:23:46 dorsz-connect volumio[980]: verbose: ControllerMpd::sendMpdCommand add "https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3" Mar 08 10:23:46 dorsz-connect volumio[980]: info: Mar 08 10:23:46 dorsz-connect volumio[980]: ---------------------------- MPD announces system playlist update Mar 08 10:23:46 dorsz-connect volumio[980]: info: Ignoring MPD Status Update Mar 08 10:23:46 dorsz-connect volumio[980]: info: sendMpdCommand add "https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3" took 3 milliseconds Mar 08 10:23:46 dorsz-connect volumio[980]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 08 10:23:46 dorsz-connect volumio[980]: verbose: ControllerMpd::sendMpdCommand play Mar 08 10:23:46 dorsz-connect volumio[980]: info: ------------------------------ 4ms Mar 08 10:23:46 dorsz-connect volumio[980]: info: sendMpdCommand play took 2 milliseconds Mar 08 10:23:48 dorsz-connect volumio[980]: info: Mar 08 10:23:48 dorsz-connect volumio[980]: ---------------------------- MPD announces state update: player Mar 08 10:23:48 dorsz-connect volumio[980]: info: ControllerMpd::getState Mar 08 10:23:48 dorsz-connect volumio[980]: verbose: ControllerMpd::sendMpdCommand status Mar 08 10:23:48 dorsz-connect volumio[980]: info: Mar 08 10:23:48 dorsz-connect volumio[980]: ---------------------------- MPD announces state update: player Mar 08 10:23:48 dorsz-connect volumio[980]: info: ControllerMpd::getState Mar 08 10:23:48 dorsz-connect volumio[980]: verbose: ControllerMpd::sendMpdCommand status Mar 08 10:23:48 dorsz-connect volumio[980]: verbose: ControllerMpd::sendMpdCommand clearerror Mar 08 10:23:48 dorsz-connect volumio[980]: info: sendMpdCommand status took 8 milliseconds Mar 08 10:23:48 dorsz-connect volumio[980]: verbose: ControllerMpd::parseState Mar 08 10:23:48 dorsz-connect volumio[980]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 10:23:48 dorsz-connect volumio[980]: verbose: ControllerMpd::sendMpdCommand clearerror Mar 08 10:23:48 dorsz-connect volumio[980]: info: sendMpdCommand status took 21 milliseconds Mar 08 10:23:48 dorsz-connect volumio[980]: info: sendMpdCommand clearerror took 15 milliseconds Mar 08 10:23:48 dorsz-connect volumio[980]: info: sendMpdCommand playlistinfo took 13 milliseconds Mar 08 10:23:48 dorsz-connect volumio[980]: verbose: ControllerMpd::parseState Mar 08 10:23:48 dorsz-connect volumio[980]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 10:23:48 dorsz-connect volumio[980]: verbose: ControllerMpd::parseTrackInfo Mar 08 10:23:48 dorsz-connect volumio[980]: info: ControllerMpd::pushState Mar 08 10:23:48 dorsz-connect volumio[980]: info: CoreCommandRouter::servicePushState Mar 08 10:23:48 dorsz-connect volumio[980]: info: CorePlayQueue::getTrack 0 Mar 08 10:23:48 dorsz-connect volumio[980]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"mp3","artist":null,"album":null,"uri":"https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3","trackType":""} Mar 08 10:23:48 dorsz-connect volumio[980]: verbose: CURRENT POSITION 0 Mar 08 10:23:48 dorsz-connect volumio[980]: info: CoreStateMachine::syncState stateService pause Mar 08 10:23:48 dorsz-connect volumio[980]: info: CoreStateMachine::syncState currentStatus stop Mar 08 10:23:48 dorsz-connect volumio[980]: info: CoreStateMachine::pushState Mar 08 10:23:48 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 08 10:23:48 dorsz-connect volumio[980]: info: CoreCommandRouter::volumioPushState Mar 08 10:23:48 dorsz-connect volumio[980]: info: ------------------------------ 46ms Mar 08 10:23:48 dorsz-connect volumio[980]: info: sendMpdCommand clearerror took 33 milliseconds Mar 08 10:23:48 dorsz-connect volumio[980]: info: sendMpdCommand playlistinfo took 31 milliseconds Mar 08 10:23:48 dorsz-connect volumio[980]: verbose: ControllerMpd::parseTrackInfo Mar 08 10:23:48 dorsz-connect volumio[980]: info: ControllerMpd::pushState Mar 08 10:23:48 dorsz-connect volumio[980]: info: CoreCommandRouter::servicePushState Mar 08 10:23:48 dorsz-connect volumio[980]: info: CorePlayQueue::getTrack 0 Mar 08 10:23:48 dorsz-connect volumio[980]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"mp3","artist":null,"album":null,"uri":"https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3","trackType":""} Mar 08 10:23:48 dorsz-connect volumio[980]: verbose: CURRENT POSITION 0 Mar 08 10:23:48 dorsz-connect volumio[980]: info: CoreStateMachine::syncState stateService pause Mar 08 10:23:48 dorsz-connect volumio[980]: info: CoreStateMachine::syncState currentStatus stop Mar 08 10:23:48 dorsz-connect volumio[980]: info: CoreStateMachine::pushState Mar 08 10:23:48 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 08 10:23:48 dorsz-connect volumio[980]: info: CoreCommandRouter::volumioPushState Mar 08 10:23:48 dorsz-connect volumio[980]: info: ------------------------------ 79ms Mar 08 10:23:51 dorsz-connect volumio[980]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 08 10:23:51 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Mar 08 10:23:51 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 08 10:23:51 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 08 10:23:51 dorsz-connect volumio[980]: info: Getting Alsa Cards List without I2S DAC Mar 08 10:23:51 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Mar 08 10:23:51 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 08 10:23:51 dorsz-connect volumio[980]: Invalid card number. Mar 08 10:23:51 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 08 10:23:51 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 08 10:23:51 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 08 10:23:51 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 08 10:23:51 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 08 10:23:51 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 08 10:23:51 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 08 10:23:51 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Mar 08 10:23:51 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Mar 08 10:23:54 dorsz-connect volumio[980]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 08 10:23:54 dorsz-connect volumio[980]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 08 10:23:54 dorsz-connect volumio[980]: info: Retrieving Cloud Streaming UI Mar 08 10:23:54 dorsz-connect volumio[980]: info: Getting Tidal Cloud Configuration Mar 08 10:23:54 dorsz-connect volumio[980]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 08 10:23:54 dorsz-connect volumio[980]: info: Getting Qobuz Cloud Configuration Mar 08 10:23:54 dorsz-connect volumio[980]: info: Asking plugin for UI Config Mar 08 10:23:54 dorsz-connect volumio[980]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 08 10:23:54 dorsz-connect volumio[980]: info: Getting Spotify Cloud Configuration Mar 08 10:23:54 dorsz-connect volumio[980]: info: Asking plugin for UI Config Mar 08 10:23:54 dorsz-connect volumio[980]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 08 10:23:54 dorsz-connect volumio[980]: info: Saving Spotify Acccount Mar 08 10:23:54 dorsz-connect volumio[980]: info: Got it Mar 08 10:23:54 dorsz-connect volumio[980]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Mar 08 10:23:54 dorsz-connect volumio[980]: info: Got it Mar 08 10:23:54 dorsz-connect volumio[980]: info: Got Tidal Cloud Configuration Mar 08 10:23:54 dorsz-connect volumio[980]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 08 10:23:54 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Mar 08 10:23:54 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 08 10:23:54 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 08 10:23:54 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 08 10:23:54 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 08 10:23:54 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 08 10:23:54 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 08 10:23:54 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 08 10:23:54 dorsz-connect volumio[980]: info: CoreCommandRouter::volumioGetBrowseSources Mar 08 10:23:54 dorsz-connect volumio[980]: info: CoreCommandRouter::volumioGetBrowseSources Mar 08 10:23:54 dorsz-connect volumio[980]: info: CoreCommandRouter::volumioGetBrowseSources Mar 08 10:23:54 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 08 10:23:54 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Mar 08 10:23:56 dorsz-connect volumio[980]: info: Disabling MyMusic plugin upnp Mar 08 10:23:56 dorsz-connect sudo[1554]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service Mar 08 10:23:56 dorsz-connect sudo[1554]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 08 10:23:56 dorsz-connect systemd[1]: Stopping UPnP Renderer front-end to MPD... Mar 08 10:23:56 dorsz-connect volumio[980]: error: Upnp client error: Error: This socket has been ended by the other party Mar 08 10:23:57 dorsz-connect volumio[980]: info: Enabling MyMusic plugin upnp Mar 08 10:23:57 dorsz-connect volumio[980]: info: Enabling plugin upnp Mar 08 10:23:57 dorsz-connect volumio[980]: info: Loading plugin "upnp"... Mar 08 10:23:57 dorsz-connect volumio[980]: info: [1741425837360] Starting Upmpd Daemon Mar 08 10:23:57 dorsz-connect volumio[980]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 08 10:23:57 dorsz-connect volumio[980]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 08 10:23:57 dorsz-connect volumio[980]: Error: listen EADDRINUSE: address already in use :::6599 Mar 08 10:23:57 dorsz-connect volumio[980]: at Server.setupListenHandle [as _listen2] (net.js:1318:16) Mar 08 10:23:57 dorsz-connect volumio[980]: at listenInCluster (net.js:1366:12) Mar 08 10:23:57 dorsz-connect volumio[980]: at Server.listen (net.js:1452:7) Mar 08 10:23:57 dorsz-connect volumio[980]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17) Mar 08 10:23:57 dorsz-connect volumio[980]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38) Mar 08 10:23:57 dorsz-connect volumio[980]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) Mar 08 10:23:57 dorsz-connect volumio[980]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Mar 08 10:23:57 dorsz-connect volumio[980]: at processTicksAndRejections (internal/process/task_queues.js:75:11) { Mar 08 10:23:57 dorsz-connect volumio[980]: code: 'EADDRINUSE', Mar 08 10:23:57 dorsz-connect volumio[980]: errno: -98, Mar 08 10:23:57 dorsz-connect volumio[980]: syscall: 'listen', Mar 08 10:23:57 dorsz-connect volumio[980]: address: '::', Mar 08 10:23:57 dorsz-connect volumio[980]: port: 6599 Mar 08 10:23:57 dorsz-connect volumio[980]: } Mar 08 10:23:57 dorsz-connect volumio[980]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 08 10:23:57 dorsz-connect sudo[1565]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-08 10:22 Mar 08 10:23:57 dorsz-connect sudo[1565]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster 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="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="a01a833dd28483f88cb390596f5090b7187992af" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 27 Feb 2025 11:42:54 AM CET" VOLUMIO_VERSION="3.795" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="4049a67f1c09d4a94e033ba35a80a144"