-- Logs begin at Mon 2024-11-25 19:28:43 CET, end at Mon 2024-11-25 19:30:44 CET. -- Nov 25 19:29:00 thomsaudiohoek wireless.js[745]: trying... Nov 25 19:29:00 thomsaudiohoek sudo[1216]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Nov 25 19:29:00 thomsaudiohoek sudo[1216]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:29:00 thomsaudiohoek sudo[1216]: pam_unix(sudo:session): session closed for user root Nov 25 19:29:01 thomsaudiohoek dhcpcd[1151]: wlan0: leased 192.168.68.65 for 7200 seconds Nov 25 19:29:01 thomsaudiohoek avahi-daemon[769]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.68.65. Nov 25 19:29:01 thomsaudiohoek avahi-daemon[769]: New relevant interface wlan0.IPv4 for mDNS. Nov 25 19:29:01 thomsaudiohoek avahi-daemon[769]: Registering new address record for 192.168.68.65 on wlan0.IPv4. Nov 25 19:29:01 thomsaudiohoek dhcpcd[1151]: wlan0: adding route to 192.168.68.0/22 Nov 25 19:29:01 thomsaudiohoek dhcpcd[1151]: wlan0: adding default route via 192.168.68.1 Nov 25 19:29:01 thomsaudiohoek wireless.js[745]: trying... Nov 25 19:29:01 thomsaudiohoek sudo[1238]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Nov 25 19:29:01 thomsaudiohoek sudo[1238]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:29:01 thomsaudiohoek sudo[1238]: pam_unix(sudo:session): session closed for user root Nov 25 19:29:01 thomsaudiohoek wireless.js[745]: Connected to: ----FiberFirst Nov 25 19:29:01 thomsaudiohoek wireless.js[745]: ---- Nov 25 19:29:01 thomsaudiohoek sudo[1241]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 25 19:29:01 thomsaudiohoek sudo[1241]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:29:01 thomsaudiohoek sudo[1241]: pam_unix(sudo:session): session closed for user root Nov 25 19:29:01 thomsaudiohoek wireless.js[745]: ... joined AP, wlan0 IPv4 is 192.168.68.65, ipV6 is undefined Nov 25 19:29:01 thomsaudiohoek wireless.js[745]: It's done! AP Nov 25 19:29:02 thomsaudiohoek kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Nov 25 19:29:02 thomsaudiohoek systemd[1]: Started Wireless Services. Nov 25 19:29:02 thomsaudiohoek systemd[1]: Started Volumio Backend Module. Nov 25 19:29:02 thomsaudiohoek systemd[1]: Started Volumio Cpu Tweaker. Nov 25 19:29:02 thomsaudiohoek volumio-cpu-tweak[1247]: Setting RT Priority for mpd Nov 25 19:29:02 thomsaudiohoek volumio-cpu-tweak[1247]: Setting MPD Affinity Nov 25 19:29:02 thomsaudiohoek volumio-cpu-tweak[1247]: pid 981's current affinity mask: f Nov 25 19:29:02 thomsaudiohoek volumio-cpu-tweak[1247]: pid 981's new affinity mask: 3 Nov 25 19:29:02 thomsaudiohoek volumio-cpu-tweak[1247]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input Nov 25 19:29:02 thomsaudiohoek volumio-cpu-tweak[1247]: VOLUMIO CPU TWEAK: Setting CPU Governor: conservative Nov 25 19:29:02 thomsaudiohoek systemd[1]: volumio_cpu_tweak.service: Succeeded. Nov 25 19:29:02 thomsaudiohoek volumio[1246]: info: ------------------------------------------- Nov 25 19:29:02 thomsaudiohoek volumio[1246]: info: ----- Volumio3 ---- Nov 25 19:29:02 thomsaudiohoek volumio[1246]: info: ------------------------------------------- Nov 25 19:29:02 thomsaudiohoek volumio[1246]: info: ----- System startup ---- Nov 25 19:29:02 thomsaudiohoek volumio[1246]: info: ------------------------------------------- Nov 25 19:29:02 thomsaudiohoek ntpd[967]: Listen normally on 3 wlan0 192.168.68.65:123 Nov 25 19:29:02 thomsaudiohoek ntpd[967]: new interface(s) found: waking up resolver Nov 25 19:29:02 thomsaudiohoek volumio[1246]: info: MYVOLUMIO Environment detected Nov 25 19:29:02 thomsaudiohoek volumio[1246]: info: Plugin folders cleanup Nov 25 19:29:02 thomsaudiohoek volumio[1246]: info: Scanning into folder /volumio/app/plugins/ Nov 25 19:29:02 thomsaudiohoek volumio[1246]: info: Scanning category audio_interface Nov 25 19:29:02 thomsaudiohoek volumio[1246]: info: Scanning category miscellanea Nov 25 19:29:02 thomsaudiohoek volumio[1246]: info: Scanning category music_service Nov 25 19:29:02 thomsaudiohoek volumio[1246]: info: Scanning category plugins.json Nov 25 19:29:02 thomsaudiohoek volumio[1246]: info: Scanning category system_controller Nov 25 19:29:02 thomsaudiohoek volumio[1246]: info: Scanning category user_interface Nov 25 19:29:02 thomsaudiohoek volumio[1246]: info: Scanning into folder /data/plugins/ Nov 25 19:29:02 thomsaudiohoek volumio[1246]: info: Scanning category audio_interface Nov 25 19:29:02 thomsaudiohoek volumio[1246]: info: Scanning category music_service Nov 25 19:29:02 thomsaudiohoek volumio[1246]: info: Scanning category system_controller Nov 25 19:29:02 thomsaudiohoek volumio[1246]: info: Scanning category system_hardware Nov 25 19:29:02 thomsaudiohoek volumio[1246]: info: Scanning category user_interface Nov 25 19:29:02 thomsaudiohoek volumio[1246]: info: Plugin folders cleanup completed Nov 25 19:29:02 thomsaudiohoek volumio[1246]: info: ------------------------------------------- Nov 25 19:29:02 thomsaudiohoek volumio[1246]: info: ----- Core plugins startup ---- Nov 25 19:29:02 thomsaudiohoek volumio[1246]: info: ------------------------------------------- Nov 25 19:29:02 thomsaudiohoek volumio[1246]: info: Loading plugins from folder /volumio/app/plugins/ Nov 25 19:29:02 thomsaudiohoek volumio[1246]: info: Adding plugin upnp to MyMusic Plugins Nov 25 19:29:02 thomsaudiohoek volumio[1246]: info: Adding plugin airplay_emulation to MyMusic Plugins Nov 25 19:29:02 thomsaudiohoek volumio[1246]: info: Adding plugin upnp_browser to MyMusic Plugins Nov 25 19:29:02 thomsaudiohoek volumio[1246]: info: Loading plugins from folder /data/plugins/ Nov 25 19:29:02 thomsaudiohoek volumio[1246]: info: Loading plugin "system"... Nov 25 19:29:02 thomsaudiohoek volumio[1246]: info: Loading plugin "appearance"... Nov 25 19:29:03 thomsaudiohoek volumio[1246]: info: Loading plugin "network"... Nov 25 19:29:03 thomsaudiohoek volumio[1246]: info: Refreshing Cached IP Addresses Nov 25 19:29:03 thomsaudiohoek sudo[1277]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 25 19:29:03 thomsaudiohoek sudo[1277]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:29:03 thomsaudiohoek sudo[1279]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 25 19:29:03 thomsaudiohoek sudo[1279]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:29:03 thomsaudiohoek sudo[1277]: pam_unix(sudo:session): session closed for user root Nov 25 19:29:03 thomsaudiohoek sudo[1279]: pam_unix(sudo:session): session closed for user root Nov 25 19:29:03 thomsaudiohoek volumio[1246]: info: Loading plugin "services"... Nov 25 19:29:03 thomsaudiohoek volumio[1246]: info: Loading plugin "alsa_controller"... Nov 25 19:29:03 thomsaudiohoek sudo[1292]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Nov 25 19:29:03 thomsaudiohoek sudo[1292]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:29:03 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 25 19:29:03 thomsaudiohoek volumio[1246]: info: Loading plugin "wizard"... Nov 25 19:29:03 thomsaudiohoek volumio[1246]: info: Loading plugin "networkfs"... Nov 25 19:29:03 thomsaudiohoek volumio[1246]: info: Starting Udev Watcher for removable devices Nov 25 19:29:03 thomsaudiohoek sudo[1305]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=thom van zee,password=Ikwilopdenas!1,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.68.150/music /mnt/NAS/Gangkast Nov 25 19:29:03 thomsaudiohoek sudo[1305]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:29:03 thomsaudiohoek volumio[1246]: info: Ignoring mount for partition: boot Nov 25 19:29:03 thomsaudiohoek volumio[1246]: info: Ignoring mount for partition: volumio Nov 25 19:29:03 thomsaudiohoek volumio[1246]: info: Ignoring mount for partition: volumio_data Nov 25 19:29:03 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 25 19:29:03 thomsaudiohoek volumio[1246]: info: Loading plugin "volumio_command_line_client"... Nov 25 19:29:03 thomsaudiohoek volumio[1246]: info: Loading plugin "upnp"... Nov 25 19:29:03 thomsaudiohoek volumio[1246]: info: [1732559343286] Starting Upmpd Daemon Nov 25 19:29:03 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 25 19:29:03 thomsaudiohoek volumio[1246]: info: Loading plugin "my_music"... Nov 25 19:29:03 thomsaudiohoek volumio[1246]: info: Loading plugin "mpd"... Nov 25 19:29:03 thomsaudiohoek kernel: Key type cifs.spnego registered Nov 25 19:29:03 thomsaudiohoek kernel: Key type cifs.idmap registered Nov 25 19:29:03 thomsaudiohoek kernel: CIFS: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3.1.1), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3.1.1 (or even SMB3 or SMB2.1) specify vers=1.0 on mount. Nov 25 19:29:03 thomsaudiohoek kernel: CIFS: Attempting to mount //192.168.68.150/music Nov 25 19:29:03 thomsaudiohoek volumio[1246]: info: Plugin upnp_browser is not enabled Nov 25 19:29:03 thomsaudiohoek volumio[1246]: info: Loading plugin "alarm-clock"... Nov 25 19:29:03 thomsaudiohoek volumio[1246]: info: Loading plugin "airplay_emulation"... Nov 25 19:29:03 thomsaudiohoek volumio[1246]: info: Starting Shairport Sync Nov 25 19:29:03 thomsaudiohoek volumio[1246]: info: Loading plugin "last_100"... Nov 25 19:29:03 thomsaudiohoek volumio[1246]: info: Loading plugin "webradio"... Nov 25 19:29:03 thomsaudiohoek volumio[1246]: info: Loading plugin "i2s_dacs"... Nov 25 19:29:03 thomsaudiohoek volumio[1246]: info: I2S DAC not set, start Auto-detection Nov 25 19:29:03 thomsaudiohoek volumio[1246]: info: Loading plugin "volumiodiscovery"... Nov 25 19:29:03 thomsaudiohoek volumio[1246]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 25 19:29:03 thomsaudiohoek volumio[1246]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 25 19:29:03 thomsaudiohoek volumio[1246]: *** WARNING *** For more information see Nov 25 19:29:03 thomsaudiohoek node[1246]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 25 19:29:03 thomsaudiohoek volumio[1246]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 25 19:29:03 thomsaudiohoek volumio[1246]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 25 19:29:03 thomsaudiohoek volumio[1246]: *** WARNING *** For more information see Nov 25 19:29:03 thomsaudiohoek node[1246]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 25 19:29:03 thomsaudiohoek node[1246]: *** WARNING *** For more information see Nov 25 19:29:03 thomsaudiohoek node[1246]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 25 19:29:03 thomsaudiohoek node[1246]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 25 19:29:03 thomsaudiohoek node[1246]: *** WARNING *** For more information see Nov 25 19:29:03 thomsaudiohoek volumio[1246]: info: Applying required configuration parameters for plugin volumiodiscovery Nov 25 19:29:03 thomsaudiohoek volumio[1246]: info: Discovery: Started advertising with name: ThomsAudioHoek Nov 25 19:29:03 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 25 19:29:03 thomsaudiohoek volumio[1246]: info: Plugin spop is not enabled Nov 25 19:29:03 thomsaudiohoek volumio[1246]: info: Loading plugin "youtube2"... Nov 25 19:29:03 thomsaudiohoek sudo[1305]: pam_unix(sudo:session): session closed for user root Nov 25 19:29:03 thomsaudiohoek volumio[1246]: info: Loading plugin "ytcr"... Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: Loading plugin "ytmusic"... Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: Loading plugin "autostart"... Nov 25 19:29:04 thomsaudiohoek volumio-time-update[748]: volumio-time-update-util: Fetching time from Volumio... Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: Applying required configuration parameters for plugin autostart Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: AutoStart - onVolumioStart - read config.json Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: Loading plugin "outputs"... Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: Loading plugin "albumart"... Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: Plugin example_plugin is not enabled Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: Loading plugin "inputs"... Nov 25 19:29:04 thomsaudiohoek volumio-time-update[748]: volumio-time-update-util: Setting system time to: 2024-11-25 19:29:04 Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: Loading plugin "updater_comm"... Nov 25 19:29:04 thomsaudiohoek sudo[1339]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-time 2024-11-25 19:29:04 Nov 25 19:29:04 thomsaudiohoek sudo[1339]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:29:04 thomsaudiohoek dbus-daemon[737]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.11' (uid=0 pid=1345 comm="timedatectl set-time 2024-11-25 19:29:04 ") Nov 25 19:29:04 thomsaudiohoek systemd[1]: Starting Time & Date Service... Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: Plugin mpdemulation is not enabled Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: Loading plugin "rest_api"... Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: Loading plugin "websocket"... Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: Starting Socket.io Server version 2.3.0 Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: Loading plugin "fusiondsp"... Nov 25 19:29:04 thomsaudiohoek volumio[1246]: Forking 3 albumart workers Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: Applying required configuration parameters for plugin fusiondsp Nov 25 19:29:04 thomsaudiohoek dbus-daemon[737]: [system] Successfully activated service 'org.freedesktop.timedate1' Nov 25 19:29:04 thomsaudiohoek systemd[1]: Started Time & Date Service. Nov 25 19:29:04 thomsaudiohoek systemd-timedated[1347]: Changed local time to Mon Nov 25 19:29:04 2024 Nov 25 19:29:04 thomsaudiohoek sudo[1339]: pam_unix(sudo:session): session closed for user root Nov 25 19:29:04 thomsaudiohoek volumio-time-update[748]: volumio-time-update-util: System time updated successfully. Nov 25 19:29:04 thomsaudiohoek systemd[1]: Started Volumio Time Update Utility. Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: Loading plugin "motherearthradio"... Nov 25 19:29:04 thomsaudiohoek volumio[1246]: Starting albumart workers Nov 25 19:29:04 thomsaudiohoek volumio[1246]: Starting albumart workers Nov 25 19:29:04 thomsaudiohoek volumio[1246]: Starting albumart workers Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: Applying required configuration parameters for plugin motherearthradio Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: [1732559344224] [MotherEarth] API delay: 5 Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: Loading plugin "radio_paradise"... Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: Applying required configuration parameters for plugin radio_paradise Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: [1732559344312] [RadioParadise] API delay: 5 Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: Plugin music_services_shield is not enabled Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: Loading plugin "Systeminfo"... Nov 25 19:29:04 thomsaudiohoek nmbd[926]: [2024/11/25 19:29:04.334313, 0] ../lib/util/become_daemon.c:138(daemon_ready) Nov 25 19:29:04 thomsaudiohoek nmbd[926]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Nov 25 19:29:04 thomsaudiohoek systemd[1]: Started Samba NMB Daemon. Nov 25 19:29:04 thomsaudiohoek systemd[1]: Starting Samba Winbind Daemon... Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: Loading plugin "touch_display"... Nov 25 19:29:04 thomsaudiohoek winbindd[1394]: [2024/11/25 19:29:04.427225, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Nov 25 19:29:04 thomsaudiohoek winbindd[1394]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Nov 25 19:29:04 thomsaudiohoek winbindd[1394]: [2024/11/25 19:29:04.430372, 0] ../lib/util/become_daemon.c:138(daemon_ready) Nov 25 19:29:04 thomsaudiohoek systemd[1]: Started Samba Winbind Daemon. Nov 25 19:29:04 thomsaudiohoek winbindd[1394]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Nov 25 19:29:04 thomsaudiohoek systemd[1]: Starting Samba SMB Daemon... Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: Applying required configuration parameters for plugin touch_display Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: Loading i18n strings for locale nl Nov 25 19:29:04 thomsaudiohoek volumio[1246]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found. Nov 25 19:29:04 thomsaudiohoek volumio[1246]: Updating browse sources language Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 25 19:29:04 thomsaudiohoek winbindd[1394]: [2024/11/25 19:29:04.535814, 0] ../source3/winbindd/wb_lookupsids.c:659(wb_lookupsids_recv) Nov 25 19:29:04 thomsaudiohoek winbindd[1394]: res_names->count = 3, expected 4 Nov 25 19:29:04 thomsaudiohoek smbd[1399]: [2024/11/25 19:29:04.554461, 0] ../lib/util/become_daemon.c:138(daemon_ready) Nov 25 19:29:04 thomsaudiohoek smbd[1399]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Nov 25 19:29:04 thomsaudiohoek systemd[1]: Started Samba SMB Daemon. Nov 25 19:29:04 thomsaudiohoek systemd[1]: Reached target Multi-User System. Nov 25 19:29:04 thomsaudiohoek systemd[1]: Reached target Graphical Interface. Nov 25 19:29:04 thomsaudiohoek systemd[1]: Starting Update UTMP about System Runlevel Changes... Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::initPlayerControls Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 25 19:29:04 thomsaudiohoek systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Nov 25 19:29:04 thomsaudiohoek volumio[1246]: Express server listening on port 3000 Nov 25 19:29:04 thomsaudiohoek volumio[1246]: [Metrics] WebUI: 3s 55.39ms Nov 25 19:29:04 thomsaudiohoek systemd[1]: Started Update UTMP about System Runlevel Changes. Nov 25 19:29:04 thomsaudiohoek systemd[1]: Startup finished in 11.202s (kernel) + 22.129s (userspace) = 33.332s. Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: CoreStateMachine::resetVolumioState Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: CoreStateMachine::getcurrentVolume Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::volumioRetrievevolume Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: Volumio Network Manager: Network status updated: 2 Nov 25 19:29:04 thomsaudiohoek volumio[1246]: verbose: New Socket.io Connection to 192.168.68.65 from 192.168.68.76 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/131.0.0.0 Safari/537.36 Edg/131.0.0.0 Engine version: 3 Transport: polling Total Clients: 1 Nov 25 19:29:04 thomsaudiohoek volumio[1246]: verbose: New Socket.io Connection to 192.168.68.65 from 192.168.68.76 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/131.0.0.0 Safari/537.36 Edg/131.0.0.0 Engine version: 3 Transport: polling Total Clients: 2 Nov 25 19:29:04 thomsaudiohoek volumio[1246]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: Reloading queue from file Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: CoreStateMachine::setRepeat null single undefined Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: CoreStateMachine::pushState Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: CorePlayQueue::getTrack 0 Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::volumioPushState Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: CoreStateMachine::setRandom null Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: CoreStateMachine::pushState Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: CorePlayQueue::getTrack 0 Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::volumioPushState Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: Setting Device type: Raspberry PI Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: USB Boot Capable - System SBC Revision found in cpuinfo: d04170 Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: VolumeController:: Volume=58 Mute =false Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: CoreStateMachine::pushState Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: CorePlayQueue::getTrack 0 Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::volumioPushState Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: CoreStateMachine::updateTrackBlock Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: CorePlayQueue::getTrackBlock Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::volumioRetrievevolume Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: Completed loading Core Plugins Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: Preparing to generate the ALSA configuration file Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: Reading ALSA contributions from plugins. Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: VolumeController:: Volume=58 Mute =false Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: CoreStateMachine::pushState Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: CorePlayQueue::getTrack 0 Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::volumioPushState Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: Asound.conf file unchanged, so no further update is needed Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: Output device has changed, restarting MPD Nov 25 19:29:04 thomsaudiohoek sudo[1423]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 25 19:29:04 thomsaudiohoek sudo[1423]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: Output device has changed, restarting Shairport Sync Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 25 19:29:04 thomsaudiohoek sudo[1423]: pam_unix(sudo:session): session closed for user root Nov 25 19:29:04 thomsaudiohoek sudo[1426]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 25 19:29:04 thomsaudiohoek sudo[1426]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:29:04 thomsaudiohoek systemd[1]: Stopping Music Player Daemon... Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: ___________ START PLUGINS ___________ Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: ControllerMpd::onStart: Initializing MPD Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: Creating MPD Configuration file Nov 25 19:29:04 thomsaudiohoek sudo[1432]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 25 19:29:04 thomsaudiohoek sudo[1432]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:29:04 thomsaudiohoek sudo[1432]: pam_unix(sudo:session): session closed for user root Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 25 19:29:04 thomsaudiohoek sudo[1435]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 25 19:29:04 thomsaudiohoek sudo[1435]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 25 19:29:04 thomsaudiohoek systemd[1]: mpd.service: Succeeded. Nov 25 19:29:04 thomsaudiohoek systemd[1]: Stopped Music Player Daemon. Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: [1732559344795] CoreMusicLibrary::Adding element Last_100 Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: [1732559344796] CoreMusicLibrary::Adding element Webradio Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: Initializing BBC Radios Nov 25 19:29:04 thomsaudiohoek systemd[1]: Starting Music Player Daemon... Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: [1732559344824] CoreMusicLibrary::Adding element YouTube2 Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 25 19:29:04 thomsaudiohoek volumio[1246]: Cannot find translation for source YouTube2 Nov 25 19:29:04 thomsaudiohoek sudo[1441]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 25 19:29:04 thomsaudiohoek sudo[1441]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: [1732559344836] CoreMusicLibrary::Adding element YouTube Music Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 25 19:29:04 thomsaudiohoek volumio[1246]: Cannot find translation for source YouTube2 Nov 25 19:29:04 thomsaudiohoek volumio[1246]: Cannot find translation for source YouTube Music Nov 25 19:29:04 thomsaudiohoek sudo[1441]: pam_unix(sudo:session): session closed for user root Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: AutoStart - onStart Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: Loading i18n strings for locale nl Nov 25 19:29:04 thomsaudiohoek volumio[1246]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found. Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: FusionDsp - mixtype--------------------- Hardware Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: [1732559344844] CoreMusicLibrary::Adding element Mother Earth Radio Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 25 19:29:04 thomsaudiohoek volumio[1246]: Cannot find translation for source YouTube2 Nov 25 19:29:04 thomsaudiohoek volumio[1246]: Cannot find translation for source YouTube Music Nov 25 19:29:04 thomsaudiohoek volumio[1246]: Cannot find translation for source Mother Earth Radio Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: [1732559344845] CoreMusicLibrary::Adding element Radio Paradise Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 25 19:29:04 thomsaudiohoek volumio[1246]: Cannot find translation for source YouTube2 Nov 25 19:29:04 thomsaudiohoek volumio[1246]: Cannot find translation for source YouTube Music Nov 25 19:29:04 thomsaudiohoek volumio[1246]: Cannot find translation for source Mother Earth Radio Nov 25 19:29:04 thomsaudiohoek volumio[1246]: Cannot find translation for source Radio Paradise Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: Loading i18n strings for locale nl Nov 25 19:29:04 thomsaudiohoek volumio[1246]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found. Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: Volumio Calling Home Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: Preparing to generate the ALSA configuration file Nov 25 19:29:04 thomsaudiohoek sudo[1460]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop getty@tty1.service Nov 25 19:29:04 thomsaudiohoek sudo[1460]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:29:04 thomsaudiohoek sudo[1463]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl disable getty@tty1.service Nov 25 19:29:04 thomsaudiohoek sudo[1463]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:29:04 thomsaudiohoek sudo[1465]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Nov 25 19:29:04 thomsaudiohoek sudo[1465]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:29:04 thomsaudiohoek sudo[1460]: pam_unix(sudo:session): session closed for user root Nov 25 19:29:04 thomsaudiohoek systemd[1]: Reloading. Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: Discovery: adding 9213bafe-8343-4fbb-9113-ef2e432d28e4 Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: Discovery: Found device ThomsAudioHoek Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::volumioGetState Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: CorePlayQueue::getTrack 0 Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: Reading ALSA contributions from plugins. Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: touch_display: Backlight interface detected. Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: touch_display: systemctl stop getty@tty1.service succeeded. Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: MPD Permissions set Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: MPD Permissions set Nov 25 19:29:04 thomsaudiohoek volumio[1246]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 19:29:04 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 19:29:05 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 25 19:29:05 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 19:29:05 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 19:29:05 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 19:29:05 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 19:29:05 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 19:29:05 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 19:29:05 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 19:29:05 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 19:29:05 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 19:29:05 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 25 19:29:05 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 19:29:05 thomsaudiohoek volumio[1246]: info: Volumio called home Nov 25 19:29:05 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::volumioGetState Nov 25 19:29:05 thomsaudiohoek volumio[1246]: info: CorePlayQueue::getTrack 0 Nov 25 19:29:05 thomsaudiohoek systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Nov 25 19:29:05 thomsaudiohoek sudo[1492]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+w /sys/class/backlight/11-0045/brightness Nov 25 19:29:05 thomsaudiohoek sudo[1492]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:29:05 thomsaudiohoek sudo[1492]: pam_unix(sudo:session): session closed for user root Nov 25 19:29:05 thomsaudiohoek volumio[1246]: info: touch_display: Raspberry Pi Foundation touch screen detected. Nov 25 19:29:05 thomsaudiohoek volumio[1246]: info: Starting Shairport Sync Nov 25 19:29:05 thomsaudiohoek sudo[1495]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/99-vc4.conf Nov 25 19:29:05 thomsaudiohoek sudo[1495]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:29:05 thomsaudiohoek sudo[1495]: pam_unix(sudo:session): session closed for user root Nov 25 19:29:05 thomsaudiohoek volumio[1246]: info: Starting Shairport Sync Nov 25 19:29:05 thomsaudiohoek sudo[1498]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 25 19:29:05 thomsaudiohoek sudo[1498]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:29:05 thomsaudiohoek volumio[1246]: info: Starting Shairport Sync Nov 25 19:29:05 thomsaudiohoek sudo[1501]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 25 19:29:05 thomsaudiohoek sudo[1501]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:29:05 thomsaudiohoek volumio[1246]: info: touch_display: File permissions for backlight brightness control set. Nov 25 19:29:05 thomsaudiohoek volumio[1246]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/99-vc4.conf set. Nov 25 19:29:05 thomsaudiohoek sudo[1503]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 25 19:29:05 thomsaudiohoek sudo[1503]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:29:05 thomsaudiohoek volumio[1246]: info: Asound.conf file unchanged, so no further update is needed Nov 25 19:29:05 thomsaudiohoek volumio[1246]: info: Output device has changed, restarting MPD Nov 25 19:29:05 thomsaudiohoek sudo[1507]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 25 19:29:05 thomsaudiohoek sudo[1507]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:29:05 thomsaudiohoek volumio[1246]: info: Output device has changed, restarting Shairport Sync Nov 25 19:29:05 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 19:29:05 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 25 19:29:05 thomsaudiohoek sudo[1510]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 25 19:29:05 thomsaudiohoek sudo[1510]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:29:05 thomsaudiohoek sudo[1507]: pam_unix(sudo:session): session closed for user root Nov 25 19:29:05 thomsaudiohoek volumio[1246]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 25 19:29:05 thomsaudiohoek volumio[1246]: info: MPD Permissions set Nov 25 19:29:05 thomsaudiohoek systemd[1]: ifup@eth0.service: Current command vanished from the unit file, execution of the command list won't be resumed. Nov 25 19:29:05 thomsaudiohoek mpd[1455]: Nov 25 19:29 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 25 19:29:05 thomsaudiohoek systemd[1]: serial-getty@ttyAMA10.service: Current command vanished from the unit file, execution of the command list won't be resumed. Nov 25 19:29:05 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 19:29:05 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 19:29:05 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 19:29:05 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 19:29:05 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 19:29:05 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 19:29:05 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 19:29:05 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 19:29:05 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 25 19:29:05 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 19:29:05 thomsaudiohoek volumio[1246]: info: Starting Shairport Sync Nov 25 19:29:05 thomsaudiohoek sudo[1520]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 25 19:29:05 thomsaudiohoek sudo[1520]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:29:05 thomsaudiohoek systemd[1]: Reloading. Nov 25 19:29:05 thomsaudiohoek sudo[1465]: pam_unix(sudo:session): session closed for user root Nov 25 19:29:05 thomsaudiohoek volumio[1246]: info: touch_display: systemctl daemon-reload succeeded. Nov 25 19:29:05 thomsaudiohoek sudo[1523]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service Nov 25 19:29:05 thomsaudiohoek sudo[1523]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:29:05 thomsaudiohoek systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Nov 25 19:29:05 thomsaudiohoek systemd[1]: Started Music Player Daemon. Nov 25 19:29:05 thomsaudiohoek sudo[1435]: pam_unix(sudo:session): session closed for user root Nov 25 19:29:05 thomsaudiohoek sudo[1426]: pam_unix(sudo:session): session closed for user root Nov 25 19:29:05 thomsaudiohoek sudo[1463]: pam_unix(sudo:session): session closed for user root Nov 25 19:29:05 thomsaudiohoek volumio[1246]: info: touch_display: systemctl disable getty@tty1.service succeeded. Nov 25 19:29:05 thomsaudiohoek sudo[1523]: pam_unix(sudo:session): session closed for user root Nov 25 19:29:05 thomsaudiohoek systemd[1]: Stopping Music Player Daemon... Nov 25 19:29:05 thomsaudiohoek systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Nov 25 19:29:05 thomsaudiohoek systemd[1]: shairport-sync.service: Succeeded. Nov 25 19:29:05 thomsaudiohoek systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Nov 25 19:29:05 thomsaudiohoek volumio[1246]: error: MPD error: The expression evaluated to a falsy value: Nov 25 19:29:05 thomsaudiohoek volumio[1246]: assert.ok(self.idling) Nov 25 19:29:05 thomsaudiohoek volumio[1246]: error: The expression evaluated to a falsy value: Nov 25 19:29:05 thomsaudiohoek volumio[1246]: assert.ok(self.idling) Nov 25 19:29:05 thomsaudiohoek volumio[1246]: error: MPD error: Error: write EPIPE Nov 25 19:29:05 thomsaudiohoek volumio[1246]: error: write EPIPE {"errno":-32,"code":"EPIPE","syscall":"write"} Nov 25 19:29:05 thomsaudiohoek volumio[1246]: error: touch_display: Failed to start volumio-kiosk.service: Error: Command failed: /usr/bin/sudo /bin/systemctl start volumio-kiosk.service Nov 25 19:29:05 thomsaudiohoek volumio[1246]: Failed to start volumio-kiosk.service: Unit volumio-kiosk.service not found. Nov 25 19:29:05 thomsaudiohoek volumio[1246]: info: MPD running with PID1455 Nov 25 19:29:05 thomsaudiohoek volumio[1246]: ,establishing connection Nov 25 19:29:05 thomsaudiohoek systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Nov 25 19:29:05 thomsaudiohoek sudo[1520]: pam_unix(sudo:session): session closed for user root Nov 25 19:29:05 thomsaudiohoek systemd[1]: mpd.service: Succeeded. Nov 25 19:29:05 thomsaudiohoek sudo[1498]: pam_unix(sudo:session): session closed for user root Nov 25 19:29:05 thomsaudiohoek systemd[1]: Stopped Music Player Daemon. Nov 25 19:29:05 thomsaudiohoek sudo[1501]: pam_unix(sudo:session): session closed for user root Nov 25 19:29:05 thomsaudiohoek sudo[1503]: pam_unix(sudo:session): session closed for user root Nov 25 19:29:05 thomsaudiohoek volumio[1246]: info: Shairport-Sync Started Nov 25 19:29:05 thomsaudiohoek volumio[1246]: Error adding Membership: Error: addMembership EINVAL Nov 25 19:29:05 thomsaudiohoek volumio[1246]: info: Shairport-Sync Started Nov 25 19:29:05 thomsaudiohoek systemd[1]: Starting Music Player Daemon... Nov 25 19:29:05 thomsaudiohoek sudo[1546]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 25 19:29:05 thomsaudiohoek sudo[1546]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:29:05 thomsaudiohoek sudo[1546]: pam_unix(sudo:session): session closed for user root Nov 25 19:29:05 thomsaudiohoek mpd[1548]: Nov 25 19:29 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 25 19:29:05 thomsaudiohoek systemd[1]: Started Music Player Daemon. Nov 25 19:29:05 thomsaudiohoek volumio[1246]: error: updateQueue error: null Nov 25 19:29:05 thomsaudiohoek sudo[1510]: pam_unix(sudo:session): session closed for user root Nov 25 19:29:05 thomsaudiohoek volumio[1246]: error: updateQueue error: null Nov 25 19:29:06 thomsaudiohoek sudo[1292]: pam_unix(sudo:session): session closed for user root Nov 25 19:29:06 thomsaudiohoek volumio[1246]: info: camilladsp spawned new process with pid 1558, instance 1, run: true Nov 25 19:29:06 thomsaudiohoek volumio[1246]: info: camilladsp service started and running in background, instance 1 Nov 25 19:29:06 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 19:29:06 thomsaudiohoek volumio[1246]: info: FusionDsp - AAAAAAAAAAAAAA-> 44100 48000 88200 96000 176400 192000 384000 <-AAAAAAAAAAAAA Nov 25 19:29:06 thomsaudiohoek volumio[1246]: info: FusionDsp loaded Nov 25 19:29:06 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 25 19:29:06 thomsaudiohoek sudo[1568]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Nov 25 19:29:06 thomsaudiohoek sudo[1568]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:29:06 thomsaudiohoek volumio[1246]: info: FusionDsp - Reporting Fusion DSP Enabled Nov 25 19:29:06 thomsaudiohoek volumio[1246]: info: Adding Signal Path Element [object Object] Nov 25 19:29:06 thomsaudiohoek volumio[1246]: info: Adding fusiondspeq DSP Signal Path Element Nov 25 19:29:06 thomsaudiohoek volumio[1246]: info: FusionDsp - ---- installed callbackRead Nov 25 19:29:06 thomsaudiohoek volumio[1246]: info: FusionDsp - If filter freq >samplerate/2 then disable it Nov 25 19:29:06 thomsaudiohoek volumio[1246]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Nov 25 19:29:06 thomsaudiohoek volumio[1246]: info: FusionDsp - {"Reload":{"result":"Ok"}} Nov 25 19:29:06 thomsaudiohoek systemd[1]: Started FusionDsp Daemon. Nov 25 19:29:06 thomsaudiohoek sudo[1568]: pam_unix(sudo:session): session closed for user root Nov 25 19:29:07 thomsaudiohoek volumio-remote-updater[763]: [2024-11-25 19:29:07] [connect] Successful connection Nov 25 19:29:07 thomsaudiohoek volumio-remote-updater[763]: [2024-11-25 19:29:07] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1732559347 101 Nov 25 19:29:07 thomsaudiohoek volumio[1246]: 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: 6 Nov 25 19:29:07 thomsaudiohoek volumio[1246]: verbose: New Socket.io Connection to 192.168.68.65 from 192.168.68.76 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/131.0.0.0 Safari/537.36 Edg/131.0.0.0 Engine version: 3 Transport: polling Total Clients: 7 Nov 25 19:29:07 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::volumioGetState Nov 25 19:29:07 thomsaudiohoek volumio[1246]: info: CorePlayQueue::getTrack 0 Nov 25 19:29:07 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 25 19:29:07 thomsaudiohoek volumio[1246]: info: Listing playlists Nov 25 19:29:10 thomsaudiohoek volumio[1246]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Nov 25 19:29:11 thomsaudiohoek volumio[1246]: Cannot compose Albumart path Nov 25 19:29:11 thomsaudiohoek volumio[1246]: Cannot compose Albumart path Nov 25 19:29:11 thomsaudiohoek volumio[1246]: Cannot compose Albumart path Nov 25 19:29:11 thomsaudiohoek volumio[1246]: Cannot compose Albumart path Nov 25 19:29:11 thomsaudiohoek volumio[1246]: Cannot compose Albumart path Nov 25 19:29:11 thomsaudiohoek volumio[1246]: Cannot compose Albumart path Nov 25 19:29:11 thomsaudiohoek volumio[1246]: Cannot compose Albumart path Nov 25 19:29:11 thomsaudiohoek volumio[1246]: info: [yt-cast-receiver] DIAL server listening on port 8098 Nov 25 19:29:11 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::volumioRetrievevolume Nov 25 19:29:11 thomsaudiohoek volumio[1246]: info: VolumeController:: Volume=58 Mute =false Nov 25 19:29:11 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::volumioGetState Nov 25 19:29:11 thomsaudiohoek volumio[1246]: info: CorePlayQueue::getTrack 0 Nov 25 19:29:11 thomsaudiohoek volumio[1246]: info: CoreStateMachine::pushState Nov 25 19:29:11 thomsaudiohoek volumio[1246]: info: CorePlayQueue::getTrack 0 Nov 25 19:29:11 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::volumioPushState Nov 25 19:29:11 thomsaudiohoek volumio[1246]: info: Completed starting Core Plugins Nov 25 19:29:11 thomsaudiohoek volumio[1246]: info: ------------------------------------------- Nov 25 19:29:11 thomsaudiohoek volumio[1246]: info: ----- MyVolumio plugins startup ---- Nov 25 19:29:11 thomsaudiohoek volumio[1246]: info: ------------------------------------------- Nov 25 19:29:11 thomsaudiohoek volumio[1246]: info: [MyVolumio PluginManager] Fetching plans data.... Nov 25 19:29:12 thomsaudiohoek sudo[1589]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 25 19:29:12 thomsaudiohoek sudo[1589]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:29:12 thomsaudiohoek sudo[1589]: pam_unix(sudo:session): session closed for user root Nov 25 19:29:12 thomsaudiohoek sudo[1592]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 25 19:29:12 thomsaudiohoek sudo[1592]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:29:12 thomsaudiohoek sudo[1592]: pam_unix(sudo:session): session closed for user root Nov 25 19:29:12 thomsaudiohoek sudo[1595]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Nov 25 19:29:12 thomsaudiohoek sudo[1595]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:29:12 thomsaudiohoek systemd[1]: Started UPnP Renderer front-end to MPD. Nov 25 19:29:12 thomsaudiohoek sudo[1595]: pam_unix(sudo:session): session closed for user root Nov 25 19:29:12 thomsaudiohoek volumio[1246]: info: Upmpdcli Daemon Started Nov 25 19:29:12 thomsaudiohoek volumio[1597]: Generating RSA private key, 4096 bit long modulus (2 primes) Nov 25 19:29:13 thomsaudiohoek systemd[1]: systemd-fsckd.service: Succeeded. Nov 25 19:29:13 thomsaudiohoek sh[698]: timed out Nov 25 19:29:13 thomsaudiohoek dhcpcd[743]: timed out Nov 25 19:29:13 thomsaudiohoek sh[698]: dhcpcd exited Nov 25 19:29:13 thomsaudiohoek dhcpcd[743]: dhcpcd exited Nov 25 19:29:13 thomsaudiohoek sh[698]: ifup: failed to bring up eth0 Nov 25 19:29:13 thomsaudiohoek systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE Nov 25 19:29:13 thomsaudiohoek systemd[1]: ifup@eth0.service: Failed with result 'exit-code'. Nov 25 19:29:15 thomsaudiohoek systemd[1]: systemd-hostnamed.service: Succeeded. Nov 25 19:29:20 thomsaudiohoek volumio[1246]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Nov 25 19:29:20 thomsaudiohoek volumio[1246]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Nov 25 19:29:20 thomsaudiohoek volumio[1246]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Nov 25 19:29:20 thomsaudiohoek volumio[1246]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Nov 25 19:29:20 thomsaudiohoek volumio[1246]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Nov 25 19:29:20 thomsaudiohoek volumio[1246]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Nov 25 19:29:20 thomsaudiohoek volumio[1246]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Nov 25 19:29:20 thomsaudiohoek volumio[1246]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Nov 25 19:29:20 thomsaudiohoek volumio[1246]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Nov 25 19:29:20 thomsaudiohoek volumio[1246]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Nov 25 19:29:20 thomsaudiohoek volumio[1246]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Nov 25 19:29:20 thomsaudiohoek volumio[1246]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Nov 25 19:29:20 thomsaudiohoek volumio[1246]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Nov 25 19:29:20 thomsaudiohoek volumio[1246]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Nov 25 19:29:20 thomsaudiohoek volumio[1246]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Nov 25 19:29:20 thomsaudiohoek volumio[1246]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Nov 25 19:29:20 thomsaudiohoek volumio[1246]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Nov 25 19:29:20 thomsaudiohoek volumio[1246]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Nov 25 19:29:20 thomsaudiohoek volumio[1246]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Nov 25 19:29:20 thomsaudiohoek volumio[1246]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Nov 25 19:29:20 thomsaudiohoek volumio[1246]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Nov 25 19:29:20 thomsaudiohoek volumio[1246]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Nov 25 19:29:20 thomsaudiohoek volumio[1246]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Nov 25 19:29:20 thomsaudiohoek volumio[1246]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Nov 25 19:29:20 thomsaudiohoek volumio[1246]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Nov 25 19:29:20 thomsaudiohoek volumio[1246]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Nov 25 19:29:20 thomsaudiohoek volumio[1246]: info: Adding plugin bluetooth to MyMusic Plugins Nov 25 19:29:20 thomsaudiohoek volumio[1246]: info: Adding plugin multiroom to MyMusic Plugins Nov 25 19:29:20 thomsaudiohoek volumio[1246]: info: Adding plugin metavolumio to MyMusic Plugins Nov 25 19:29:20 thomsaudiohoek volumio[1246]: info: Adding plugin cd_controller to MyMusic Plugins Nov 25 19:29:20 thomsaudiohoek volumio[1246]: info: Adding plugin smart_inputs to MyMusic Plugins Nov 25 19:29:20 thomsaudiohoek volumio[1246]: info: Adding plugin tidalconnect to MyMusic Plugins Nov 25 19:29:20 thomsaudiohoek volumio[1246]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Nov 25 19:29:20 thomsaudiohoek volumio[1246]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Nov 25 19:29:20 thomsaudiohoek volumio[1246]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Nov 25 19:29:20 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 25 19:29:20 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 25 19:29:20 thomsaudiohoek volumio[1246]: info: Starting MyVolumio Remote Streaming Endpoints Nov 25 19:29:20 thomsaudiohoek volumio[1246]: info: MyVolumio login type: Token Nov 25 19:29:20 thomsaudiohoek volumio[1246]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Nov 25 19:29:20 thomsaudiohoek volumio[1246]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Nov 25 19:29:20 thomsaudiohoek volumio[1246]: info: Starting Streaming Service Transparent Proxy Nov 25 19:29:20 thomsaudiohoek volumio[1246]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Nov 25 19:29:20 thomsaudiohoek volumio[1246]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Nov 25 19:29:20 thomsaudiohoek volumio[1246]: info: Streaming services startup Nov 25 19:29:20 thomsaudiohoek volumio[1246]: info: Starting Streaming Daemon Nov 25 19:29:20 thomsaudiohoek sudo[1628]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Nov 25 19:29:20 thomsaudiohoek sudo[1628]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:29:20 thomsaudiohoek sudo[1628]: pam_unix(sudo:session): session closed for user root Nov 25 19:29:20 thomsaudiohoek volumio[1246]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Nov 25 19:29:20 thomsaudiohoek volumio[1246]: error: Cannot start Volumio Streaming Daemon Nov 25 19:29:20 thomsaudiohoek volumio[1246]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Nov 25 19:29:20 thomsaudiohoek volumio[1246]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Nov 25 19:29:21 thomsaudiohoek volumio[1246]: STREAMING PROXY: Starting server on port 3245 Nov 25 19:29:21 thomsaudiohoek volumio[1246]: Node JS runtime: 14 Nov 25 19:29:21 thomsaudiohoek volumio[1246]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Nov 25 19:29:21 thomsaudiohoek volumio[1246]: info: MyVolumio token set successfully Nov 25 19:29:21 thomsaudiohoek volumio[1246]: info: MYVOLUMIO: Adding device Nov 25 19:29:21 thomsaudiohoek volumio[1246]: info: MYVOLUMIO: Evaluating Server Nov 25 19:29:22 thomsaudiohoek volumio[1246]: info: MyVolumio Plan changed: premium Nov 25 19:29:22 thomsaudiohoek volumio[1246]: info: [MyVolumio PluginManager] Subscribed plan changed to premium Nov 25 19:29:22 thomsaudiohoek volumio[1246]: info: Removing browser output: myVolumio user plan is not superstar Nov 25 19:29:22 thomsaudiohoek volumio[1246]: info: Removing audio output: Nov 25 19:29:22 thomsaudiohoek volumio[1246]: info: MYVOLUMIO: Adding device Nov 25 19:29:22 thomsaudiohoek volumio[1246]: info: MYVOLUMIO: Evaluating Server Nov 25 19:29:22 thomsaudiohoek volumio[1246]: info: Remote config written successfully Nov 25 19:29:22 thomsaudiohoek volumio[1246]: info: Starting Tunnel 1 Nov 25 19:29:22 thomsaudiohoek volumio[1246]: info: Starting Tunnel Connection Checker Nov 25 19:29:22 thomsaudiohoek volumio[1246]: info: Completed starting MyVolumio Plugin Nov 25 19:29:22 thomsaudiohoek volumio[1246]: info: MYVolumio Device enabled Nov 25 19:29:22 thomsaudiohoek volumio[1246]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins... Nov 25 19:29:22 thomsaudiohoek volumio[1246]: info: MyVolumio status changed Nov 25 19:29:22 thomsaudiohoek volumio[1246]: info: Streaming services startup Nov 25 19:29:22 thomsaudiohoek volumio[1246]: info: Starting Streaming Daemon Nov 25 19:29:22 thomsaudiohoek sudo[1681]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Nov 25 19:29:22 thomsaudiohoek sudo[1681]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:29:22 thomsaudiohoek volumio[1246]: info: Setting Geolocation for MyVolumio to eu6 Nov 25 19:29:22 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 25 19:29:22 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 25 19:29:22 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 25 19:29:22 thomsaudiohoek sudo[1681]: pam_unix(sudo:session): session closed for user root Nov 25 19:29:22 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid Nov 25 19:29:22 thomsaudiohoek volumio[1246]: error: [MyVolumio PluginManager] Cache data is invalid! Nov 25 19:29:22 thomsaudiohoek volumio[1246]: error: Cannot start Volumio Streaming Daemon Nov 25 19:29:22 thomsaudiohoek volumio[1246]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Nov 25 19:29:22 thomsaudiohoek volumio[1246]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Nov 25 19:29:22 thomsaudiohoek volumio[1246]: info: Setting Geolocation for MyVolumio to eu4 Nov 25 19:29:22 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 25 19:29:22 thomsaudiohoek volumio[1246]: info: Successfully Added MyVolumio device Nov 25 19:29:23 thomsaudiohoek volumio[1246]: info: Successfully Added MyVolumio device Nov 25 19:29:23 thomsaudiohoek volumio[1246]: info: Updating MyVolumio device info Nov 25 19:29:23 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 25 19:29:23 thomsaudiohoek volumio[1246]: info: Updating MyVolumio device info Nov 25 19:29:23 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 25 19:29:23 thomsaudiohoek volumio[1246]: info: Successfully Updated MyVolumio device Nov 25 19:29:23 thomsaudiohoek volumio[1246]: info: [MyVolumio PluginManager] Loading plugin "bluetooth"... Nov 25 19:29:23 thomsaudiohoek volumio[1246]: info: [1732559363971] Starting BluetoothController Nov 25 19:29:23 thomsaudiohoek volumio[1246]: info: [MyVolumio PluginManager] Loading plugin "multiroom"... Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin multiroom Nov 25 19:29:24 thomsaudiohoek sudo[1684]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom Nov 25 19:29:24 thomsaudiohoek sudo[1684]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:29:24 thomsaudiohoek sudo[1684]: pam_unix(sudo:session): session closed for user root Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: MRS: MultiRoom plugin initialized Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: MRS: STOPPING SNAPCLIENT Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: MRS: Snap server stop Nov 25 19:29:24 thomsaudiohoek sudo[1700]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient Nov 25 19:29:24 thomsaudiohoek sudo[1700]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: MRS: STOPPING volumioStreaming Nov 25 19:29:24 thomsaudiohoek sudo[1703]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver Nov 25 19:29:24 thomsaudiohoek sudo[1703]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:29:24 thomsaudiohoek sudo[1700]: pam_unix(sudo:session): session closed for user root Nov 25 19:29:24 thomsaudiohoek sudo[1703]: pam_unix(sudo:session): session closed for user root Nov 25 19:29:24 thomsaudiohoek sudo[1706]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming Nov 25 19:29:24 thomsaudiohoek sudo[1706]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: [MyVolumio PluginManager] Loading plugin "metavolumio"... Nov 25 19:29:24 thomsaudiohoek sudo[1709]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Nov 25 19:29:24 thomsaudiohoek sudo[1709]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:29:24 thomsaudiohoek sudo[1709]: pam_unix(sudo:session): session closed for user root Nov 25 19:29:24 thomsaudiohoek sudo[1706]: pam_unix(sudo:session): session closed for user root Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: [MyVolumio PluginManager] Loading plugin "manifestui"... Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: [MyVolumio PluginManager] Loading plugin "cd_controller"... Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: [MyVolumio PluginManager] Loading plugin "smart_inputs"... Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: [MyVolumio PluginManager] Loading plugin "hi_res_audio"... Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin hi_res_audio Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: [MyVolumio PluginManager] Loading plugin "tidal"... Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: [MyVolumio PluginManager] Loading plugin "qobuz"... Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: [MyVolumio PluginManager] Loading plugin "tidalconnect"... Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: Preparing to generate the ALSA configuration file Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: Reading ALSA contributions from plugins. Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: Successfully Updated MyVolumio device Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: MRS: Removed streaming files Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: MRS: volumioStreaming STOPPED Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: MRS: SNAPSERVER STOPPED Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: MRS: SNAPCLIENT STOPPED Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: Asound.conf file unchanged, so no further update is needed Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: Output device has changed, restarting MPD Nov 25 19:29:24 thomsaudiohoek sudo[1712]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 25 19:29:24 thomsaudiohoek sudo[1712]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: Output device has changed, restarting Shairport Sync Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 25 19:29:24 thomsaudiohoek sudo[1712]: pam_unix(sudo:session): session closed for user root Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Nov 25 19:29:24 thomsaudiohoek sudo[1715]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 25 19:29:24 thomsaudiohoek sudo[1715]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: [MyVolumio PluginManager] Starting plugin audio_interface.bluetooth Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 25 19:29:24 thomsaudiohoek systemd[1]: Stopping Music Player Daemon... Nov 25 19:29:24 thomsaudiohoek systemd[1]: mpd.service: Succeeded. Nov 25 19:29:24 thomsaudiohoek systemd[1]: Stopped Music Player Daemon. Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: [MyVolumio PluginManager] Starting plugin audio_interface.multiroom Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: [MyVolumio PluginManager] Plugin multiroom disabled by user. Not starting Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: [MyVolumio PluginManager] Starting plugin miscellanea.metavolumio Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: Adding METAVOLUMIO REST API Endpoints Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: [MyVolumio PluginManager] Starting plugin miscellanea.manifestui Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: [MyVolumio PluginManager] Starting plugin music_service.cd_controller Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: Preparing CD Folders Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: Adding CD REST API Endpoints Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: Starting UDEV Watcher for CD Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: Detecting CD presence with UDEV Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: networkfs , getUdevDevices Nov 25 19:29:24 thomsaudiohoek systemd[1]: Starting Music Player Daemon... Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: [MyVolumio PluginManager] Starting plugin music_service.smart_inputs Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: Adding inputs REST Endpoints Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: Adding scanAudioInputs REST Endpoint for plugin: music_service/smart_inputs Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: Scanning Audio Inputs Nov 25 19:29:24 thomsaudiohoek sudo[1723]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/hciconfig hci0 name ThomsAudioHoek Nov 25 19:29:24 thomsaudiohoek sudo[1723]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:29:24 thomsaudiohoek sudo[1723]: pam_unix(sudo:session): session closed for user root Nov 25 19:29:24 thomsaudiohoek sudo[1724]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 25 19:29:24 thomsaudiohoek sudo[1724]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:29:24 thomsaudiohoek sudo[1724]: pam_unix(sudo:session): session closed for user root Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: Checking against Known Cards name Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: Adding Server instance for streaming Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: [MyVolumio PluginManager] Starting plugin music_service.hi_res_audio Nov 25 19:29:24 thomsaudiohoek volumio[1246]: error: Hi Res Audio Failed Login: Missing Login Data Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: Adding HIGHRESAUDIO REST API Endpoints Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: Adding getStreamUrlhi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: [MyVolumio PluginManager] Starting plugin music_service.tidal Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuz Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: [MyVolumio PluginManager] Starting plugin music_service.tidalconnect Nov 25 19:29:24 thomsaudiohoek sudo[1731]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Nov 25 19:29:24 thomsaudiohoek sudo[1731]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:29:24 thomsaudiohoek sudo[1731]: pam_unix(sudo:session): session closed for user root Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: Stopping AccessToken refresher cron Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: AccessToken refresher cron started Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: Stopping AccessToken refresher cron for QOBUZ Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: AccessToken refresher cron started for QOBUZ Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: Adding TIDAL REST API Endpoints Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: Adding getStreamUrltidal REST Endpoint for plugin: music_service/tidal Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: Adding QOBUZ REST API Endpoints Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: Adding getStreamUrlqobuz REST Endpoint for plugin: music_service/qobuz Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: Bluetooth name changed to ThomsAudioHoek Nov 25 19:29:24 thomsaudiohoek volumio[1246]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: MPD Permissions set Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::volumioGetState Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: CorePlayQueue::getTrack 0 Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: Starting Shairport Sync Nov 25 19:29:24 thomsaudiohoek sudo[1739]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 25 19:29:24 thomsaudiohoek sudo[1739]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:29:24 thomsaudiohoek systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Nov 25 19:29:24 thomsaudiohoek systemd[1]: shairport-sync.service: Succeeded. Nov 25 19:29:24 thomsaudiohoek systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: AutoStart - Plugin is starting Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::volumioGetQueue Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: CoreStateMachine::getQueue Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: CorePlayQueue::getQueue Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: AutoStart - start playing Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: AutoStart - start playing with no specific position Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::volumioPlay Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: CoreStateMachine::play index 0 Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: CoreStateMachine::stop Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: CoreStateMachine::play index undefined Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: CorePlayQueue::getTrack 0 Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: CoreStateMachine::startPlaybackTimer Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: CorePlayQueue::getTrack 0 Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::volumioGetVisibleSources Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Nov 25 19:29:24 thomsaudiohoek volumio[1246]: verbose: ControllerMpd::sendMpdCommand stop Nov 25 19:29:24 thomsaudiohoek volumio[1246]: error: MPD error: Error: This socket has been ended by the other party Nov 25 19:29:24 thomsaudiohoek volumio[1246]: error: This socket has been ended by the other party {"code":"EPIPE"} Nov 25 19:29:24 thomsaudiohoek volumio[1246]: error: MPD error: Error: This socket has been ended by the other party Nov 25 19:29:24 thomsaudiohoek volumio[1246]: error: This socket has been ended by the other party {"code":"EPIPE"} Nov 25 19:29:24 thomsaudiohoek volumio[1246]: error: MPD error: Error: This socket has been ended by the other party Nov 25 19:29:24 thomsaudiohoek volumio[1246]: error: This socket has been ended by the other party {"code":"EPIPE"} Nov 25 19:29:24 thomsaudiohoek systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Nov 25 19:29:24 thomsaudiohoek sudo[1739]: pam_unix(sudo:session): session closed for user root Nov 25 19:29:24 thomsaudiohoek volumio[1246]: info: Shairport-Sync Started Nov 25 19:29:24 thomsaudiohoek mpd[1729]: Nov 25 19:29 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Nov 25 19:29:25 thomsaudiohoek systemd[1]: Started Music Player Daemon. Nov 25 19:29:25 thomsaudiohoek sudo[1715]: pam_unix(sudo:session): session closed for user root Nov 25 19:29:25 thomsaudiohoek volumio[1246]: error: updateQueue error: null Nov 25 19:29:25 thomsaudiohoek volumio[1597]: .........................................................................................................................................................................................................................................................................++++ Nov 25 19:29:25 thomsaudiohoek volumio[1597]: ..........++++ Nov 25 19:29:25 thomsaudiohoek volumio[1597]: e is 65537 (0x010001) Nov 25 19:29:25 thomsaudiohoek volumio[1597]: writing RSA key Nov 25 19:29:27 thomsaudiohoek sudo[1784]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service Nov 25 19:29:27 thomsaudiohoek sudo[1784]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:29:27 thomsaudiohoek systemd[1]: Started MyVolumio SSH Tunnel. Nov 25 19:29:27 thomsaudiohoek sudo[1784]: pam_unix(sudo:session): session closed for user root Nov 25 19:29:27 thomsaudiohoek volumio[1246]: info: Remote SSH Started Nov 25 19:29:27 thomsaudiohoek autossh[1787]: port set to 0, monitoring disabled Nov 25 19:29:27 thomsaudiohoek autossh[1787]: starting ssh (count 1) Nov 25 19:29:27 thomsaudiohoek autossh[1787]: ssh child pid is 1790 Nov 25 19:29:27 thomsaudiohoek volumio[1246]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Nov 25 19:29:27 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::volumioGetState Nov 25 19:29:27 thomsaudiohoek volumio[1246]: info: CorePlayQueue::getTrack 0 Nov 25 19:29:27 thomsaudiohoek sudo[1792]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service Nov 25 19:29:27 thomsaudiohoek sudo[1792]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:29:27 thomsaudiohoek systemd[1]: Started Volumio Bluetooth Module. Nov 25 19:29:27 thomsaudiohoek sudo[1792]: pam_unix(sudo:session): session closed for user root Nov 25 19:29:27 thomsaudiohoek volumio[1246]: info: Volumio BT Module successfully started Nov 25 19:29:27 thomsaudiohoek sudo[1795]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /var/lib/bluetooth/* Nov 25 19:29:27 thomsaudiohoek sudo[1795]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:29:27 thomsaudiohoek volumiobt[1794]: /bin/chmod: cannot access '/var/lib/bluetooth/*': No such file or directory Nov 25 19:29:27 thomsaudiohoek sudo[1795]: pam_unix(sudo:session): session closed for user root Nov 25 19:29:27 thomsaudiohoek volumio[1246]: info: TidalConnect service stoped! Nov 25 19:29:27 thomsaudiohoek volumio[1246]: info: Adding tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Nov 25 19:29:27 thomsaudiohoek volumio[1246]: info: Adding tc_connect REST Endpoint for plugin: music_service/tidalconnect Nov 25 19:29:27 thomsaudiohoek sudo[1807]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Nov 25 19:29:27 thomsaudiohoek sudo[1807]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:29:27 thomsaudiohoek systemd[1]: Started Volumio Tidal Connect Service. Nov 25 19:29:27 thomsaudiohoek sudo[1807]: pam_unix(sudo:session): session closed for user root Nov 25 19:29:27 thomsaudiohoek volumio[1246]: info: Executing endpoint tc_getconfig Nov 25 19:29:27 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Nov 25 19:29:27 thomsaudiohoek vtcs[1809]: STARTING TidalConnect services, version: 1.4.0.34 Nov 25 19:29:27 thomsaudiohoek vtcs[1809]: STARTED TidalConnect services. Nov 25 19:29:27 thomsaudiohoek volumio[1246]: info: Executing endpoint tc_connect Nov 25 19:29:27 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Nov 25 19:29:27 thomsaudiohoek volumio[1246]: info: Connecting to TidalConnect Nov 25 19:29:27 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::servicePushState Nov 25 19:29:27 thomsaudiohoek volumio[1246]: info: CoreStateMachine::pushState Nov 25 19:29:27 thomsaudiohoek volumio[1246]: info: CorePlayQueue::getTrack 0 Nov 25 19:29:27 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 25 19:29:27 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::volumioPushState Nov 25 19:29:27 thomsaudiohoek volumio[1246]: info: CorePlayQueue::getTrack 0 Nov 25 19:29:27 thomsaudiohoek volumio[1246]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received tidalconnect Nov 25 19:29:27 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::servicePushState Nov 25 19:29:27 thomsaudiohoek volumio[1246]: info: CoreStateMachine::pushState Nov 25 19:29:27 thomsaudiohoek volumio[1246]: info: CorePlayQueue::getTrack 0 Nov 25 19:29:27 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::volumioPushState Nov 25 19:29:27 thomsaudiohoek volumio[1246]: info: CorePlayQueue::getTrack 0 Nov 25 19:29:27 thomsaudiohoek volumio[1246]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received tidalconnect Nov 25 19:29:28 thomsaudiohoek sudo[1828]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall pulseaudio Nov 25 19:29:28 thomsaudiohoek sudo[1828]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:29:28 thomsaudiohoek volumiobt[1794]: pulseaudio: no process found Nov 25 19:29:28 thomsaudiohoek sudo[1828]: pam_unix(sudo:session): session closed for user root Nov 25 19:29:28 thomsaudiohoek dbus-daemon[737]: [system] Activating via systemd: service name='org.freedesktop.RealtimeKit1' unit='rtkit-daemon.service' requested by ':1.20' (uid=1000 pid=1832 comm="/usr/bin/pulseaudio --high-priority=true ") Nov 25 19:29:28 thomsaudiohoek systemd[1]: Starting RealtimeKit Scheduling Policy Service... Nov 25 19:29:28 thomsaudiohoek volumio[1246]: ------------------------------------ BT MESSAGE: BT STATUS: running Nov 25 19:29:28 thomsaudiohoek dbus-daemon[737]: [system] Successfully activated service 'org.freedesktop.RealtimeKit1' Nov 25 19:29:28 thomsaudiohoek systemd[1]: Started RealtimeKit Scheduling Policy Service. Nov 25 19:29:28 thomsaudiohoek rtkit-daemon[1833]: Successfully called chroot. Nov 25 19:29:28 thomsaudiohoek rtkit-daemon[1833]: Successfully dropped privileges. Nov 25 19:29:28 thomsaudiohoek rtkit-daemon[1833]: Successfully limited resources. Nov 25 19:29:28 thomsaudiohoek rtkit-daemon[1833]: Running. Nov 25 19:29:28 thomsaudiohoek rtkit-daemon[1833]: Canary thread running. Nov 25 19:29:28 thomsaudiohoek rtkit-daemon[1833]: Watchdog thread running. Nov 25 19:29:28 thomsaudiohoek dbus-daemon[737]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.21' (uid=0 pid=1833 comm="/usr/lib/rtkit/rtkit-daemon ") Nov 25 19:29:28 thomsaudiohoek systemd[1]: Starting Authorization Manager... Nov 25 19:29:28 thomsaudiohoek volumio[1246]: ------------------------------------ BT MESSAGE: BT STATUS: running Nov 25 19:29:28 thomsaudiohoek polkitd[1837]: started daemon version 0.105 using authority implementation `local' version `0.105' Nov 25 19:29:28 thomsaudiohoek dbus-daemon[737]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Nov 25 19:29:28 thomsaudiohoek systemd[1]: Started Authorization Manager. Nov 25 19:29:28 thomsaudiohoek pulseaudio[1832]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Nov 25 19:29:28 thomsaudiohoek pulseaudio[1832]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Nov 25 19:29:28 thomsaudiohoek bluetoothd[1079]: Endpoint registered: sender=:1.41 path=/MediaEndpoint/A2DPSource Nov 25 19:29:28 thomsaudiohoek bluetoothd[1079]: Endpoint registered: sender=:1.41 path=/MediaEndpoint/A2DPSink Nov 25 19:29:28 thomsaudiohoek volumiobt[1794]: Applying permissions Nov 25 19:29:28 thomsaudiohoek volumiobt[1794]: Setting BT discoverable and pairable Nov 25 19:29:28 thomsaudiohoek pulseaudio[1832]: Failed to register as a handsfree audio agent with ofono: org.freedesktop.DBus.Error.ServiceUnknown: The name org.ofono was not provided by any .service files Nov 25 19:29:28 thomsaudiohoek volumiobt[1794]: Agent registered Nov 25 19:29:28 thomsaudiohoek kernel: Bluetooth: RFCOMM TTY layer initialized Nov 25 19:29:28 thomsaudiohoek kernel: Bluetooth: RFCOMM socket layer initialized Nov 25 19:29:28 thomsaudiohoek kernel: Bluetooth: RFCOMM ver 1.11 Nov 25 19:29:28 thomsaudiohoek volumiobt[1794]: [bluetooth]# -e power on Nov 25 19:29:28 thomsaudiohoek volumiobt[1794]: Invalid command in menu main: -e Nov 25 19:29:28 thomsaudiohoek volumiobt[1794]: Nov 25 19:29:28 thomsaudiohoek volumiobt[1794]: Use "help" for a list of available commands in a menu. Nov 25 19:29:28 thomsaudiohoek volumiobt[1794]: Use "menu " if you want to enter any submenu. Nov 25 19:29:28 thomsaudiohoek volumiobt[1794]: Use "back" if you want to return to menu main. Nov 25 19:29:28 thomsaudiohoek volumiobt[1794]: [bluetooth]# agent on Nov 25 19:29:28 thomsaudiohoek volumiobt[1794]: Agent is already registered Nov 25 19:29:28 thomsaudiohoek volumiobt[1794]: [bluetooth]# discoverable on Nov 25 19:29:28 thomsaudiohoek volumiobt[1794]: [bluetooth]# pairable on Nov 25 19:29:28 thomsaudiohoek volumiobt[1794]: [bluetooth]# agent NoInputNoOutput Nov 25 19:29:28 thomsaudiohoek volumiobt[1794]: Agent is already registered Nov 25 19:29:28 thomsaudiohoek volumiobt[1794]: [bluetooth]# default-agent Nov 25 19:29:28 thomsaudiohoek volumiobt[1794]: [bluetooth]# quit Nov 25 19:29:28 thomsaudiohoek volumiobt[1794]: [59B blob data] Nov 25 19:29:30 thomsaudiohoek volumio[1246]: info: TidalConnect service started! Nov 25 19:29:30 thomsaudiohoek volumio[1246]: [Metrics] CommandRouter: 29s 119.64ms Nov 25 19:29:30 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::volumiosetStartupVolume Nov 25 19:29:30 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 19:29:30 thomsaudiohoek volumio[1246]: info: VolumeController:: Setting startup Volume 60 Nov 25 19:29:30 thomsaudiohoek volumio[1246]: info: VolumeController::SetAlsaVolume60 Nov 25 19:29:30 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 25 19:29:30 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::Close All Modals sent Nov 25 19:29:30 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::Close All Modals sent Nov 25 19:29:30 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::volumioGetState Nov 25 19:29:30 thomsaudiohoek volumio[1246]: info: CorePlayQueue::getTrack 0 Nov 25 19:29:30 thomsaudiohoek volumio[1246]: info: CoreStateMachine::pushState Nov 25 19:29:30 thomsaudiohoek volumio[1246]: info: CorePlayQueue::getTrack 0 Nov 25 19:29:30 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 25 19:29:30 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::volumioPushState Nov 25 19:29:30 thomsaudiohoek volumio[1246]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Nov 25 19:29:30 thomsaudiohoek volumio[1246]: info: FusionDsp - ---- read samplerate from file: 44100 Nov 25 19:29:30 thomsaudiohoek volumio[1246]: info: camilladsp stopping service pid 1558... Nov 25 19:29:30 thomsaudiohoek volumio[1246]: info: camilladsp service terminated, instance 1 Nov 25 19:29:30 thomsaudiohoek volumio[1246]: info: FusionDsp - If filter freq >samplerate/2 then disable it Nov 25 19:29:30 thomsaudiohoek volumio[1246]: info: camilladsp service started and running in background, instance 1 Nov 25 19:29:30 thomsaudiohoek volumio[1246]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Nov 25 19:29:30 thomsaudiohoek volumio[1246]: info: FusionDsp - ---- read samplerate from file: 44100 Nov 25 19:29:30 thomsaudiohoek volumio[1246]: info: FusionDsp - If filter freq >samplerate/2 then disable it Nov 25 19:29:30 thomsaudiohoek volumio[1246]: error: FusionDsp - WebSocket error: [object Object] Nov 25 19:29:30 thomsaudiohoek volumio[1246]: info: camilladsp spawned new process with pid 1853, instance 1, run: true Nov 25 19:29:31 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Nov 25 19:29:31 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Nov 25 19:29:31 thomsaudiohoek volumio[1246]: xcb_connection_has_error() returned true Nov 25 19:29:31 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Nov 25 19:29:31 thomsaudiohoek volumio[1246]: info: Version has changed, forcing UI Reload Nov 25 19:29:31 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::Reload Ui Nov 25 19:29:32 thomsaudiohoek sudo[1863]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 25 19:29:32 thomsaudiohoek sudo[1863]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:29:32 thomsaudiohoek sudo[1863]: pam_unix(sudo:session): session closed for user root Nov 25 19:29:32 thomsaudiohoek sudo[1866]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 25 19:29:32 thomsaudiohoek sudo[1866]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:29:32 thomsaudiohoek sudo[1866]: pam_unix(sudo:session): session closed for user root Nov 25 19:29:32 thomsaudiohoek volumio[1246]: verbose: New Socket.io Connection to 192.168.68.65 from 192.168.68.76 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/131.0.0.0 Safari/537.36 Edg/131.0.0.0 Engine version: 3 Transport: polling Total Clients: 8 Nov 25 19:29:32 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 25 19:29:32 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Nov 25 19:29:32 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::volumioGetState Nov 25 19:29:32 thomsaudiohoek volumio[1246]: info: CorePlayQueue::getTrack 0 Nov 25 19:29:32 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Nov 25 19:29:32 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Nov 25 19:29:32 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Nov 25 19:29:32 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Nov 25 19:29:32 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Nov 25 19:29:32 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Nov 25 19:29:32 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableUIs Nov 25 19:29:32 thomsaudiohoek volumio[1246]: info: Received Get System Version Nov 25 19:29:32 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 25 19:29:32 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: appearance , getBackgrounds Nov 25 19:29:34 thomsaudiohoek systemd[1]: systemd-timedated.service: Succeeded. Nov 25 19:29:34 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 25 19:29:34 thomsaudiohoek volumio[1246]: info: Received Get System Info Nov 25 19:29:34 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 25 19:29:34 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 25 19:29:34 thomsaudiohoek volumio[1246]: info: Discovery: Getting this device information Nov 25 19:29:34 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::volumioGetState Nov 25 19:29:34 thomsaudiohoek volumio[1246]: info: CorePlayQueue::getTrack 0 Nov 25 19:29:34 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 25 19:29:34 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 25 19:29:34 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 25 19:29:34 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Nov 25 19:29:34 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Nov 25 19:29:34 thomsaudiohoek volumio-remote-updater[763]: Test mode enabled Nov 25 19:29:34 thomsaudiohoek volumio-remote-updater[763]: No alpha test mode Nov 25 19:29:35 thomsaudiohoek volumio[1246]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Nov 25 19:29:35 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Nov 25 19:29:35 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 25 19:29:35 thomsaudiohoek volumio[1246]: info: Received Get System Info Nov 25 19:29:35 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 25 19:29:35 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 25 19:29:35 thomsaudiohoek volumio[1246]: info: Discovery: Getting this device information Nov 25 19:29:35 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::volumioGetState Nov 25 19:29:35 thomsaudiohoek volumio[1246]: info: CorePlayQueue::getTrack 0 Nov 25 19:29:35 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 25 19:29:35 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Nov 25 19:29:35 thomsaudiohoek volumio[1246]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Nov 25 19:29:35 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::volumioGetState Nov 25 19:29:35 thomsaudiohoek volumio[1246]: info: CorePlayQueue::getTrack 0 Nov 25 19:29:36 thomsaudiohoek volumio[1246]: info: camilladsp spawned new process with pid 1904, instance 1, run: true Nov 25 19:29:37 thomsaudiohoek volumio[1246]: info: BOOT COMPLETED Nov 25 19:29:40 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 19:29:40 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 25 19:29:40 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Nov 25 19:29:40 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Nov 25 19:29:40 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Nov 25 19:29:40 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::volumioGetBrowseSources Nov 25 19:29:40 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 25 19:29:45 thomsaudiohoek volumio-remote-updater[763]: Test mode enabled Nov 25 19:29:45 thomsaudiohoek volumio-remote-updater[763]: No alpha test mode Nov 25 19:29:45 thomsaudiohoek volumio[1246]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Nov 25 19:29:45 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Nov 25 19:29:48 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::Close All Modals sent Nov 25 19:29:50 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Nov 25 19:29:50 thomsaudiohoek volumio[1246]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Nov 25 19:29:50 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Nov 25 19:29:50 thomsaudiohoek volumio[1246]: info: Received Get System Version Nov 25 19:29:50 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 25 19:29:50 thomsaudiohoek volumio[1246]: info: Received Get System Info Nov 25 19:29:50 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 25 19:29:50 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 25 19:29:50 thomsaudiohoek volumio[1246]: info: Discovery: Getting this device information Nov 25 19:29:50 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::volumioGetState Nov 25 19:29:50 thomsaudiohoek volumio[1246]: info: CorePlayQueue::getTrack 0 Nov 25 19:29:50 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 25 19:29:50 thomsaudiohoek ntpd[967]: Soliciting pool server 193.123.56.220 Nov 25 19:29:51 thomsaudiohoek ntpd[967]: Soliciting pool server 178.239.19.60 Nov 25 19:29:52 thomsaudiohoek ntpd[967]: Soliciting pool server 193.123.37.231 Nov 25 19:29:52 thomsaudiohoek ntpd[967]: Soliciting pool server 194.104.0.153 Nov 25 19:29:52 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 25 19:29:52 thomsaudiohoek volumio[1246]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Nov 25 19:29:52 thomsaudiohoek volumio[1246]: info: Listing playlists Nov 25 19:29:52 thomsaudiohoek ntpd[967]: Soliciting pool server 149.210.142.45 Nov 25 19:29:52 thomsaudiohoek ntpd[967]: Soliciting pool server 144.21.38.190 Nov 25 19:29:52 thomsaudiohoek ntpd[967]: Soliciting pool server 5.255.124.190 Nov 25 19:29:53 thomsaudiohoek ntpd[967]: Soliciting pool server 174.138.107.7 Nov 25 19:29:53 thomsaudiohoek ntpd[967]: Soliciting pool server 178.239.19.61 Nov 25 19:29:53 thomsaudiohoek ntpd[967]: Soliciting pool server 178.215.228.24 Nov 25 19:29:53 thomsaudiohoek ntpd[967]: Soliciting pool server 162.159.200.1 Nov 25 19:29:53 thomsaudiohoek ntpd[967]: Soliciting pool server 83.98.155.30 Nov 25 19:29:54 thomsaudiohoek ntpd[967]: Soliciting pool server 84.82.15.107 Nov 25 19:29:54 thomsaudiohoek ntpd[967]: Soliciting pool server 45.83.205.227 Nov 25 19:29:54 thomsaudiohoek ntpd[967]: Soliciting pool server 158.101.216.150 Nov 25 19:29:55 thomsaudiohoek ntpd[967]: Soliciting pool server 94.198.159.15 Nov 25 19:29:55 thomsaudiohoek ntpd[967]: Soliciting pool server 185.51.192.63 Nov 25 19:29:55 thomsaudiohoek ntpd[967]: Soliciting pool server 185.224.145.68 Nov 25 19:29:57 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::volumioPlay Nov 25 19:29:57 thomsaudiohoek volumio[1246]: info: CoreStateMachine::play index undefined Nov 25 19:29:57 thomsaudiohoek volumio[1246]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 25 19:29:57 thomsaudiohoek volumio[1246]: info: CorePlayQueue::getTrack 0 Nov 25 19:29:57 thomsaudiohoek volumio[1246]: info: CoreStateMachine::startPlaybackTimer Nov 25 19:29:57 thomsaudiohoek volumio[1246]: info: CorePlayQueue::getTrack 0 Nov 25 19:29:57 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::volumioGetVisibleSources Nov 25 19:29:57 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 25 19:29:57 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Nov 25 19:29:57 thomsaudiohoek volumio[1246]: verbose: ControllerMpd::sendMpdCommand stop Nov 25 19:29:57 thomsaudiohoek volumio[1246]: info: sendMpdCommand stop took 1 milliseconds Nov 25 19:29:57 thomsaudiohoek volumio[1246]: verbose: ControllerMpd::sendMpdCommand clear Nov 25 19:29:57 thomsaudiohoek volumio[1246]: info: Nov 25 19:29:57 thomsaudiohoek volumio[1246]: ---------------------------- MPD announces system playlist update Nov 25 19:29:57 thomsaudiohoek volumio[1246]: info: Ignoring MPD Status Update Nov 25 19:29:57 thomsaudiohoek volumio[1246]: info: sendMpdCommand clear took 1 milliseconds Nov 25 19:29:57 thomsaudiohoek volumio[1246]: verbose: ControllerMpd::sendMpdCommand consume 1 Nov 25 19:29:57 thomsaudiohoek volumio[1246]: error: updateQueue error: null Nov 25 19:29:57 thomsaudiohoek volumio[1246]: info: Nov 25 19:29:57 thomsaudiohoek volumio[1246]: ---------------------------- MPD announces state update: options Nov 25 19:29:57 thomsaudiohoek volumio[1246]: info: ------------------------------ 2ms Nov 25 19:29:57 thomsaudiohoek volumio[1246]: info: sendMpdCommand consume 1 took 1 milliseconds Nov 25 19:29:57 thomsaudiohoek volumio[1246]: info: ControllerMpd::getState Nov 25 19:29:57 thomsaudiohoek volumio[1246]: verbose: ControllerMpd::sendMpdCommand status Nov 25 19:29:57 thomsaudiohoek volumio[1246]: info: [1732559397084] [RadioParadise] set to consume mode, adding url: https://stream.radioparadise.com/mellow-flac Nov 25 19:29:57 thomsaudiohoek volumio[1246]: verbose: ControllerMpd::sendMpdCommand add "https://stream.radioparadise.com/mellow-flac" Nov 25 19:29:57 thomsaudiohoek volumio[1246]: info: Nov 25 19:29:57 thomsaudiohoek volumio[1246]: ---------------------------- MPD announces system playlist update Nov 25 19:29:57 thomsaudiohoek volumio[1246]: info: Ignoring MPD Status Update Nov 25 19:29:57 thomsaudiohoek volumio[1246]: info: sendMpdCommand status took 1 milliseconds Nov 25 19:29:57 thomsaudiohoek volumio[1246]: info: sendMpdCommand add "https://stream.radioparadise.com/mellow-flac" took 1 milliseconds Nov 25 19:29:57 thomsaudiohoek volumio[1246]: verbose: ControllerMpd::parseState Nov 25 19:29:57 thomsaudiohoek volumio[1246]: verbose: ControllerMpd::sendMpdCommand play Nov 25 19:29:57 thomsaudiohoek volumio[1246]: info: ControllerMpd::pushState Nov 25 19:29:57 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::servicePushState Nov 25 19:29:57 thomsaudiohoek volumio[1246]: info: CoreStateMachine::pushState Nov 25 19:29:57 thomsaudiohoek volumio[1246]: info: CorePlayQueue::getTrack 0 Nov 25 19:29:57 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 25 19:29:57 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::volumioPushState Nov 25 19:29:57 thomsaudiohoek volumio[1246]: info: CorePlayQueue::getTrack 0 Nov 25 19:29:57 thomsaudiohoek volumio[1246]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Nov 25 19:29:57 thomsaudiohoek volumio[1246]: info: ------------------------------ 10ms Nov 25 19:29:57 thomsaudiohoek volumio[1246]: info: ------------------------------ 10ms Nov 25 19:29:57 thomsaudiohoek volumio[1246]: info: sendMpdCommand play took 6 milliseconds Nov 25 19:29:57 thomsaudiohoek volumio[1246]: info: [1732559397095] [RadioParadise] getMetadata started with url https://api.radioparadise.com/api/now_playing?chan=1 Nov 25 19:29:57 thomsaudiohoek volumio[1246]: info: Nov 25 19:29:57 thomsaudiohoek volumio[1246]: ---------------------------- MPD announces state update: player Nov 25 19:29:57 thomsaudiohoek volumio[1246]: info: ControllerMpd::getState Nov 25 19:29:57 thomsaudiohoek volumio[1246]: verbose: ControllerMpd::sendMpdCommand status Nov 25 19:29:57 thomsaudiohoek volumio[1246]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Nov 25 19:29:57 thomsaudiohoek volumio[1246]: info: FusionDsp - ---- read samplerate from file: 44100 Nov 25 19:29:57 thomsaudiohoek volumio[1246]: info: FusionDsp - If filter freq >samplerate/2 then disable it Nov 25 19:29:57 thomsaudiohoek volumio[1246]: info: Nov 25 19:29:57 thomsaudiohoek volumio[1246]: ---------------------------- MPD announces state update: player Nov 25 19:29:57 thomsaudiohoek volumio[1246]: info: sendMpdCommand status took 9 milliseconds Nov 25 19:29:57 thomsaudiohoek volumio[1246]: info: ControllerMpd::getState Nov 25 19:29:57 thomsaudiohoek volumio[1246]: verbose: ControllerMpd::sendMpdCommand status Nov 25 19:29:57 thomsaudiohoek volumio[1246]: verbose: ControllerMpd::parseState Nov 25 19:29:57 thomsaudiohoek volumio[1246]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 25 19:29:57 thomsaudiohoek volumio[1246]: info: sendMpdCommand status took 1 milliseconds Nov 25 19:29:57 thomsaudiohoek volumio[1246]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 25 19:29:57 thomsaudiohoek volumio[1246]: verbose: ControllerMpd::parseState Nov 25 19:29:57 thomsaudiohoek volumio[1246]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 25 19:29:57 thomsaudiohoek volumio[1246]: verbose: ControllerMpd::parseTrackInfo Nov 25 19:29:57 thomsaudiohoek volumio[1246]: info: ControllerMpd::pushState Nov 25 19:29:57 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::servicePushState Nov 25 19:29:57 thomsaudiohoek volumio[1246]: info: CorePlayQueue::getTrack 0 Nov 25 19:29:57 thomsaudiohoek volumio[1246]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Nov 25 19:29:57 thomsaudiohoek volumio[1246]: info: ------------------------------ 12ms Nov 25 19:29:57 thomsaudiohoek volumio[1246]: info: Nov 25 19:29:57 thomsaudiohoek volumio[1246]: ---------------------------- MPD announces system playlist update Nov 25 19:29:57 thomsaudiohoek volumio[1246]: info: Ignoring MPD Status Update Nov 25 19:29:57 thomsaudiohoek volumio[1246]: info: Nov 25 19:29:57 thomsaudiohoek volumio[1246]: ---------------------------- MPD announces state update: player Nov 25 19:29:57 thomsaudiohoek volumio[1246]: info: sendMpdCommand playlistinfo took 2 milliseconds Nov 25 19:29:57 thomsaudiohoek volumio[1246]: info: ControllerMpd::getState Nov 25 19:29:57 thomsaudiohoek volumio[1246]: verbose: ControllerMpd::sendMpdCommand status Nov 25 19:29:57 thomsaudiohoek volumio[1246]: verbose: ControllerMpd::parseTrackInfo Nov 25 19:29:57 thomsaudiohoek volumio[1246]: info: ControllerMpd::pushState Nov 25 19:29:57 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::servicePushState Nov 25 19:29:57 thomsaudiohoek volumio[1246]: info: CorePlayQueue::getTrack 0 Nov 25 19:29:57 thomsaudiohoek volumio[1246]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Nov 25 19:29:57 thomsaudiohoek volumio[1246]: info: ------------------------------ 5ms Nov 25 19:29:57 thomsaudiohoek volumio[1246]: info: ------------------------------ 4ms Nov 25 19:29:57 thomsaudiohoek volumio[1246]: info: sendMpdCommand status took 3 milliseconds Nov 25 19:29:57 thomsaudiohoek volumio[1246]: verbose: ControllerMpd::parseState Nov 25 19:29:57 thomsaudiohoek volumio[1246]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 25 19:29:57 thomsaudiohoek volumio[1246]: info: FusionDsp - {"Reload":{"result":"Ok"}} Nov 25 19:29:57 thomsaudiohoek volumio[1246]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 25 19:29:57 thomsaudiohoek volumio[1246]: verbose: ControllerMpd::parseTrackInfo Nov 25 19:29:57 thomsaudiohoek volumio[1246]: info: ControllerMpd::pushState Nov 25 19:29:57 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::servicePushState Nov 25 19:29:57 thomsaudiohoek volumio[1246]: info: CorePlayQueue::getTrack 0 Nov 25 19:29:57 thomsaudiohoek volumio[1246]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Nov 25 19:29:57 thomsaudiohoek volumio[1246]: info: ------------------------------ 4ms Nov 25 19:29:57 thomsaudiohoek volumio[1246]: info: [1732559397562] [RadioParadise] received new metadata: {"time":105,"artist":"Patty Griffin","title":"Goodbye","album":"Flaming Red","year":"1998","cover":"https://img.radioparadise.com/covers/l/B000007QDI.jpg","cover_med":"https://img.radioparadise.com/covers/m/B000007QDI.jpg","cover_small":"https://img.radioparadise.com/covers/s/B000007QDI.jpg"} Nov 25 19:29:57 thomsaudiohoek volumio[1246]: info: CorePlayQueue::getTrack 0 Nov 25 19:29:57 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::servicePushState Nov 25 19:29:57 thomsaudiohoek volumio[1246]: info: CorePlayQueue::getTrack 0 Nov 25 19:29:57 thomsaudiohoek volumio[1246]: verbose: STATE SERVICE {"status":"play","service":"radio_paradise","type":"webradio","trackType":"flac","radioType":"rparadise","albumart":"https://img.radioparadise.com/covers/l/B000007QDI.jpg","uri":"https://stream.radioparadise.com/mellow-flac","name":"Goodbye","title":"Goodbye","artist":"Patty Griffin","album":"Flaming Red","streaming":true,"disableUiControls":true,"duration":110,"seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Nov 25 19:29:57 thomsaudiohoek volumio[1246]: verbose: CURRENT POSITION 0 Nov 25 19:29:57 thomsaudiohoek volumio[1246]: info: CoreStateMachine::syncState stateService play Nov 25 19:29:57 thomsaudiohoek volumio[1246]: info: CoreStateMachine::syncState currentStatus stop Nov 25 19:29:57 thomsaudiohoek volumio[1246]: info: [1732559397563] [RadioParadise] setting new timer with duration of 110000 seconds. Nov 25 19:29:57 thomsaudiohoek volumio[1246]: info: CorePlayQueue::getTrack 0 Nov 25 19:29:57 thomsaudiohoek volumio[1246]: info: CorePlayQueue::getTrack 1 Nov 25 19:30:00 thomsaudiohoek ntpd[967]: receive: Unexpected origin timestamp 0xeaef40a7.f61cdfe8 does not match aorg 0000000000.00000000 from server@193.123.56.220 xmt 0xeaef40a8.b9c675c2 Nov 25 19:30:00 thomsaudiohoek ntpd[967]: receive: Unexpected origin timestamp 0xeaef40a7.f6195e9e does not match aorg 0000000000.00000000 from server@185.51.192.63 xmt 0xeaef40a8.ba074d6c Nov 25 19:30:00 thomsaudiohoek ntpd[967]: receive: Unexpected origin timestamp 0xeaef40a7.f61c5e69 does not match aorg 0000000000.00000000 from server@178.239.19.60 xmt 0xeaef40a8.ba3cb5f2 Nov 25 19:30:00 thomsaudiohoek ntpd[967]: receive: Unexpected origin timestamp 0xeaef40a7.f61a0e84 does not match aorg 0000000000.00000000 from server@178.215.228.24 xmt 0xeaef40a8.ba6824f8 Nov 25 19:30:00 thomsaudiohoek ntpd[967]: receive: Unexpected origin timestamp 0xeaef40a7.f6160450 does not match aorg 0000000000.00000000 from server@185.224.145.68 xmt 0xeaef40a8.ba6543df Nov 25 19:30:00 thomsaudiohoek ntpd[967]: receive: Unexpected origin timestamp 0xeaef40a7.f61b0818 does not match aorg 0000000000.00000000 from server@174.138.107.7 xmt 0xeaef40a8.b9885b5c Nov 25 19:30:00 thomsaudiohoek ntpd[967]: receive: Unexpected origin timestamp 0xeaef40a7.f61b73cf does not match aorg 0000000000.00000000 from server@144.21.38.190 xmt 0xeaef40a8.bea02836 Nov 25 19:30:10 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 25 19:30:10 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Nov 25 19:30:13 thomsaudiohoek volumiossh-tunnel[1786]: Warning: Permanently added '[eu4.myvolumio.org]:2222,[167.172.103.77]:2222' (RSA) to the list of known hosts. Nov 25 19:30:21 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Nov 25 19:30:29 thomsaudiohoek volumio[1246]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/download/touch_display/3.5.1/volumio/buster/armhf Nov 25 19:30:30 thomsaudiohoek volumio[1246]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/download/touch_display/3.5.1/volumio/buster/armhf Nov 25 19:30:30 thomsaudiohoek volumio[1246]: info: Folder /tmp/plugins removed Nov 25 19:30:30 thomsaudiohoek volumio[1246]: info: Check plugin dependencies Nov 25 19:30:30 thomsaudiohoek volumio[1246]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 25 19:30:30 thomsaudiohoek volumio[1246]: info: Checking if plugin already exists Nov 25 19:30:30 thomsaudiohoek volumio[1246]: info: An error occurred installing the plugin. Rolling back config Nov 25 19:30:30 thomsaudiohoek volumio[1246]: info: Plugin folders cleanup Nov 25 19:30:30 thomsaudiohoek volumio[1246]: info: Scanning into folder /volumio/app/plugins/ Nov 25 19:30:30 thomsaudiohoek volumio[1246]: info: Scanning category audio_interface Nov 25 19:30:30 thomsaudiohoek volumio[1246]: info: Scanning category miscellanea Nov 25 19:30:30 thomsaudiohoek volumio[1246]: info: Scanning category music_service Nov 25 19:30:30 thomsaudiohoek volumio[1246]: info: Scanning category plugins.json Nov 25 19:30:30 thomsaudiohoek volumio[1246]: info: Scanning category system_controller Nov 25 19:30:30 thomsaudiohoek volumio[1246]: info: Scanning category user_interface Nov 25 19:30:30 thomsaudiohoek volumio[1246]: info: Scanning into folder /data/plugins/ Nov 25 19:30:30 thomsaudiohoek volumio[1246]: info: Scanning category audio_interface Nov 25 19:30:30 thomsaudiohoek volumio[1246]: info: Scanning category music_service Nov 25 19:30:30 thomsaudiohoek volumio[1246]: info: Scanning category system_controller Nov 25 19:30:30 thomsaudiohoek volumio[1246]: info: Scanning category system_hardware Nov 25 19:30:30 thomsaudiohoek volumio[1246]: info: Scanning category user_interface Nov 25 19:30:30 thomsaudiohoek volumio[1246]: info: Plugin folders cleanup completed Nov 25 19:30:30 thomsaudiohoek volumio[1246]: info: Error: Error Nov 25 19:30:30 thomsaudiohoek volumio[1246]: info: Folder /tmp/plugins removed Nov 25 19:30:30 thomsaudiohoek volumio[1246]: info: Folder /tmp/downloaded_plugin.zip removed Nov 25 19:30:30 thomsaudiohoek volumio[1246]: info: Folder /tmp/downloaded_plugin.zip removed Nov 25 19:30:30 thomsaudiohoek volumio[1246]: info: Folder /data/temp removed Nov 25 19:30:42 thomsaudiohoek volumio[1246]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatest/touch_display/volumio/buster/armhf Nov 25 19:30:44 thomsaudiohoek volumio[1246]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatest/touch_display/volumio/buster/armhf Nov 25 19:30:44 thomsaudiohoek sudo[2085]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/95-touch_display-plugin.conf Nov 25 19:30:44 thomsaudiohoek sudo[2085]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:30:44 thomsaudiohoek sudo[2085]: pam_unix(sudo:session): session closed for user root Nov 25 19:30:44 thomsaudiohoek sudo[2088]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start getty@tty1.service Nov 25 19:30:44 thomsaudiohoek sudo[2088]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:30:44 thomsaudiohoek systemd[1]: Created slice system-getty.slice. Nov 25 19:30:44 thomsaudiohoek sudo[2091]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl enable getty@tty1.service Nov 25 19:30:44 thomsaudiohoek sudo[2091]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:30:44 thomsaudiohoek sudo[2095]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumio-kiosk.service Nov 25 19:30:44 thomsaudiohoek volumio[1246]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/95-touch_display-plugin.conf set. Nov 25 19:30:44 thomsaudiohoek volumio[1246]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 25 19:30:44 thomsaudiohoek volumio[1246]: TypeError: Cannot read property 'split' of undefined Nov 25 19:30:44 thomsaudiohoek volumio[1246]: at /data/plugins/user_interface/touch_display/index.js:1258:37 Nov 25 19:30:44 thomsaudiohoek volumio[1246]: at ChildProcess.exithandler (child_process.js:299:7) Nov 25 19:30:44 thomsaudiohoek volumio[1246]: at ChildProcess.emit (events.js:315:20) Nov 25 19:30:44 thomsaudiohoek volumio[1246]: at maybeClose (internal/child_process.js:1048:16) Nov 25 19:30:44 thomsaudiohoek volumio[1246]: at Socket. (internal/child_process.js:439:11) Nov 25 19:30:44 thomsaudiohoek volumio[1246]: at Socket.emit (events.js:315:20) Nov 25 19:30:44 thomsaudiohoek volumio[1246]: at Pipe. (net.js:673:12) Nov 25 19:30:44 thomsaudiohoek volumio[1246]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 25 19:30:44 thomsaudiohoek sudo[2095]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 25 19:30:44 thomsaudiohoek systemd[1]: Started Getty on tty1. Nov 25 19:30:44 thomsaudiohoek sudo[2088]: pam_unix(sudo:session): session closed for user root Nov 25 19:30:44 thomsaudiohoek systemd[1]: Reloading. Nov 25 19:30:44 thomsaudiohoek sudo[2095]: pam_unix(sudo:session): session closed for user root Nov 25 19:30:44 thomsaudiohoek systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Nov 25 19:30:44 thomsaudiohoek sudo[2157]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-25 19:29 Nov 25 19:30:44 thomsaudiohoek sudo[2157]: 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="f6610a1100d2380eef33bd3004af43153c786f96" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="c56b231f88ce17023518c3b6aa9e933e8e8256d8" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 25 Nov 2024 02:41:54 PM CET" VOLUMIO_VERSION="3.782" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="769a33e6dd61b9a5d2fa14f934eef739"