-- Logs begin at Thu 2019-02-14 11:11:58 CET, end at Wed 2024-09-04 22:42:39 CEST. -- Sep 04 22:41:00 volumio wireless.js[838]: trying... Sep 04 22:41:00 volumio sudo[1224]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Sep 04 22:41:00 volumio sudo[1224]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 22:41:00 volumio sudo[1224]: pam_unix(sudo:session): session closed for user root Sep 04 22:41:00 volumio nmbd[969]: [2024/09/04 22:41:00.635637, 0] ../lib/util/become_daemon.c:138(daemon_ready) Sep 04 22:41:00 volumio nmbd[969]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Sep 04 22:41:00 volumio systemd[1]: Started Samba NMB Daemon. Sep 04 22:41:00 volumio nmbd[969]: [2024/09/04 22:41:00.643084, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Sep 04 22:41:00 volumio nmbd[969]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.1.134 for name WORKGROUP<1d>. Sep 04 22:41:00 volumio nmbd[969]: This response was from IP 192.168.1.11, reporting an IP address of 192.168.1.11. Sep 04 22:41:00 volumio systemd[1]: Starting Samba Winbind Daemon... Sep 04 22:41:00 volumio winbindd[1226]: [2024/09/04 22:41:00.747472, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Sep 04 22:41:00 volumio winbindd[1226]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Sep 04 22:41:00 volumio winbindd[1226]: [2024/09/04 22:41:00.766643, 0] ../lib/util/become_daemon.c:138(daemon_ready) Sep 04 22:41:00 volumio winbindd[1226]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Sep 04 22:41:00 volumio systemd[1]: Started Samba Winbind Daemon. Sep 04 22:41:00 volumio systemd[1]: Starting Samba SMB Daemon... Sep 04 22:41:00 volumio smbd[1231]: [2024/09/04 22:41:00.965171, 0] ../lib/util/become_daemon.c:138(daemon_ready) Sep 04 22:41:00 volumio systemd[1]: Started Samba SMB Daemon. Sep 04 22:41:00 volumio smbd[1231]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Sep 04 22:41:01 volumio wireless.js[838]: trying... Sep 04 22:41:01 volumio sudo[1240]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Sep 04 22:41:01 volumio sudo[1240]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 22:41:01 volumio sudo[1240]: pam_unix(sudo:session): session closed for user root Sep 04 22:41:01 volumio wpa_supplicant[1101]: RRM: Ignoring radio measurement request: Not RRM network Sep 04 22:41:02 volumio wireless.js[838]: trying... Sep 04 22:41:02 volumio sudo[1243]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Sep 04 22:41:02 volumio sudo[1243]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 22:41:02 volumio sudo[1243]: pam_unix(sudo:session): session closed for user root Sep 04 22:41:02 volumio dhcpcd[1170]: wlan0: leased 192.168.1.101 for 43200 seconds Sep 04 22:41:02 volumio avahi-daemon[833]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.101. Sep 04 22:41:02 volumio avahi-daemon[833]: New relevant interface wlan0.IPv4 for mDNS. Sep 04 22:41:02 volumio dhcpcd[1170]: wlan0: adding route to 192.168.1.0/24 Sep 04 22:41:02 volumio avahi-daemon[833]: Registering new address record for 192.168.1.101 on wlan0.IPv4. Sep 04 22:41:02 volumio dhcpcd[1170]: wlan0: adding default route via 192.168.1.254 Sep 04 22:41:03 volumio wireless.js[838]: trying... Sep 04 22:41:03 volumio sudo[1266]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Sep 04 22:41:03 volumio sudo[1266]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 22:41:03 volumio sudo[1266]: pam_unix(sudo:session): session closed for user root Sep 04 22:41:03 volumio wireless.js[838]: Connected to: ----free_ANB Sep 04 22:41:03 volumio wireless.js[838]: ---- Sep 04 22:41:03 volumio sudo[1269]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 04 22:41:03 volumio sudo[1269]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 22:41:03 volumio sudo[1269]: pam_unix(sudo:session): session closed for user root Sep 04 22:41:03 volumio wireless.js[838]: ... joined AP, wlan0 IPv4 is 192.168.1.101, ipV6 is undefined Sep 04 22:41:03 volumio wireless.js[838]: It's done! AP Sep 04 22:41:03 volumio systemd[1]: Started Wireless Services. Sep 04 22:41:03 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Sep 04 22:41:03 volumio systemd[1]: Started Volumio Backend Module. Sep 04 22:41:03 volumio systemd[1]: Started Volumio Cpu Tweaker. Sep 04 22:41:03 volumio systemd[1]: Reached target Multi-User System. Sep 04 22:41:03 volumio systemd[1]: Reached target Graphical Interface. Sep 04 22:41:03 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... Sep 04 22:41:03 volumio volumio-cpu-tweak[1275]: Setting RT Priority for mpd Sep 04 22:41:03 volumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Sep 04 22:41:03 volumio systemd[1]: Started Update UTMP about System Runlevel Changes. Sep 04 22:41:03 volumio systemd[1]: Startup finished in 11.296s (kernel) + 21.160s (userspace) = 32.457s. Sep 04 22:41:03 volumio volumio-cpu-tweak[1275]: pid 35's current scheduling policy: SCHED_OTHER Sep 04 22:41:03 volumio volumio-cpu-tweak[1275]: pid 35's current scheduling priority: 0 Sep 04 22:41:03 volumio volumio-cpu-tweak[1275]: Setting MPD Affinity Sep 04 22:41:03 volumio volumio-cpu-tweak[1275]: pid 3's current affinity mask: f Sep 04 22:41:03 volumio volumio-cpu-tweak[1275]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input Sep 04 22:41:03 volumio volumio-cpu-tweak[1275]: VOLUMIO CPU TWEAK: Setting CPU Governor: conservative Sep 04 22:41:03 volumio systemd[1]: volumio_cpu_tweak.service: Succeeded. Sep 04 22:41:04 volumio ntpd[987]: Listen normally on 4 wlan0 192.168.1.101:123 Sep 04 22:41:04 volumio ntpd[987]: new interface(s) found: waking up resolver Sep 04 22:41:04 volumio volumio[1274]: info: ------------------------------------------- Sep 04 22:41:04 volumio volumio[1274]: info: ----- Volumio3 ---- Sep 04 22:41:04 volumio volumio[1274]: info: ------------------------------------------- Sep 04 22:41:04 volumio volumio[1274]: info: ----- System startup ---- Sep 04 22:41:04 volumio volumio[1274]: info: ------------------------------------------- Sep 04 22:41:04 volumio volumio[1274]: info: MYVOLUMIO Environment detected Sep 04 22:41:04 volumio volumio[1274]: info: Plugin folders cleanup Sep 04 22:41:04 volumio volumio[1274]: info: Scanning into folder /volumio/app/plugins/ Sep 04 22:41:04 volumio volumio[1274]: info: Scanning category audio_interface Sep 04 22:41:04 volumio volumio[1274]: info: Scanning category miscellanea Sep 04 22:41:04 volumio volumio[1274]: info: Scanning category music_service Sep 04 22:41:04 volumio volumio[1274]: info: Scanning category plugins.json Sep 04 22:41:04 volumio volumio[1274]: info: Scanning category system_controller Sep 04 22:41:04 volumio volumio[1274]: info: Scanning category user_interface Sep 04 22:41:04 volumio volumio[1274]: info: Scanning into folder /data/plugins/ Sep 04 22:41:04 volumio volumio[1274]: info: Scanning category user_interface Sep 04 22:41:04 volumio volumio[1274]: info: Plugin folders cleanup completed Sep 04 22:41:04 volumio volumio[1274]: info: ------------------------------------------- Sep 04 22:41:04 volumio volumio[1274]: info: ----- Core plugins startup ---- Sep 04 22:41:04 volumio volumio[1274]: info: ------------------------------------------- Sep 04 22:41:04 volumio volumio[1274]: info: Loading plugins from folder /volumio/app/plugins/ Sep 04 22:41:04 volumio volumio[1274]: info: Adding plugin upnp to MyMusic Plugins Sep 04 22:41:04 volumio volumio[1274]: info: Adding plugin airplay_emulation to MyMusic Plugins Sep 04 22:41:04 volumio volumio[1274]: info: Adding plugin upnp_browser to MyMusic Plugins Sep 04 22:41:04 volumio volumio[1274]: info: Loading plugins from folder /data/plugins/ Sep 04 22:41:04 volumio volumio[1274]: info: Loading plugin "system"... Sep 04 22:41:04 volumio volumio[1274]: info: Loading plugin "appearance"... Sep 04 22:41:05 volumio volumio[1274]: info: Loading plugin "network"... Sep 04 22:41:05 volumio volumio[1274]: info: Refreshing Cached IP Addresses Sep 04 22:41:05 volumio sudo[1306]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 04 22:41:05 volumio sudo[1306]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 22:41:05 volumio sudo[1306]: pam_unix(sudo:session): session closed for user root Sep 04 22:41:05 volumio sudo[1308]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 04 22:41:05 volumio sudo[1308]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 22:41:05 volumio volumio[1274]: info: Loading plugin "services"... Sep 04 22:41:05 volumio sudo[1308]: pam_unix(sudo:session): session closed for user root Sep 04 22:41:05 volumio volumio[1274]: info: Loading plugin "alsa_controller"... Sep 04 22:41:05 volumio sudo[1311]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Sep 04 22:41:05 volumio sudo[1311]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 22:41:05 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 04 22:41:05 volumio volumio[1274]: info: Loading plugin "wizard"... Sep 04 22:41:05 volumio volumio[1274]: info: Loading plugin "networkfs"... Sep 04 22:41:05 volumio volumio[1274]: info: Starting Udev Watcher for removable devices Sep 04 22:41:05 volumio volumio[1274]: info: Ignoring mount for partition: boot Sep 04 22:41:05 volumio volumio[1274]: info: Ignoring mount for partition: volumio Sep 04 22:41:05 volumio volumio[1274]: info: Ignoring mount for partition: volumio_data Sep 04 22:41:05 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Sep 04 22:41:05 volumio volumio[1274]: info: Loading plugin "volumio_command_line_client"... Sep 04 22:41:05 volumio volumio[1274]: info: Loading plugin "upnp"... Sep 04 22:41:05 volumio volumio[1274]: info: [1725482465135] Starting Upmpd Daemon Sep 04 22:41:05 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Sep 04 22:41:05 volumio volumio[1274]: info: Loading plugin "my_music"... Sep 04 22:41:05 volumio volumio[1274]: info: Loading plugin "mpd"... Sep 04 22:41:05 volumio volumio[1274]: info: Loading plugin "upnp_browser"... Sep 04 22:41:05 volumio volumio[1274]: info: Loading plugin "alarm-clock"... Sep 04 22:41:05 volumio volumio[1274]: info: Loading plugin "airplay_emulation"... Sep 04 22:41:05 volumio volumio[1274]: info: Starting Shairport Sync Sep 04 22:41:05 volumio volumio[1274]: info: Loading plugin "last_100"... Sep 04 22:41:05 volumio volumio[1274]: info: Loading plugin "webradio"... Sep 04 22:41:05 volumio volumio[1274]: info: Loading plugin "i2s_dacs"... Sep 04 22:41:05 volumio volumio[1274]: info: Loading plugin "volumiodiscovery"... Sep 04 22:41:05 volumio volumio[1274]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Sep 04 22:41:05 volumio volumio[1274]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 04 22:41:05 volumio volumio[1274]: *** WARNING *** For more information see Sep 04 22:41:05 volumio node[1274]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Sep 04 22:41:05 volumio volumio[1274]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Sep 04 22:41:05 volumio volumio[1274]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 04 22:41:05 volumio volumio[1274]: *** WARNING *** For more information see Sep 04 22:41:05 volumio node[1274]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 04 22:41:05 volumio node[1274]: *** WARNING *** For more information see Sep 04 22:41:05 volumio node[1274]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Sep 04 22:41:05 volumio node[1274]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 04 22:41:05 volumio node[1274]: *** WARNING *** For more information see Sep 04 22:41:05 volumio volumio[1274]: info: Applying required configuration parameters for plugin volumiodiscovery Sep 04 22:41:05 volumio volumio[1274]: info: Discovery: Started advertising with name: Volumio Sep 04 22:41:05 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Sep 04 22:41:05 volumio volumio[1274]: info: Loading plugin "outputs"... Sep 04 22:41:05 volumio volumio[1274]: info: Loading plugin "albumart"... Sep 04 22:41:05 volumio volumio[1274]: info: Plugin example_plugin is not enabled Sep 04 22:41:05 volumio volumio[1274]: info: Loading plugin "inputs"... Sep 04 22:41:05 volumio volumio[1274]: info: Loading plugin "updater_comm"... Sep 04 22:41:05 volumio volumio[1274]: Forking 3 albumart workers Sep 04 22:41:05 volumio volumio[1274]: info: Plugin mpdemulation is not enabled Sep 04 22:41:05 volumio volumio[1274]: info: Loading plugin "rest_api"... Sep 04 22:41:05 volumio volumio[1274]: info: Loading plugin "websocket"... Sep 04 22:41:05 volumio volumio[1274]: info: Starting Socket.io Server version 2.3.0 Sep 04 22:41:05 volumio volumio[1274]: info: Loading plugin "touch_display"... Sep 04 22:41:05 volumio volumio[1274]: Starting albumart workers Sep 04 22:41:05 volumio volumio[1274]: Starting albumart workers Sep 04 22:41:05 volumio volumio[1274]: Starting albumart workers Sep 04 22:41:05 volumio volumio[1274]: info: Applying required configuration parameters for plugin touch_display Sep 04 22:41:05 volumio volumio[1274]: info: Loading i18n strings for locale en Sep 04 22:41:05 volumio volumio[1274]: Updating browse sources language Sep 04 22:41:05 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 04 22:41:06 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 22:41:06 volumio volumio[1274]: info: CoreCommandRouter::initPlayerControls Sep 04 22:41:06 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 22:41:06 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 22:41:06 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 22:41:06 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 22:41:06 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 22:41:06 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 22:41:06 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 22:41:06 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 22:41:06 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 22:41:06 volumio volumio[1274]: Express server listening on port 3000 Sep 04 22:41:06 volumio volumio[1274]: [Metrics] WebUI: 1s 971.82ms Sep 04 22:41:06 volumio volumio[1274]: info: CoreStateMachine::resetVolumioState Sep 04 22:41:06 volumio volumio[1274]: info: CoreStateMachine::getcurrentVolume Sep 04 22:41:06 volumio volumio[1274]: info: CoreCommandRouter::volumioRetrievevolume Sep 04 22:41:06 volumio volumio[1274]: info: CoreStateMachine::pushState Sep 04 22:41:06 volumio volumio[1274]: info: CorePlayQueue::getTrack 0 Sep 04 22:41:06 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 04 22:41:06 volumio volumio[1274]: info: CoreCommandRouter::volumioPushState Sep 04 22:41:06 volumio volumio[1274]: info: Cannot read play queue from file Sep 04 22:41:06 volumio volumio[1274]: verbose: New Socket.io Connection to 192.168.1.134 from 192.168.1.30 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/128.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 Sep 04 22:41:06 volumio volumio[1274]: verbose: New Socket.io Connection to 192.168.1.134 from 192.168.1.30 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/128.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2 Sep 04 22:41:06 volumio volumio[1274]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Sep 04 22:41:06 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 04 22:41:06 volumio volumio[1274]: info: Setting Device type: Raspberry PI Sep 04 22:41:06 volumio volumio[1274]: info: CoreStateMachine::setRepeat null single undefined Sep 04 22:41:06 volumio volumio[1274]: info: CoreStateMachine::pushState Sep 04 22:41:06 volumio volumio[1274]: info: CorePlayQueue::getTrack 0 Sep 04 22:41:06 volumio volumio[1274]: info: CoreCommandRouter::volumioPushState Sep 04 22:41:06 volumio volumio[1274]: info: CoreStateMachine::setRandom null Sep 04 22:41:06 volumio volumio[1274]: info: CoreStateMachine::pushState Sep 04 22:41:06 volumio volumio[1274]: info: CorePlayQueue::getTrack 0 Sep 04 22:41:06 volumio volumio[1274]: info: CoreCommandRouter::volumioPushState Sep 04 22:41:06 volumio volumio[1274]: info: Completed loading Core Plugins Sep 04 22:41:06 volumio volumio[1274]: info: Preparing to generate the ALSA configuration file Sep 04 22:41:06 volumio volumio[1274]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Sep 04 22:41:06 volumio volumio[1274]: info: USB Boot Capable - System SBC Revision found in cpuinfo: d04170 Sep 04 22:41:06 volumio volumio[1274]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Sep 04 22:41:06 volumio volumio[1274]: info: Asound.conf file unchanged, so no further update is needed Sep 04 22:41:06 volumio volumio[1274]: info: Output device has changed, restarting MPD Sep 04 22:41:06 volumio volumio[1274]: info: Output device has changed, restarting Shairport Sync Sep 04 22:41:06 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 22:41:06 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 04 22:41:06 volumio sudo[1382]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Sep 04 22:41:06 volumio sudo[1382]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 22:41:06 volumio sudo[1382]: pam_unix(sudo:session): session closed for user root Sep 04 22:41:06 volumio sudo[1384]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Sep 04 22:41:06 volumio sudo[1384]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 22:41:06 volumio volumio[1274]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 04 22:41:06 volumio volumio[1274]: info: ___________ START PLUGINS ___________ Sep 04 22:41:06 volumio volumio[1274]: info: ControllerMpd::onStart: Initializing MPD Sep 04 22:41:06 volumio volumio[1274]: info: Creating MPD Configuration file Sep 04 22:41:06 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 04 22:41:06 volumio volumio[1274]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 04 22:41:06 volumio volumio[1274]: info: [1725482466187] CoreMusicLibrary::Adding element Media Servers Sep 04 22:41:06 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 04 22:41:06 volumio sudo[1392]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Sep 04 22:41:06 volumio sudo[1392]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 22:41:06 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 22:41:06 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 04 22:41:06 volumio sudo[1392]: pam_unix(sudo:session): session closed for user root Sep 04 22:41:06 volumio sudo[1394]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Sep 04 22:41:06 volumio sudo[1394]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 22:41:06 volumio systemd[1]: Listening on mpd.socket. Sep 04 22:41:06 volumio systemd[1]: Starting Music Player Daemon... Sep 04 22:41:06 volumio volumio[1274]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 04 22:41:06 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 22:41:06 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 04 22:41:06 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Sep 04 22:41:06 volumio systemd[1]: mpd.service: Succeeded. Sep 04 22:41:06 volumio systemd[1]: Stopped Music Player Daemon. Sep 04 22:41:06 volumio systemd[1]: Starting Music Player Daemon... Sep 04 22:41:06 volumio volumio[1274]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 04 22:41:06 volumio volumio[1274]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 04 22:41:06 volumio volumio[1274]: info: [1725482466225] CoreMusicLibrary::Adding element Last_100 Sep 04 22:41:06 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 04 22:41:06 volumio volumio[1274]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 04 22:41:06 volumio volumio[1274]: info: [1725482466226] CoreMusicLibrary::Adding element Webradio Sep 04 22:41:06 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 04 22:41:06 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 04 22:41:06 volumio volumio[1274]: info: Initializing BBC Radios Sep 04 22:41:06 volumio sudo[1404]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Sep 04 22:41:06 volumio sudo[1404]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 22:41:06 volumio sudo[1404]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Sep 04 22:41:06 volumio sudo[1404]: pam_unix(sudo:session): session closed for user root Sep 04 22:41:06 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 04 22:41:06 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 04 22:41:06 volumio volumio[1274]: info: Loading i18n strings for locale en Sep 04 22:41:06 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 04 22:41:06 volumio volumio[1274]: info: Volumio Calling Home Sep 04 22:41:06 volumio sudo[1421]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop getty@tty1.service Sep 04 22:41:06 volumio sudo[1421]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 22:41:06 volumio sudo[1423]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl disable getty@tty1.service Sep 04 22:41:06 volumio sudo[1423]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 22:41:06 volumio sudo[1426]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Sep 04 22:41:06 volumio sudo[1426]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 22:41:06 volumio systemd[1]: Reloading. Sep 04 22:41:06 volumio volumio[1274]: info: touch_display: No backlight interface detected. Sep 04 22:41:06 volumio volumio[1274]: info: MPD Permissions set Sep 04 22:41:06 volumio volumio[1274]: info: MPD Permissions set Sep 04 22:41:06 volumio volumio[1274]: verbose: New Socket.io Connection to 192.168.1.134 from 192.168.1.30 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/128.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Sep 04 22:41:06 volumio volumio[1274]: verbose: New Socket.io Connection to 192.168.1.101 from 192.168.1.30 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/128.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Sep 04 22:41:06 volumio volumio[1274]: info: Volumio called home Sep 04 22:41:06 volumio volumio[1274]: info: Discovery: adding 92a7e165-70cf-4707-b1fd-a2e0b3e9be19 Sep 04 22:41:06 volumio volumio[1274]: info: Discovery: Found device Volumio Sep 04 22:41:06 volumio volumio[1274]: info: CoreCommandRouter::volumioGetState Sep 04 22:41:06 volumio volumio[1274]: info: CorePlayQueue::getTrack 0 Sep 04 22:41:06 volumio volumio[1274]: info: Discovery: this is already registered, 92a7e165-70cf-4707-b1fd-a2e0b3e9be19 Sep 04 22:41:06 volumio volumio[1274]: info: Discovery: Found device Volumio Sep 04 22:41:06 volumio volumio[1274]: info: CoreCommandRouter::volumioGetState Sep 04 22:41:06 volumio volumio[1274]: info: CorePlayQueue::getTrack 0 Sep 04 22:41:06 volumio volumio[1274]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Sep 04 22:41:06 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 22:41:06 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 22:41:06 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 22:41:06 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 22:41:06 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 22:41:06 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 22:41:06 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 22:41:06 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 22:41:06 volumio 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. Sep 04 22:41:06 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 04 22:41:06 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 22:41:06 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 22:41:06 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 22:41:06 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 22:41:06 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 22:41:06 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 22:41:06 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 22:41:06 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 22:41:06 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 22:41:06 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 04 22:41:06 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 22:41:06 volumio volumio[1274]: verbose: New Socket.io Connection to 192.168.1.134 from 192.168.1.30 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/128.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Sep 04 22:41:06 volumio volumio[1274]: info: touch_display: No Raspberry Pi Foundation touch screen detected. Sep 04 22:41:06 volumio volumio[1274]: info: Starting Shairport Sync Sep 04 22:41:06 volumio sudo[1451]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/99-vc4.conf Sep 04 22:41:06 volumio sudo[1451]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 22:41:06 volumio volumio[1274]: info: Starting Shairport Sync Sep 04 22:41:06 volumio volumio[1274]: info: Starting Shairport Sync Sep 04 22:41:06 volumio sudo[1451]: pam_unix(sudo:session): session closed for user root Sep 04 22:41:06 volumio sudo[1454]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 04 22:41:06 volumio sudo[1454]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 22:41:06 volumio volumio[1274]: info: CoreCommandRouter::volumioGetState Sep 04 22:41:06 volumio volumio[1274]: info: CorePlayQueue::getTrack 0 Sep 04 22:41:06 volumio sudo[1456]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 04 22:41:06 volumio sudo[1456]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 22:41:06 volumio sudo[1459]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 04 22:41:06 volumio sudo[1459]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 22:41:06 volumio volumio[1274]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/99-vc4.conf set. Sep 04 22:41:06 volumio volumio[1274]: verbose: New Socket.io Connection to 192.168.1.101 from 192.168.1.30 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/128.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Sep 04 22:41:06 volumio volumio[1274]: verbose: New Socket.io Connection to 192.168.1.101 from 192.168.1.30 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/128.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Sep 04 22:41:06 volumio systemd[1]: serial-getty@ttyAMA10.service: Current command vanished from the unit file, execution of the command list won't be resumed. Sep 04 22:41:06 volumio sudo[1426]: pam_unix(sudo:session): session closed for user root Sep 04 22:41:06 volumio volumio[1274]: info: touch_display: systemctl daemon-reload succeeded. Sep 04 22:41:06 volumio sudo[1463]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service Sep 04 22:41:06 volumio sudo[1463]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 22:41:06 volumio systemd[1]: Reloading. Sep 04 22:41:06 volumio volumio[1274]: info: CoreCommandRouter::volumioGetState Sep 04 22:41:06 volumio volumio[1274]: info: CorePlayQueue::getTrack 0 Sep 04 22:41:06 volumio 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. Sep 04 22:41:06 volumio volumio[1274]: info: CoreCommandRouter::volumioGetState Sep 04 22:41:06 volumio volumio[1274]: info: CorePlayQueue::getTrack 0 Sep 04 22:41:06 volumio sudo[1423]: pam_unix(sudo:session): session closed for user root Sep 04 22:41:06 volumio volumio[1274]: info: touch_display: systemctl disable getty@tty1.service succeeded. Sep 04 22:41:06 volumio sudo[1421]: pam_unix(sudo:session): session closed for user root Sep 04 22:41:06 volumio volumio[1274]: info: touch_display: systemctl stop getty@tty1.service succeeded. Sep 04 22:41:06 volumio systemd[1]: Started Volumio Kiosk. Sep 04 22:41:06 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Sep 04 22:41:06 volumio sudo[1463]: pam_unix(sudo:session): session closed for user root Sep 04 22:41:06 volumio systemd[1]: Starting Daily apt download activities... Sep 04 22:41:06 volumio volumio[1274]: info: touch_display: systemctl start volumio-kiosk.service succeeded. Sep 04 22:41:06 volumio volumio[1274]: info: touch_display: Volumio Kiosk started. Sep 04 22:41:06 volumio systemd[1]: shairport-sync.service: Succeeded. Sep 04 22:41:06 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Sep 04 22:41:06 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Sep 04 22:41:06 volumio sudo[1454]: pam_unix(sudo:session): session closed for user root Sep 04 22:41:06 volumio sudo[1456]: pam_unix(sudo:session): session closed for user root Sep 04 22:41:06 volumio sudo[1459]: pam_unix(sudo:session): session closed for user root Sep 04 22:41:06 volumio volumio[1274]: info: CoreCommandRouter::volumioGetState Sep 04 22:41:06 volumio volumio[1274]: info: CorePlayQueue::getTrack 0 Sep 04 22:41:06 volumio volumio[1274]: info: CoreCommandRouter::volumioGetState Sep 04 22:41:06 volumio volumio[1274]: info: CorePlayQueue::getTrack 0 Sep 04 22:41:06 volumio volumio[1274]: info: Shairport-Sync Started Sep 04 22:41:06 volumio volumio[1274]: Error adding Membership: Error: addMembership EINVAL Sep 04 22:41:06 volumio volumio[1274]: info: Shairport-Sync Started Sep 04 22:41:06 volumio volumio[1274]: info: Shairport-Sync Started Sep 04 22:41:06 volumio volumio[1274]: info: touch_display: X display number found: Sep 04 22:41:07 volumio startx[1479]: X.Org X Server 1.20.4 Sep 04 22:41:07 volumio startx[1479]: X Protocol Version 11, Revision 0 Sep 04 22:41:07 volumio startx[1479]: Build Operating System: Linux 5.4.0-109-generic armv8l Raspbian Sep 04 22:41:07 volumio startx[1479]: Current Operating System: Linux volumio 6.1.69-v8+ #1710 SMP PREEMPT Thu Dec 21 13:21:40 GMT 2023 aarch64 Sep 04 22:41:07 volumio startx[1479]: Kernel command line: reboot=w coherent_pool=1M 8250.nr_uarts=1 pci=pcie_bus_safe snd_bcm2835.enable_compat_alsa=0 snd_bcm2835.enable_hdmi=1 smsc95xx.macaddr=D8:3A:DD:DF:4B:69 vc_mem.mem_base=0x3fc00000 vc_mem.mem_size=0x40000000 splash plymouth.ignore-serial-consoles dwc_otg.fiq_enable=1 dwc_otg.fiq_fsm_enable=1 dwc_otg.fiq_fsm_mask=0xF dwc_otg.nak_holdoff=1 quiet console=ttyAMA10,115200 console=tty1 imgpart=UUID=0c3a77ec-ae84-4f1b-8028-c61cc251ffe5 imgfile=/volumio_current.sqsh bootpart=UUID=41CA-9A8B datapart=UUID=0324d53a-d066-482b-b659-eb98af2b49e7 uuidconfig=cmdline.txt pcie_aspm=off pci=pcie_bus_safe rootwait bootdelay=7 logo.nologo vt.global_cursor_default=0 net.ifnames=0 snd-bcm2835.enable_compat_alsa= snd_bcm2835.enable_hdmi=1 snd_bcm2835.enable_headphones=1 loglevel=0 nodebug use_kmsg=no cfg80211.ieee80211_regdom=FR Sep 04 22:41:07 volumio startx[1479]: Build Date: 04 April 2023 07:50:56AM Sep 04 22:41:07 volumio startx[1479]: xorg-server 2:1.20.4-1+rpt4+deb10u9 (https://www.debian.org/support) Sep 04 22:41:07 volumio startx[1479]: Current version of pixman: 0.36.0 Sep 04 22:41:07 volumio startx[1479]: Before reporting problems, check http://wiki.x.org Sep 04 22:41:07 volumio startx[1479]: to make sure that you have the latest version. Sep 04 22:41:07 volumio startx[1479]: Markers: (--) probed, (**) from config file, (==) default setting, Sep 04 22:41:07 volumio startx[1479]: (++) from command line, (!!) notice, (II) informational, Sep 04 22:41:07 volumio startx[1479]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown. Sep 04 22:41:07 volumio startx[1479]: (==) Log file: "/var/log/Xorg.0.log", Time: Wed Sep 4 22:41:07 2024 Sep 04 22:41:07 volumio startx[1479]: (==) Using config directory: "/etc/X11/xorg.conf.d" Sep 04 22:41:07 volumio startx[1479]: (==) Using system config directory "/usr/share/X11/xorg.conf.d" Sep 04 22:41:07 volumio volumio[1274]: info: touch_display: X display number found: 0 Sep 04 22:41:07 volumio startx[1479]: modprobe: FATAL: Module g2d_23 not found in directory /lib/modules/6.1.69-v8+ Sep 04 22:41:07 volumio volumio[1274]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Sep 04 22:41:07 volumio volumio[1274]: info: touch_display: X display number found: 0 Sep 04 22:41:07 volumio mpd[1413]: Sep 04 22:41 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Sep 04 22:41:07 volumio systemd[1]: Started Music Player Daemon. Sep 04 22:41:07 volumio sudo[1384]: pam_unix(sudo:session): session closed for user root Sep 04 22:41:07 volumio sudo[1394]: pam_unix(sudo:session): session closed for user root Sep 04 22:41:07 volumio volumio[1274]: info: Completed starting Core Plugins Sep 04 22:41:07 volumio volumio[1274]: info: ------------------------------------------- Sep 04 22:41:07 volumio volumio[1274]: info: ----- MyVolumio plugins startup ---- Sep 04 22:41:07 volumio volumio[1274]: info: ------------------------------------------- Sep 04 22:41:07 volumio volumio[1274]: info: [MyVolumio PluginManager] Fetching plans data.... Sep 04 22:41:07 volumio volumio[1274]: error: MPD error: The expression evaluated to a falsy value: Sep 04 22:41:07 volumio volumio[1274]: assert.ok(self.idling) Sep 04 22:41:07 volumio volumio[1274]: error: The expression evaluated to a falsy value: Sep 04 22:41:07 volumio volumio[1274]: assert.ok(self.idling) Sep 04 22:41:07 volumio volumio[1274]: info: MPD running with PID1413 Sep 04 22:41:07 volumio volumio[1274]: ,establishing connection Sep 04 22:41:07 volumio volumio[1274]: error: updateQueue error: null Sep 04 22:41:07 volumio volumio[1274]: error: updateQueue error: null Sep 04 22:41:07 volumio volumio-remote-updater[825]: [2024-09-04 22:41:07] [connect] Successful connection Sep 04 22:41:07 volumio volumio-remote-updater[825]: [2024-09-04 22:41:07] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1725482467 101 Sep 04 22:41:07 volumio volumio[1274]: 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: 10 Sep 04 22:41:07 volumio wpa_supplicant[1101]: RRM: Ignoring radio measurement request: Not RRM network Sep 04 22:41:07 volumio startx[1479]: /usr/lib/xorg/Xorg: symbol lookup error: /usr/lib/xorg/modules/drivers/fbturbo_drv.so: undefined symbol: shadowUpdatePackedWeak Sep 04 22:41:07 volumio volumio[1274]: error: touch_display: Error determining the video outputs: Error: Command failed: /usr/bin/xrandr -display :0 Sep 04 22:41:07 volumio volumio[1274]: Can't open display :0 Sep 04 22:41:08 volumio systemd[1]: apt-daily.service: Succeeded. Sep 04 22:41:08 volumio systemd[1]: Started Daily apt download activities. Sep 04 22:41:08 volumio volumio[1274]: info: Received Get System Info Sep 04 22:41:08 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 04 22:41:08 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 04 22:41:08 volumio volumio[1274]: info: Discovery: Getting this device information Sep 04 22:41:08 volumio volumio[1274]: info: CoreCommandRouter::volumioGetState Sep 04 22:41:08 volumio volumio[1274]: info: CorePlayQueue::getTrack 0 Sep 04 22:41:08 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 04 22:41:08 volumio volumio[1274]: info: CoreCommandRouter::volumioGetState Sep 04 22:41:08 volumio volumio[1274]: info: CorePlayQueue::getTrack 0 Sep 04 22:41:08 volumio volumio[1274]: info: Received Get System Info Sep 04 22:41:08 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 04 22:41:08 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 04 22:41:08 volumio volumio[1274]: info: Discovery: Getting this device information Sep 04 22:41:08 volumio volumio[1274]: info: CoreCommandRouter::volumioGetState Sep 04 22:41:08 volumio volumio[1274]: info: CorePlayQueue::getTrack 0 Sep 04 22:41:08 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 04 22:41:08 volumio volumio[1274]: info: CoreCommandRouter::volumioGetState Sep 04 22:41:08 volumio volumio[1274]: info: CorePlayQueue::getTrack 0 Sep 04 22:41:08 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Sep 04 22:41:08 volumio volumio[1274]: info: CoreCommandRouter::volumioGetVisibleSources Sep 04 22:41:08 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 04 22:41:08 volumio volumio[1274]: info: CoreCommandRouter::volumioGetState Sep 04 22:41:08 volumio volumio[1274]: info: CorePlayQueue::getTrack 0 Sep 04 22:41:08 volumio volumio[1274]: info: CoreCommandRouter::volumioGetState Sep 04 22:41:08 volumio volumio[1274]: info: CorePlayQueue::getTrack 0 Sep 04 22:41:08 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Sep 04 22:41:08 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Sep 04 22:41:08 volumio volumio[1274]: info: Received Get System Info Sep 04 22:41:08 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 04 22:41:08 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 04 22:41:08 volumio volumio[1274]: info: Discovery: Getting this device information Sep 04 22:41:08 volumio volumio[1274]: info: CoreCommandRouter::volumioGetState Sep 04 22:41:08 volumio volumio[1274]: info: CorePlayQueue::getTrack 0 Sep 04 22:41:08 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 04 22:41:08 volumio volumio[1274]: info: CoreCommandRouter::volumioGetState Sep 04 22:41:08 volumio volumio[1274]: info: CorePlayQueue::getTrack 0 Sep 04 22:41:08 volumio volumio[1274]: info: Listing playlists Sep 04 22:41:08 volumio volumio[1274]: info: Received Get System Info Sep 04 22:41:08 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 04 22:41:08 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 04 22:41:08 volumio volumio[1274]: info: Discovery: Getting this device information Sep 04 22:41:08 volumio volumio[1274]: info: CoreCommandRouter::volumioGetState Sep 04 22:41:08 volumio volumio[1274]: info: CorePlayQueue::getTrack 0 Sep 04 22:41:08 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 04 22:41:08 volumio volumio[1274]: info: CoreCommandRouter::volumioGetState Sep 04 22:41:08 volumio volumio[1274]: info: CorePlayQueue::getTrack 0 Sep 04 22:41:08 volumio volumio[1274]: info: Received Get System Info Sep 04 22:41:08 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 04 22:41:08 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 04 22:41:08 volumio volumio[1274]: info: Discovery: Getting this device information Sep 04 22:41:08 volumio volumio[1274]: info: CoreCommandRouter::volumioGetState Sep 04 22:41:08 volumio volumio[1274]: info: CorePlayQueue::getTrack 0 Sep 04 22:41:08 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 04 22:41:08 volumio volumio[1274]: info: CoreCommandRouter::volumioGetState Sep 04 22:41:08 volumio volumio[1274]: info: CorePlayQueue::getTrack 0 Sep 04 22:41:08 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Sep 04 22:41:08 volumio volumio[1274]: info: CoreCommandRouter::volumioGetVisibleSources Sep 04 22:41:08 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 04 22:41:08 volumio volumio[1274]: info: CoreCommandRouter::volumioGetState Sep 04 22:41:08 volumio volumio[1274]: info: CorePlayQueue::getTrack 0 Sep 04 22:41:08 volumio volumio[1274]: info: CoreCommandRouter::volumioGetState Sep 04 22:41:08 volumio volumio[1274]: info: CorePlayQueue::getTrack 0 Sep 04 22:41:08 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Sep 04 22:41:08 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Sep 04 22:41:08 volumio volumio[1274]: info: Received Get System Info Sep 04 22:41:08 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 04 22:41:08 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 04 22:41:08 volumio volumio[1274]: info: Discovery: Getting this device information Sep 04 22:41:08 volumio volumio[1274]: info: CoreCommandRouter::volumioGetState Sep 04 22:41:08 volumio volumio[1274]: info: CorePlayQueue::getTrack 0 Sep 04 22:41:08 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 04 22:41:08 volumio volumio[1274]: info: CoreCommandRouter::volumioGetState Sep 04 22:41:08 volumio volumio[1274]: info: CorePlayQueue::getTrack 0 Sep 04 22:41:08 volumio volumio[1274]: info: Listing playlists Sep 04 22:41:08 volumio sudo[1311]: pam_unix(sudo:session): session closed for user root Sep 04 22:41:10 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Sep 04 22:41:10 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Sep 04 22:41:10 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Sep 04 22:41:10 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Sep 04 22:41:10 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Sep 04 22:41:10 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Sep 04 22:41:10 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Sep 04 22:41:10 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Sep 04 22:41:10 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Sep 04 22:41:10 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Sep 04 22:41:10 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Sep 04 22:41:10 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Sep 04 22:41:10 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Sep 04 22:41:10 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Sep 04 22:41:10 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Sep 04 22:41:10 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Sep 04 22:41:10 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Sep 04 22:41:10 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Sep 04 22:41:10 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Sep 04 22:41:10 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Sep 04 22:41:10 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Sep 04 22:41:10 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Sep 04 22:41:10 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Sep 04 22:41:10 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Sep 04 22:41:10 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Sep 04 22:41:10 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Sep 04 22:41:10 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Sep 04 22:41:10 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Sep 04 22:41:10 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Sep 04 22:41:10 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Sep 04 22:41:10 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Sep 04 22:41:10 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Sep 04 22:41:10 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Sep 04 22:41:10 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Sep 04 22:41:10 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Sep 04 22:41:10 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Sep 04 22:41:11 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Sep 04 22:41:11 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Sep 04 22:41:11 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Sep 04 22:41:12 volumio volumio[1274]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Sep 04 22:41:13 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Sep 04 22:41:13 volumio wpa_supplicant[1101]: RRM: Ignoring radio measurement request: Not RRM network Sep 04 22:41:14 volumio systemd[1]: systemd-fsckd.service: Succeeded. Sep 04 22:41:15 volumio sudo[1587]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 04 22:41:15 volumio sudo[1587]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 22:41:15 volumio sudo[1587]: pam_unix(sudo:session): session closed for user root Sep 04 22:41:15 volumio sudo[1589]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 04 22:41:15 volumio sudo[1589]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 22:41:15 volumio sudo[1589]: pam_unix(sudo:session): session closed for user root Sep 04 22:41:15 volumio sudo[1593]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Sep 04 22:41:15 volumio sudo[1593]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 22:41:15 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Sep 04 22:41:15 volumio sudo[1593]: pam_unix(sudo:session): session closed for user root Sep 04 22:41:15 volumio volumio[1274]: info: Upmpdcli Daemon Started Sep 04 22:41:15 volumio volumio[1595]: Generating RSA private key, 4096 bit long modulus (2 primes) Sep 04 22:41:15 volumio systemd[1]: systemd-hostnamed.service: Succeeded. Sep 04 22:41:15 volumio volumio[1274]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Sep 04 22:41:15 volumio volumio[1274]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Sep 04 22:41:15 volumio volumio[1274]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Sep 04 22:41:15 volumio volumio[1274]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Sep 04 22:41:15 volumio volumio[1274]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Sep 04 22:41:15 volumio volumio[1274]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Sep 04 22:41:15 volumio volumio[1274]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Sep 04 22:41:15 volumio volumio[1274]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Sep 04 22:41:15 volumio volumio[1274]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Sep 04 22:41:15 volumio volumio[1274]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Sep 04 22:41:15 volumio volumio[1274]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Sep 04 22:41:15 volumio volumio[1274]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Sep 04 22:41:15 volumio volumio[1274]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Sep 04 22:41:15 volumio volumio[1274]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Sep 04 22:41:15 volumio volumio[1274]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Sep 04 22:41:15 volumio volumio[1274]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Sep 04 22:41:15 volumio volumio[1274]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Sep 04 22:41:15 volumio volumio[1274]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Sep 04 22:41:15 volumio volumio[1274]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Sep 04 22:41:15 volumio volumio[1274]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Sep 04 22:41:15 volumio volumio[1274]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Sep 04 22:41:15 volumio volumio[1274]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Sep 04 22:41:15 volumio volumio[1274]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Sep 04 22:41:15 volumio volumio[1274]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Sep 04 22:41:15 volumio volumio[1274]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Sep 04 22:41:15 volumio volumio[1274]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Sep 04 22:41:15 volumio volumio[1274]: info: Adding plugin bluetooth to MyMusic Plugins Sep 04 22:41:15 volumio volumio[1274]: info: Adding plugin multiroom to MyMusic Plugins Sep 04 22:41:15 volumio volumio[1274]: info: Adding plugin metavolumio to MyMusic Plugins Sep 04 22:41:15 volumio volumio[1274]: info: Adding plugin cd_controller to MyMusic Plugins Sep 04 22:41:15 volumio volumio[1274]: info: Adding plugin smart_inputs to MyMusic Plugins Sep 04 22:41:15 volumio volumio[1274]: info: Adding plugin tidalconnect to MyMusic Plugins Sep 04 22:41:15 volumio volumio[1274]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Sep 04 22:41:15 volumio volumio[1274]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Sep 04 22:41:15 volumio volumio[1274]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Sep 04 22:41:15 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 04 22:41:15 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 04 22:41:15 volumio volumio[1274]: info: Starting MyVolumio Remote Streaming Endpoints Sep 04 22:41:15 volumio volumio[1274]: info: MyVolumio login type: Token Sep 04 22:41:15 volumio volumio[1274]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Sep 04 22:41:15 volumio volumio[1274]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Sep 04 22:41:16 volumio volumio[1274]: info: Starting Streaming Service Transparent Proxy Sep 04 22:41:16 volumio volumio[1274]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Sep 04 22:41:16 volumio volumio[1274]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Sep 04 22:41:16 volumio volumio[1274]: info: Streaming services startup Sep 04 22:41:16 volumio volumio[1274]: info: Starting Streaming Daemon Sep 04 22:41:16 volumio sudo[1620]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Sep 04 22:41:16 volumio sudo[1620]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 22:41:16 volumio sudo[1620]: pam_unix(sudo:session): session closed for user root Sep 04 22:41:16 volumio volumio[1274]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Sep 04 22:41:16 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Sep 04 22:41:16 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Sep 04 22:41:16 volumio volumio[1274]: error: Cannot start Volumio Streaming Daemon Sep 04 22:41:16 volumio volumio[1274]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Sep 04 22:41:16 volumio volumio[1274]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Sep 04 22:41:16 volumio volumio[1274]: STREAMING PROXY: Starting server on port 3245 Sep 04 22:41:16 volumio volumio[1274]: Node JS runtime: 14 Sep 04 22:41:16 volumio volumio[1274]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Sep 04 22:41:17 volumio volumio[1274]: info: MyVolumio token set successfully Sep 04 22:41:17 volumio volumio[1274]: info: MYVOLUMIO: Adding device Sep 04 22:41:17 volumio volumio[1274]: info: MYVOLUMIO: Evaluating Server Sep 04 22:41:17 volumio volumio[1274]: info: MyVolumio status changed Sep 04 22:41:17 volumio volumio[1274]: info: Streaming services startup Sep 04 22:41:17 volumio volumio[1274]: info: Starting Streaming Daemon Sep 04 22:41:17 volumio volumio[1274]: info: Removing browser output: myVolumio user plan is not superstar Sep 04 22:41:17 volumio volumio[1274]: info: Removing audio output: Sep 04 22:41:17 volumio volumio[1274]: info: Stoppping Tunnel 1 Sep 04 22:41:17 volumio sudo[1645]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Sep 04 22:41:17 volumio sudo[1645]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 22:41:17 volumio sudo[1645]: pam_unix(sudo:session): session closed for user root Sep 04 22:41:17 volumio volumio[1274]: error: Cannot start Volumio Streaming Daemon Sep 04 22:41:17 volumio volumio[1274]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Sep 04 22:41:17 volumio volumio[1274]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Sep 04 22:41:17 volumio sudo[1647]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Sep 04 22:41:17 volumio sudo[1647]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 22:41:17 volumio sudo[1647]: pam_unix(sudo:session): session closed for user root Sep 04 22:41:17 volumio volumio[1274]: info: Remote SSH Stopped Sep 04 22:41:17 volumio volumio[1274]: info: Setting Geolocation for MyVolumio to eu4 Sep 04 22:41:17 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 04 22:41:17 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 04 22:41:17 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 04 22:41:17 volumio volumio[1274]: info: Successfully Added MyVolumio device Sep 04 22:41:18 volumio volumio[1274]: info: Updating MyVolumio device info Sep 04 22:41:18 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 04 22:41:18 volumio volumio[1274]: info: Successfully Updated MyVolumio device Sep 04 22:41:21 volumio startx[1479]: xinit: giving up Sep 04 22:41:21 volumio startx[1479]: xinit: unable to connect to X server: Cannot assign requested address Sep 04 22:41:21 volumio startx[1479]: xinit: server error Sep 04 22:41:21 volumio systemd[1]: volumio-kiosk.service: Main process exited, code=exited, status=1/FAILURE Sep 04 22:41:21 volumio systemd[1]: volumio-kiosk.service: Failed with result 'exit-code'. Sep 04 22:41:22 volumio wpa_supplicant[1101]: RRM: Ignoring radio measurement request: Not RRM network Sep 04 22:41:22 volumio volumio[1595]: ............................................................................................................................................................++++ Sep 04 22:41:25 volumio volumio[1595]: ...........................................................++++ Sep 04 22:41:25 volumio volumio[1595]: e is 65537 (0x010001) Sep 04 22:41:25 volumio volumio[1595]: writing RSA key Sep 04 22:41:28 volumio wpa_supplicant[1101]: RRM: Ignoring radio measurement request: Not RRM network Sep 04 22:41:30 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Sep 04 22:41:30 volumio volumio[1274]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 11 Sep 04 22:41:30 volumio volumio[1274]: info: CoreCommandRouter::volumioGetState Sep 04 22:41:30 volumio volumio[1274]: info: CorePlayQueue::getTrack 0 Sep 04 22:41:34 volumio wpa_supplicant[1101]: RRM: Ignoring radio measurement request: Not RRM network Sep 04 22:41:35 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 22:41:35 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 22:41:35 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Sep 04 22:41:35 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Sep 04 22:41:35 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Sep 04 22:41:35 volumio volumio[1274]: info: CoreCommandRouter::volumioGetBrowseSources Sep 04 22:41:35 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 04 22:41:36 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 04 22:41:36 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 04 22:41:36 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Sep 04 22:41:36 volumio volumio[1274]: error: MyVolumio Plugin failed to authenticate in a timely fashion Sep 04 22:41:36 volumio volumio[1274]: info: Completed starting MyVolumio Plugin Sep 04 22:41:36 volumio volumio[1274]: info: BOOT COMPLETED Sep 04 22:41:36 volumio volumio[1274]: [Metrics] CommandRouter: 31s 974.03ms Sep 04 22:41:36 volumio volumio[1274]: info: CoreCommandRouter::volumiosetStartupVolume Sep 04 22:41:36 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 04 22:41:36 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 04 22:41:36 volumio volumio[1274]: info: CoreCommandRouter::Close All Modals sent Sep 04 22:41:36 volumio volumio[1274]: info: CoreCommandRouter::Close All Modals sent Sep 04 22:41:36 volumio volumio-remote-updater[825]: No test mode Sep 04 22:41:36 volumio volumio-remote-updater[825]: No alpha test mode Sep 04 22:41:36 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Sep 04 22:41:36 volumio volumio[1274]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Sep 04 22:41:36 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Sep 04 22:41:37 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Sep 04 22:41:37 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Sep 04 22:41:37 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Sep 04 22:41:40 volumio wpa_supplicant[1101]: RRM: Ignoring radio measurement request: Not RRM network Sep 04 22:41:42 volumio volumio[1274]: verbose: New Socket.io Connection to 192.168.1.101 from 192.168.1.30 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/128.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Sep 04 22:41:42 volumio volumio[1274]: info: CoreCommandRouter::volumioGetState Sep 04 22:41:42 volumio volumio[1274]: info: CorePlayQueue::getTrack 0 Sep 04 22:41:42 volumio volumio[1274]: info: Received Get System Info Sep 04 22:41:42 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 04 22:41:42 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 04 22:41:42 volumio volumio[1274]: info: Discovery: Getting this device information Sep 04 22:41:42 volumio volumio[1274]: info: CoreCommandRouter::volumioGetState Sep 04 22:41:42 volumio volumio[1274]: info: CorePlayQueue::getTrack 0 Sep 04 22:41:42 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 04 22:41:42 volumio volumio[1274]: info: CoreCommandRouter::volumioGetState Sep 04 22:41:42 volumio volumio[1274]: info: CorePlayQueue::getTrack 0 Sep 04 22:41:42 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Sep 04 22:41:42 volumio volumio[1274]: info: CoreCommandRouter::volumioGetVisibleSources Sep 04 22:41:42 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 04 22:41:42 volumio volumio[1274]: info: CoreCommandRouter::volumioGetState Sep 04 22:41:42 volumio volumio[1274]: info: CorePlayQueue::getTrack 0 Sep 04 22:41:42 volumio volumio[1274]: info: CoreCommandRouter::volumioGetState Sep 04 22:41:42 volumio volumio[1274]: info: CorePlayQueue::getTrack 0 Sep 04 22:41:42 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Sep 04 22:41:42 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Sep 04 22:41:42 volumio volumio[1274]: info: Received Get System Info Sep 04 22:41:42 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 04 22:41:42 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 04 22:41:42 volumio volumio[1274]: info: Discovery: Getting this device information Sep 04 22:41:42 volumio volumio[1274]: info: CoreCommandRouter::volumioGetState Sep 04 22:41:42 volumio volumio[1274]: info: CorePlayQueue::getTrack 0 Sep 04 22:41:42 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 04 22:41:42 volumio volumio[1274]: info: CoreCommandRouter::volumioGetState Sep 04 22:41:42 volumio volumio[1274]: info: CorePlayQueue::getTrack 0 Sep 04 22:41:42 volumio volumio[1274]: info: Listing playlists Sep 04 22:41:42 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Sep 04 22:41:46 volumio wpa_supplicant[1101]: RRM: Ignoring radio measurement request: Not RRM network Sep 04 22:41:48 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Sep 04 22:41:48 volumio volumio[1274]: info: Received Get System Info Sep 04 22:41:48 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 04 22:41:48 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 04 22:41:48 volumio volumio[1274]: info: Discovery: Getting this device information Sep 04 22:41:48 volumio volumio[1274]: info: CoreCommandRouter::volumioGetState Sep 04 22:41:48 volumio volumio[1274]: info: CorePlayQueue::getTrack 0 Sep 04 22:41:48 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 04 22:41:50 volumio ntpd[987]: Soliciting pool server 194.177.34.116 Sep 04 22:41:50 volumio volumio[1274]: info: CoreCommandRouter::volumioGetState Sep 04 22:41:50 volumio volumio[1274]: info: CorePlayQueue::getTrack 0 Sep 04 22:41:51 volumio ntpd[987]: Soliciting pool server 31.170.8.123 Sep 04 22:41:52 volumio ntpd[987]: Soliciting pool server 54.36.61.42 Sep 04 22:41:52 volumio ntpd[987]: Soliciting pool server 162.159.200.1 Sep 04 22:41:53 volumio wpa_supplicant[1101]: RRM: Ignoring radio measurement request: Not RRM network Sep 04 22:41:53 volumio ntpd[987]: Soliciting pool server 95.81.173.74 Sep 04 22:41:53 volumio ntpd[987]: Soliciting pool server 51.75.17.219 Sep 04 22:41:54 volumio ntpd[987]: Soliciting pool server 82.65.248.56 Sep 04 22:41:54 volumio ntpd[987]: Soliciting pool server 129.250.35.251 Sep 04 22:41:54 volumio ntpd[987]: Soliciting pool server 51.158.153.13 Sep 04 22:41:55 volumio ntpd[987]: Soliciting pool server 51.15.191.239 Sep 04 22:41:55 volumio ntpd[987]: Soliciting pool server 91.224.149.41 Sep 04 22:41:55 volumio ntpd[987]: Soliciting pool server 51.38.113.118 Sep 04 22:41:56 volumio ntpd[987]: Soliciting pool server 82.64.42.185 Sep 04 22:41:56 volumio ntpd[987]: Soliciting pool server 2001:41d0:8:9233::1 Sep 04 22:41:56 volumio ntpd[987]: Soliciting pool server 108.61.176.155 Sep 04 22:41:57 volumio ntpd[987]: Soliciting pool server 5.39.80.51 Sep 04 22:41:57 volumio ntpd[987]: Soliciting pool server 37.59.63.125 Sep 04 22:41:58 volumio volumio[1274]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 04 22:41:58 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Sep 04 22:41:58 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Sep 04 22:41:58 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Sep 04 22:41:58 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableUIs Sep 04 22:41:59 volumio volumio[1274]: info: Received Get System Version Sep 04 22:41:59 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 04 22:41:59 volumio wpa_supplicant[1101]: RRM: Ignoring radio measurement request: Not RRM network Sep 04 22:42:28 volumio ntpd[987]: receive: Unexpected origin timestamp 0xea834497.47af7817 does not match aorg 0000000000.00000000 from server@82.64.42.185 xmt 0xea8344b4.7c471b56 Sep 04 22:42:28 volumio ntpd[987]: receive: Unexpected origin timestamp 0xea834497.47b7d795 does not match aorg 0000000000.00000000 from server@54.36.61.42 xmt 0xea8344b4.7cbd164b Sep 04 22:42:28 volumio ntpd[987]: receive: Unexpected origin timestamp 0xea834497.47b53f96 does not match aorg 0000000000.00000000 from server@129.250.35.251 xmt 0xea8344b4.7cbd3b33 Sep 04 22:42:28 volumio ntpd[987]: receive: Unexpected origin timestamp 0xea834497.47b44802 does not match aorg 0000000000.00000000 from server@51.158.153.13 xmt 0xea8344b4.7d50e64c Sep 04 22:42:28 volumio ntpd[987]: receive: Unexpected origin timestamp 0xea834497.47b6f898 does not match aorg 0000000000.00000000 from server@162.159.200.1 xmt 0xea8344b4.7c33e472 Sep 04 22:42:28 volumio ntpd[987]: receive: Unexpected origin timestamp 0xea834497.47b34dcf does not match aorg 0000000000.00000000 from server@51.38.113.118 xmt 0xea8344b4.7d823d68 Sep 04 22:42:29 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Sep 04 22:42:31 volumio volumio[1274]: info: CoreCommandRouter::volumioGetState Sep 04 22:42:31 volumio volumio[1274]: info: CorePlayQueue::getTrack 0 Sep 04 22:42:34 volumio wpa_supplicant[1101]: RRM: Ignoring radio measurement request: Not RRM network Sep 04 22:42:34 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Sep 04 22:42:34 volumio volumio[1274]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Sep 04 22:42:39 volumio sudo[1750]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/95-touch_display-plugin.conf Sep 04 22:42:39 volumio sudo[1750]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 22:42:39 volumio sudo[1750]: pam_unix(sudo:session): session closed for user root Sep 04 22:42:39 volumio sudo[1752]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start getty@tty1.service Sep 04 22:42:39 volumio sudo[1752]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 22:42:39 volumio sudo[1755]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl enable getty@tty1.service Sep 04 22:42:39 volumio sudo[1755]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 22:42:39 volumio volumio[1274]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/95-touch_display-plugin.conf set. Sep 04 22:42:39 volumio volumio[1274]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 04 22:42:39 volumio systemd[1]: Created slice system-getty.slice. Sep 04 22:42:39 volumio volumio[1274]: TypeError: Cannot read property 'split' of undefined Sep 04 22:42:39 volumio volumio[1274]: at /data/plugins/user_interface/touch_display/index.js:1258:37 Sep 04 22:42:39 volumio volumio[1274]: at ChildProcess.exithandler (child_process.js:299:7) Sep 04 22:42:39 volumio volumio[1274]: at ChildProcess.emit (events.js:315:20) Sep 04 22:42:39 volumio volumio[1274]: at maybeClose (internal/child_process.js:1048:16) Sep 04 22:42:39 volumio volumio[1274]: at Socket. (internal/child_process.js:439:11) Sep 04 22:42:39 volumio volumio[1274]: at Socket.emit (events.js:315:20) Sep 04 22:42:39 volumio volumio[1274]: at Pipe. (net.js:673:12) Sep 04 22:42:39 volumio volumio[1274]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 04 22:42:39 volumio sudo[1758]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumio-kiosk.service Sep 04 22:42:39 volumio sudo[1758]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 04 22:42:39 volumio systemd[1]: Started Getty on tty1. Sep 04 22:42:39 volumio sudo[1752]: pam_unix(sudo:session): session closed for user root Sep 04 22:42:39 volumio systemd[1]: Reloading. Sep 04 22:42:39 volumio 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. Sep 04 22:42:39 volumio sudo[1784]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-09-04 22:41 Sep 04 22:42:39 volumio sudo[1784]: 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="5fd3886148e72a9cecd88a772d1f6079fb64d11a" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8bb23b009e91ae4c7ecd678f193e7d3b281fca0c" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 22 Jul 2024 07:17:01 PM CEST" VOLUMIO_VERSION="3.742" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="2782e52360f70dfab079c82951ebbbb1"