-- Logs begin at Fri 2025-09-12 20:51:35 MSK, end at Fri 2025-09-12 20:53:52 MSK. -- Sep 12 20:53:04 volumio systemd-timedated[1119]: Changed local time to Fri Sep 12 20:53:04 2025 Sep 12 20:53:04 volumio sudo[1117]: pam_unix(sudo:session): session closed for user root Sep 12 20:53:04 volumio volumio-time-update[649]: volumio-time-update-util: System time updated successfully. Sep 12 20:53:04 volumio systemd[1]: Started Volumio Time Update Utility. Sep 12 20:53:04 volumio volumio[1092]: info: ------------------------------------------- Sep 12 20:53:04 volumio volumio[1092]: info: ----- Volumio3 ---- Sep 12 20:53:04 volumio volumio[1092]: info: ------------------------------------------- Sep 12 20:53:04 volumio volumio[1092]: info: ----- System startup ---- Sep 12 20:53:04 volumio volumio[1092]: info: ------------------------------------------- Sep 12 20:53:04 volumio sshd[1081]: Accepted password for volumio from 10.0.0.200 port 18117 ssh2 Sep 12 20:53:04 volumio sshd[1081]: pam_unix(sshd:session): session opened for user volumio by (uid=0) Sep 12 20:53:04 volumio systemd[1]: Created slice User Slice of UID 1000. Sep 12 20:53:04 volumio systemd[1]: Starting User Runtime Directory /run/user/1000... Sep 12 20:53:04 volumio systemd-logind[654]: New session 1 of user volumio. Sep 12 20:53:04 volumio systemd[1]: Started User Runtime Directory /run/user/1000. Sep 12 20:53:04 volumio systemd[1]: Starting User Manager for UID 1000... Sep 12 20:53:04 volumio systemd[1129]: pam_unix(systemd-user:session): session opened for user volumio by (uid=0) Sep 12 20:53:04 volumio systemd[1129]: Listening on GnuPG network certificate management daemon. Sep 12 20:53:04 volumio systemd[1129]: Listening on GnuPG cryptographic agent and passphrase cache (access for web browsers). Sep 12 20:53:04 volumio systemd[1129]: Reached target Paths. Sep 12 20:53:04 volumio systemd[1129]: Reached target Timers. Sep 12 20:53:04 volumio systemd[1129]: Listening on GnuPG cryptographic agent (ssh-agent emulation). Sep 12 20:53:05 volumio volumio[1092]: info: MYVOLUMIO Environment detected Sep 12 20:53:05 volumio systemd[1129]: Starting D-Bus User Message Bus Socket. Sep 12 20:53:05 volumio systemd[1129]: Listening on GnuPG cryptographic agent and passphrase cache. Sep 12 20:53:05 volumio systemd[1129]: Listening on GnuPG cryptographic agent and passphrase cache (restricted). Sep 12 20:53:05 volumio systemd[1129]: Listening on Sound System. Sep 12 20:53:05 volumio systemd[1129]: Listening on D-Bus User Message Bus Socket. Sep 12 20:53:05 volumio systemd[1129]: Reached target Sockets. Sep 12 20:53:05 volumio systemd[1129]: Reached target Basic System. Sep 12 20:53:05 volumio systemd[1129]: Reached target Default. Sep 12 20:53:05 volumio systemd[1129]: Startup finished in 328ms. Sep 12 20:53:05 volumio systemd[1]: Started User Manager for UID 1000. Sep 12 20:53:05 volumio systemd[1]: Started Session 1 of user volumio. Sep 12 20:53:05 volumio volumio[1092]: info: Plugin folders cleanup Sep 12 20:53:05 volumio volumio[1092]: info: Scanning into folder /volumio/app/plugins/ Sep 12 20:53:05 volumio volumio[1092]: info: Scanning category audio_interface Sep 12 20:53:05 volumio volumio[1092]: info: Scanning category miscellanea Sep 12 20:53:05 volumio volumio[1092]: info: Scanning category music_service Sep 12 20:53:05 volumio volumio[1092]: info: Scanning category plugins.json Sep 12 20:53:05 volumio volumio[1092]: info: Scanning category system_controller Sep 12 20:53:05 volumio volumio[1092]: info: Scanning category user_interface Sep 12 20:53:05 volumio volumio[1092]: info: Scanning into folder /data/plugins/ Sep 12 20:53:05 volumio volumio[1092]: info: Scanning category audio_interface Sep 12 20:53:05 volumio volumio[1092]: info: Scanning category music_service Sep 12 20:53:05 volumio volumio[1092]: info: Scanning category system_controller Sep 12 20:53:05 volumio volumio[1092]: info: Scanning category system_hardware Sep 12 20:53:05 volumio volumio[1092]: info: Scanning category user_interface Sep 12 20:53:05 volumio volumio[1092]: info: Plugin folders cleanup completed Sep 12 20:53:05 volumio volumio[1092]: info: ------------------------------------------- Sep 12 20:53:05 volumio volumio[1092]: info: ----- Core plugins startup ---- Sep 12 20:53:05 volumio volumio[1092]: info: ------------------------------------------- Sep 12 20:53:05 volumio volumio[1092]: info: Loading plugins from folder /volumio/app/plugins/ Sep 12 20:53:05 volumio volumio[1092]: info: Adding plugin upnp to MyMusic Plugins Sep 12 20:53:05 volumio nmbd[817]: [2025/09/12 20:53:05.233315, 0] ../lib/util/become_daemon.c:138(daemon_ready) Sep 12 20:53:05 volumio systemd[1]: Started Samba NMB Daemon. Sep 12 20:53:05 volumio volumio[1092]: info: Adding plugin airplay_emulation to MyMusic Plugins Sep 12 20:53:05 volumio volumio[1092]: info: Adding plugin upnp_browser to MyMusic Plugins Sep 12 20:53:05 volumio nmbd[817]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Sep 12 20:53:05 volumio volumio[1092]: info: Loading plugins from folder /data/plugins/ Sep 12 20:53:05 volumio volumio[1092]: info: Loading plugin "system"... Sep 12 20:53:05 volumio nmbd[817]: [2025/09/12 20:53:05.247415, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Sep 12 20:53:05 volumio nmbd[817]: query_name_response: Multiple (2) responses received for a query on subnet 10.0.0.125 for name WORKGROUP<1d>. Sep 12 20:53:05 volumio nmbd[817]: This response was from IP 10.0.0.4, reporting an IP address of 10.0.0.4. Sep 12 20:53:05 volumio volumio[1092]: info: Loading plugin "appearance"... Sep 12 20:53:05 volumio systemd[1]: Starting Samba Winbind Daemon... Sep 12 20:53:05 volumio winbindd[1154]: [2025/09/12 20:53:05.498292, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Sep 12 20:53:05 volumio winbindd[1154]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Sep 12 20:53:05 volumio systemd[1]: Started Samba Winbind Daemon. Sep 12 20:53:05 volumio winbindd[1154]: [2025/09/12 20:53:05.516211, 0] ../lib/util/become_daemon.c:138(daemon_ready) Sep 12 20:53:05 volumio winbindd[1154]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Sep 12 20:53:05 volumio systemd[1]: Starting Samba SMB Daemon... Sep 12 20:53:05 volumio volumio-remote-updater[637]: [2025-09-12 20:53:05] [connect] Successful connection Sep 12 20:53:05 volumio smbd[1162]: [2025/09/12 20:53:05.930269, 0] ../lib/util/become_daemon.c:138(daemon_ready) Sep 12 20:53:05 volumio systemd[1]: Started Samba SMB Daemon. Sep 12 20:53:05 volumio smbd[1162]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Sep 12 20:53:05 volumio systemd[1]: Reached target Multi-User System. Sep 12 20:53:05 volumio systemd[1]: Reached target Graphical Interface. Sep 12 20:53:05 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... Sep 12 20:53:06 volumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Sep 12 20:53:06 volumio systemd[1]: Started Update UTMP about System Runlevel Changes. Sep 12 20:53:06 volumio systemd[1]: Startup finished in 11.925s (kernel) + 26.686s (userspace) = 38.612s. Sep 12 20:53:06 volumio volumio[1092]: info: Loading plugin "network"... Sep 12 20:53:06 volumio volumio[1092]: info: Refreshing Cached IP Addresses Sep 12 20:53:06 volumio sudo[1172]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 12 20:53:06 volumio sudo[1172]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 20:53:06 volumio sudo[1172]: pam_unix(sudo:session): session closed for user root Sep 12 20:53:06 volumio sudo[1174]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 12 20:53:06 volumio sudo[1174]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 20:53:06 volumio sudo[1174]: pam_unix(sudo:session): session closed for user root Sep 12 20:53:06 volumio volumio[1092]: info: Loading plugin "services"... Sep 12 20:53:06 volumio volumio[1092]: info: Loading plugin "alsa_controller"... Sep 12 20:53:06 volumio sudo[1183]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Sep 12 20:53:06 volumio sudo[1183]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 20:53:06 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 12 20:53:06 volumio volumio[1092]: info: Loading plugin "wizard"... Sep 12 20:53:06 volumio volumio[1092]: info: Loading plugin "networkfs"... Sep 12 20:53:06 volumio volumio[1092]: info: Starting Udev Watcher for removable devices Sep 12 20:53:06 volumio sudo[1198]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=nextcloud-smb,password=Kr1njBog1234,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.82/smb-folder/Music /mnt/NAS/Треки Sep 12 20:53:06 volumio sudo[1198]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 20:53:06 volumio volumio[1092]: info: Ignoring mount for partition: boot Sep 12 20:53:06 volumio volumio[1092]: info: Ignoring mount for partition: volumio Sep 12 20:53:06 volumio volumio[1092]: info: Ignoring mount for partition: volumio_data Sep 12 20:53:06 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Sep 12 20:53:06 volumio volumio[1092]: info: Loading plugin "volumio_command_line_client"... Sep 12 20:53:06 volumio volumio[1092]: info: Loading plugin "upnp"... Sep 12 20:53:06 volumio volumio[1092]: info: [1757699586578] Starting Upmpd Daemon Sep 12 20:53:06 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Sep 12 20:53:06 volumio volumio[1092]: info: Loading plugin "my_music"... Sep 12 20:53:06 volumio volumio[1092]: info: Loading plugin "mpd"... Sep 12 20:53:06 volumio kernel: Key type cifs.spnego registered Sep 12 20:53:06 volumio kernel: Key type cifs.idmap registered Sep 12 20:53:06 volumio 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. Sep 12 20:53:06 volumio kernel: CIFS: Attempting to mount //192.168.1.82/smb-folder/Music Sep 12 20:53:06 volumio volumio[1092]: info: Loading plugin "upnp_browser"... Sep 12 20:53:07 volumio sshd[1212]: Accepted password for volumio from 10.0.0.200 port 18137 ssh2 Sep 12 20:53:07 volumio sshd[1212]: pam_unix(sshd:session): session opened for user volumio by (uid=0) Sep 12 20:53:07 volumio systemd-logind[654]: New session 3 of user volumio. Sep 12 20:53:07 volumio systemd[1]: Started Session 3 of user volumio. Sep 12 20:53:07 volumio volumio[1092]: info: Loading plugin "alarm-clock"... Sep 12 20:53:07 volumio volumio[1092]: info: Loading plugin "airplay_emulation"... Sep 12 20:53:07 volumio volumio[1092]: info: Starting Shairport Sync Sep 12 20:53:07 volumio volumio[1092]: info: Loading plugin "last_100"... Sep 12 20:53:07 volumio volumio[1092]: info: Loading plugin "webradio"... Sep 12 20:53:07 volumio volumio[1092]: info: Loading plugin "i2s_dacs"... Sep 12 20:53:07 volumio volumio[1092]: info: Loading plugin "volumiodiscovery"... Sep 12 20:53:07 volumio volumio[1092]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Sep 12 20:53:07 volumio volumio[1092]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 12 20:53:07 volumio node[1092]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Sep 12 20:53:07 volumio volumio[1092]: *** WARNING *** For more information see Sep 12 20:53:07 volumio volumio[1092]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Sep 12 20:53:07 volumio volumio[1092]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 12 20:53:07 volumio volumio[1092]: *** WARNING *** For more information see Sep 12 20:53:07 volumio node[1092]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 12 20:53:07 volumio node[1092]: *** WARNING *** For more information see Sep 12 20:53:07 volumio node[1092]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Sep 12 20:53:07 volumio node[1092]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 12 20:53:07 volumio node[1092]: *** WARNING *** For more information see Sep 12 20:53:07 volumio volumio[1092]: info: Applying required configuration parameters for plugin volumiodiscovery Sep 12 20:53:07 volumio volumio[1092]: info: Discovery: Started advertising with name: Volumio Sep 12 20:53:07 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Sep 12 20:53:07 volumio volumio[1092]: info: Loading plugin "jellyfin"... Sep 12 20:53:08 volumio volumio[1092]: info: Plugin autostart is not enabled Sep 12 20:53:08 volumio volumio[1092]: info: Loading plugin "gpio-buttons"... Sep 12 20:53:08 volumio volumio[1092]: info: GPIO-Buttons initialized Sep 12 20:53:08 volumio volumio[1092]: info: Loading plugin "now_playing"... Sep 12 20:53:09 volumio volumio[1092]: info: Loading plugin "outputs"... Sep 12 20:53:09 volumio volumio[1092]: info: Loading plugin "albumart"... Sep 12 20:53:09 volumio volumio[1092]: info: Plugin example_plugin is not enabled Sep 12 20:53:09 volumio volumio[1092]: info: Loading plugin "inputs"... Sep 12 20:53:09 volumio volumio[1092]: info: Loading plugin "updater_comm"... Sep 12 20:53:10 volumio volumio[1092]: Forking 3 albumart workers Sep 12 20:53:10 volumio volumio[1092]: info: Plugin mpdemulation is not enabled Sep 12 20:53:10 volumio volumio[1092]: info: Loading plugin "rest_api"... Sep 12 20:53:10 volumio volumio[1092]: info: Loading plugin "websocket"... Sep 12 20:53:10 volumio volumio[1092]: info: Starting Socket.io Server version 2.3.0 Sep 12 20:53:10 volumio volumio[1092]: info: Loading plugin "fusiondsp"... Sep 12 20:53:10 volumio sudo[1183]: pam_unix(sudo:session): session closed for user root Sep 12 20:53:10 volumio volumio[1092]: Starting albumart workers Sep 12 20:53:10 volumio volumio[1092]: Starting albumart workers Sep 12 20:53:10 volumio volumio[1092]: info: Applying required configuration parameters for plugin fusiondsp Sep 12 20:53:10 volumio volumio[1092]: Starting albumart workers Sep 12 20:53:11 volumio volumio[1092]: info: Loading plugin "yandex_music"... Sep 12 20:53:12 volumio systemd[1]: systemd-fsckd.service: Succeeded. Sep 12 20:53:12 volumio volumio[1092]: info: Applying required configuration parameters for plugin yandex_music Sep 12 20:53:12 volumio volumio[1092]: info: Loading plugin "backup_restore"... Sep 12 20:53:12 volumio sh[569]: timed out Sep 12 20:53:12 volumio dhcpcd[602]: timed out Sep 12 20:53:12 volumio sh[569]: dhcpcd exited Sep 12 20:53:12 volumio dhcpcd[602]: dhcpcd exited Sep 12 20:53:12 volumio sh[569]: ifup: failed to bring up eth0 Sep 12 20:53:12 volumio systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE Sep 12 20:53:12 volumio systemd[1]: ifup@eth0.service: Failed with result 'exit-code'. Sep 12 20:53:12 volumio volumio[1092]: info: Applying required configuration parameters for plugin backup_restore Sep 12 20:53:12 volumio volumio[1092]: info: Plugin gpio_control is not enabled Sep 12 20:53:12 volumio volumio[1092]: info: Loading plugin "rotaryencoder2"... Sep 12 20:53:13 volumio volumio[1092]: info: Loading plugin "touch_display"... Sep 12 20:53:13 volumio volumio[1092]: info: Applying required configuration parameters for plugin touch_display Sep 12 20:53:13 volumio volumio[1092]: info: Loading i18n strings for locale ru Sep 12 20:53:13 volumio volumio[1092]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found. Sep 12 20:53:13 volumio volumio[1092]: Updating browse sources language Sep 12 20:53:13 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 12 20:53:13 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 12 20:53:13 volumio volumio[1092]: info: CoreCommandRouter::initPlayerControls Sep 12 20:53:13 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 12 20:53:13 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 12 20:53:13 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 12 20:53:13 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 12 20:53:13 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 12 20:53:13 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 12 20:53:13 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 12 20:53:13 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 12 20:53:13 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 12 20:53:13 volumio volumio[1092]: Express server listening on port 3000 Sep 12 20:53:13 volumio volumio[1092]: [Metrics] WebUI: 10s 35.10ms Sep 12 20:53:13 volumio volumio[1092]: info: CoreStateMachine::resetVolumioState Sep 12 20:53:13 volumio volumio[1092]: info: CoreStateMachine::getcurrentVolume Sep 12 20:53:13 volumio volumio[1092]: info: CoreCommandRouter::volumioRetrievevolume Sep 12 20:53:13 volumio volumio[1092]: info: Volumio Network Manager: Network status updated: 2 Sep 12 20:53:13 volumio volumio[1092]: verbose: New Socket.io Connection to 10.0.0.125 from 10.0.0.200 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/140.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 Sep 12 20:53:13 volumio volumio[1092]: verbose: New Socket.io Connection to 10.0.0.125 from 10.0.0.200 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/140.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2 Sep 12 20:53:13 volumio volumio[1092]: verbose: New Socket.io Connection to 10.0.0.125 from 10.0.0.200 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/140.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3 Sep 12 20:53:13 volumio volumio[1092]: info: CoreStateMachine::pushState Sep 12 20:53:13 volumio volumio[1092]: info: CorePlayQueue::getTrack 0 Sep 12 20:53:13 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 12 20:53:13 volumio volumio[1092]: info: CoreCommandRouter::volumioPushState Sep 12 20:53:13 volumio volumio[1092]: info: CoreStateMachine::updateTrackBlock Sep 12 20:53:13 volumio volumio[1092]: info: CorePlayQueue::getTrackBlock Sep 12 20:53:13 volumio volumio[1092]: info: CoreCommandRouter::volumioRetrievevolume Sep 12 20:53:13 volumio volumio[1092]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Sep 12 20:53:13 volumio volumio[1092]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Sep 12 20:53:13 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 12 20:53:13 volumio volumio[1092]: info: Reloading queue from file Sep 12 20:53:14 volumio volumio[1092]: info: CoreStateMachine::setRepeat null single undefined Sep 12 20:53:14 volumio volumio[1092]: info: CoreStateMachine::pushState Sep 12 20:53:14 volumio volumio[1092]: info: CorePlayQueue::getTrack 0 Sep 12 20:53:14 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 12 20:53:14 volumio volumio[1092]: info: CoreCommandRouter::volumioPushState Sep 12 20:53:14 volumio volumio[1092]: info: CoreStateMachine::setRandom false Sep 12 20:53:14 volumio volumio[1092]: info: CoreStateMachine::pushState Sep 12 20:53:14 volumio volumio[1092]: info: CorePlayQueue::getTrack 0 Sep 12 20:53:14 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 12 20:53:14 volumio volumio[1092]: info: CoreCommandRouter::volumioPushState Sep 12 20:53:14 volumio volumio[1092]: info: Setting Device type: Raspberry PI Sep 12 20:53:14 volumio volumio[1092]: info: CoreStateMachine::pushState Sep 12 20:53:14 volumio volumio[1092]: info: CorePlayQueue::getTrack 0 Sep 12 20:53:14 volumio volumio[1092]: info: CoreCommandRouter::volumioPushState Sep 12 20:53:14 volumio volumio[1092]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Sep 12 20:53:14 volumio volumio[1092]: info: USB Boot Capable - System SBC Revision found in cpuinfo: c03112 Sep 12 20:53:14 volumio volumio[1092]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Sep 12 20:53:14 volumio volumio[1092]: info: Discovery: adding 8aa00845-b990-4e3d-be52-d988b2f2f205 Sep 12 20:53:14 volumio volumio[1092]: info: Discovery: Found device Volumio Sep 12 20:53:14 volumio volumio[1092]: info: CoreCommandRouter::volumioGetState Sep 12 20:53:14 volumio volumio[1092]: info: CorePlayQueue::getTrack 0 Sep 12 20:53:14 volumio systemd[1]: systemd-hostnamed.service: Succeeded. Sep 12 20:53:16 volumio sudo[1341]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 12 20:53:16 volumio sudo[1341]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 20:53:16 volumio sudo[1341]: pam_unix(sudo:session): session closed for user root Sep 12 20:53:16 volumio sudo[1343]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 12 20:53:16 volumio sudo[1343]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 20:53:16 volumio sudo[1343]: pam_unix(sudo:session): session closed for user root Sep 12 20:53:16 volumio sudo[1347]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Sep 12 20:53:16 volumio sudo[1347]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 20:53:16 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Sep 12 20:53:16 volumio sudo[1347]: pam_unix(sudo:session): session closed for user root Sep 12 20:53:16 volumio volumio[1092]: info: Upmpdcli Daemon Started Sep 12 20:53:16 volumio sudo[1198]: pam_unix(sudo:session): session closed for user root Sep 12 20:53:16 volumio volumio[1092]: info: Cannot mount NAS Треки at system boot, trial number 1 ,retrying in 5 seconds Sep 12 20:53:16 volumio volumio[1092]: info: Completed loading Core Plugins Sep 12 20:53:16 volumio volumio[1092]: info: Preparing to generate the ALSA configuration file Sep 12 20:53:16 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Sep 12 20:53:16 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -115 Sep 12 20:53:16 volumio volumio[1349]: Generating RSA private key, 4096 bit long modulus (2 primes) Sep 12 20:53:16 volumio volumio[1092]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Sep 12 20:53:16 volumio volumio[1092]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Sep 12 20:53:16 volumio volumio[1092]: info: Reading ALSA contributions from plugins. Sep 12 20:53:16 volumio volumio[1092]: info: Asound.conf file unchanged, so no further update is needed Sep 12 20:53:16 volumio volumio[1092]: info: Output device has changed, restarting MPD Sep 12 20:53:16 volumio sudo[1366]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Sep 12 20:53:16 volumio sudo[1366]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 20:53:16 volumio volumio[1092]: info: Output device has changed, restarting Shairport Sync Sep 12 20:53:16 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 12 20:53:16 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 12 20:53:16 volumio sudo[1366]: pam_unix(sudo:session): session closed for user root Sep 12 20:53:16 volumio sudo[1368]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Sep 12 20:53:16 volumio sudo[1368]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 20:53:16 volumio systemd[1]: Stopping Music Player Daemon... Sep 12 20:53:16 volumio volumio[1092]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 12 20:53:16 volumio volumio[1092]: info: ___________ START PLUGINS ___________ Sep 12 20:53:16 volumio volumio[1092]: info: ControllerMpd::onStart: Initializing MPD Sep 12 20:53:16 volumio volumio[1092]: info: Creating MPD Configuration file Sep 12 20:53:16 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 12 20:53:16 volumio volumio[1092]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 12 20:53:16 volumio volumio[1092]: info: [1757699596925] CoreMusicLibrary::Adding element Медиа-серверы Sep 12 20:53:16 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 12 20:53:16 volumio sudo[1375]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Sep 12 20:53:16 volumio sudo[1377]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Sep 12 20:53:16 volumio sudo[1375]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 20:53:16 volumio sudo[1377]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 20:53:16 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 12 20:53:16 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 12 20:53:16 volumio sudo[1375]: pam_unix(sudo:session): session closed for user root Sep 12 20:53:16 volumio volumio[1092]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 12 20:53:16 volumio systemd[1]: mpd.service: Succeeded. Sep 12 20:53:16 volumio systemd[1]: Stopped Music Player Daemon. Sep 12 20:53:16 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 12 20:53:16 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 12 20:53:17 volumio volumio[1092]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 12 20:53:17 volumio volumio[1092]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 12 20:53:17 volumio volumio[1092]: info: [1757699597022] CoreMusicLibrary::Adding element Last_100 Sep 12 20:53:17 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 12 20:53:17 volumio volumio[1092]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 12 20:53:17 volumio volumio[1092]: info: [1757699597024] CoreMusicLibrary::Adding element Webradio Sep 12 20:53:17 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 12 20:53:17 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 12 20:53:17 volumio volumio[1092]: info: Initializing BBC Radios Sep 12 20:53:17 volumio systemd[1]: Starting Music Player Daemon... Sep 12 20:53:17 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 12 20:53:17 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 12 20:53:17 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Sep 12 20:53:17 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 12 20:53:17 volumio volumio[1092]: info: Discovery: Getting this device information Sep 12 20:53:17 volumio volumio[1092]: info: CoreCommandRouter::volumioGetState Sep 12 20:53:17 volumio volumio[1092]: info: CorePlayQueue::getTrack 0 Sep 12 20:53:17 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 12 20:53:17 volumio sudo[1384]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Sep 12 20:53:17 volumio sudo[1384]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 20:53:17 volumio sudo[1384]: pam_unix(sudo:session): session closed for user root Sep 12 20:53:17 volumio volumio[1092]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 12 20:53:17 volumio volumio[1092]: info: [1757699597123] CoreMusicLibrary::Adding element Jellyfin Sep 12 20:53:17 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 12 20:53:17 volumio volumio[1092]: Cannot find translation for source Jellyfin Sep 12 20:53:17 volumio volumio[1092]: info: [jellyfin] Initialized plugin with device info: {"id":"8aa00845-b990-4e3d-be52-d988b2f2f205","host":"http://10.0.0.125","name":"Volumio","type":"device","serviceName":"Volumio","state":{"status":"stop","volume":"100","mute":false,"artist":"тима ищет свет","track":"бык","albumart":"https://avatars.yandex.net/get-music-content/4489759/8b5d6cdf.a.14561830-1/200x200"}} Sep 12 20:53:17 volumio volumio[1092]: info: GPIO-Buttons: Reading config and creating triggers... Sep 12 20:53:17 volumio volumio[1092]: info: GPIO-Buttons: shutdown on pin 515 Sep 12 20:53:17 volumio volumio[1092]: info: [now-playing] ConfigUpdater: config is up to date. Sep 12 20:53:17 volumio volumio[1092]: info: Loading i18n strings for locale ru Sep 12 20:53:17 volumio volumio[1092]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found. Sep 12 20:53:17 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Sep 12 20:53:17 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 12 20:53:17 volumio volumio[1092]: info: FusionDsp - mixtype--------------------- Software Sep 12 20:53:17 volumio volumio[1092]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 12 20:53:17 volumio volumio[1092]: info: [1757699597209] CoreMusicLibrary::Adding element Яндекс Музыка Sep 12 20:53:17 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 12 20:53:17 volumio volumio[1092]: Cannot find translation for source Jellyfin Sep 12 20:53:17 volumio volumio[1092]: Cannot find translation for source Яндекс Музыка Sep 12 20:53:17 volumio volumio[1092]: info: [ROTARYENCODER2] loadI18nStrings: /data/plugins/system_hardware/rotaryencoder2/i18n/strings_ru.json Sep 12 20:53:17 volumio volumio[1092]: info: [ROTARYENCODER2] loadI18nStrings: ru not found. Fallback to en Sep 12 20:53:17 volumio volumio[1092]: info: [ROTARYENCODER2] onStart: Config loaded: Sep 12 20:53:17 volumio volumio[1092]: info: [ROTARYENCODER2]{"syncSave":true,"autosave":true,"autosaveDelay":1000,"saved":true,"atomicSave":false,"data":{"enabled0":{"type":"boolean","value":true},"rotaryType0":{"type":"number","value":1},"pinA0":{"type":"string","value":"20"},"pinB0":{"type":"string","value":"21"},"dialAction0":{"type":"number","value":1},"socketCmdCW0":{"type":"string","value":""},"socketDataCW0":{"type":"string","value":""},"socketCmdCCW0":{"type":"string","value":""},"socketDataCCW0":{"type":"string","value":""},"pinPush0":{"type":"number","value":16},"pinPushDebounce0":{"type":"number","value":50},"pushState0":{"type":"boolean","value":true},"pushAction0":{"type":"number","value":3},"socketCmdPush0":{"type":"string","value":""},"socketDataPush0":{"type":"string","value":""},"longPushAction0":{"type":"number","value":0},"socketCmdLongPush0":{"type":"string","value":""},"socketDataLongPush0":{"type":"string","value":""},"delayLongPush0":{"type":"string","value":"2000"},"doublePushAction0":{"type":"number","value":0},"socketCmdDoublePush0":{"type":"string","value":""},"socketDataDoublePush0":{"type":"string","value":""},"delayDoublePush0":{"type":"string","value":"700"},"enabled1":{"type":"boolean","value":false},"rotaryType1":{"type":"number","value":0},"pinA1":{"type":"string","value":""},"pinB1":{"type":"string","value":""},"dialAction1":{"type":"number","value":0},"socketCmdCW1":{"type":"string","value":""},"socketDataCW1":{"type":"string","value":""},"socketCmdCCW1":{"type":"string","value":""},"socketDataCCW1":{"type":"string","value":""},"pinPush1":{"type":"number","value":0},"pinPushDebounce1":{"type":"number","value":0},"pushState1":{"type":"boolean","value":true},"pushAction1":{"type":"number","value":0},"socketCmdPush1":{"type":"string","value":""},"socketDataPush1":{"type":"string","value":""},"longPushAction1":{"type":"number","value":0},"socketCmdLongPush1":{"type":"string","value":""},"socketDataLongPush1":{"type":"string","value":""},"delayLongPush1":{"type":"string","value":"1500"},"doublePushAction1":{"type":"number","value":0},"socketCmdDoublePush1":{"type":"string","value":""},"socketDataDoublePush1":{"type":"string","value":""},"delayDoublePush1":{"type":"string","value":"700"},"enabled2":{"type":"boolean","value":false},"rotaryType2":{"type":"number","value":0},"pinA2":{"type":"string","value":""},"pinB2":{"type":"string","value":""},"dialAction2":{"type":"number","value":0},"socketCmdCW2":{"type":"string","value":""},"socketDataCW2":{"type":"string","value":""},"socketCmdCCW2":{"type":"string","value":""},"socketDataCCW2":{"type":"string","value":""},"pinPush2":{"type":"number","value":0},"pinPushDebounce2":{"type":"number","value":0},"pushState2":{"type":"boolean","value":true},"pushAction2":{"type":"number","value":0},"socketCmdPush2":{"type":"string","value":""},"socketDataPush2":{"type":"string","value":""},"longPushAction2":{"type":"number","value":0},"socketCmdLongPush2":{"type":"string","value":""},"socketDataLongPush2":{"type":"string","value":""},"delayLongPush2":{"type":"string","value":"1500"},"doublePushAction2":{"type":"number","value":0},"socketCmdDoublePush2":{"type":"string","value":""},"socketDataDoublePush2":{"type":"string","value":""},"delayDoublePush2":{"type":"string","value":"700"},"logging":{"type":"boolean","value":true},"loggingJSON":{"type":"boolean","value":true}},"callbacks":{"_":{}},"filePath":"/data/configuration/system_hardware/rotaryencoder2/config.json"} Sep 12 20:53:17 volumio volumio[1092]: info: [ROTARYENCODER2] installAllOverlays: 1,2,3 Sep 12 20:53:17 volumio volumio[1092]: info: [ROTARYENCODER2] installAllOverlays: 1,2 Sep 12 20:53:17 volumio volumio[1092]: info: [ROTARYENCODER2] installAllOverlays: 1 Sep 12 20:53:17 volumio volumio[1092]: info: [ROTARYENCODER2] installAllOverlays: Sep 12 20:53:17 volumio volumio[1092]: info: [ROTARYENCODER2] installAllOverlays: end of recursion. Sep 12 20:53:17 volumio volumio[1092]: info: Loading i18n strings for locale ru Sep 12 20:53:17 volumio volumio[1092]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found. Sep 12 20:53:17 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 12 20:53:17 volumio volumio[1092]: info: Volumio Calling Home Sep 12 20:53:17 volumio volumio[1092]: info: GPIO-Buttons started Sep 12 20:53:17 volumio volumio[1092]: info: Preparing to generate the ALSA configuration file Sep 12 20:53:17 volumio volumio[1092]: info: [ROTARYENCODER2] addOverlay for Rotary: 20 21 1 Sep 12 20:53:17 volumio volumio[1092]: info: [ROTARYENCODER2] addOverlay: executing command: /usr/bin/sudo /usr/bin/dtoverlay rotary-encoder pin_a=20 pin_b=21 relative_axis=true steps-per-period=1 & Sep 12 20:53:17 volumio sudo[1421]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay rotary-encoder pin_a=20 pin_b=21 relative_axis=true steps-per-period=1 Sep 12 20:53:17 volumio sudo[1421]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 20:53:17 volumio sudo[1427]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl disable getty@tty1.service Sep 12 20:53:17 volumio sudo[1427]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 20:53:17 volumio sudo[1430]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Sep 12 20:53:17 volumio sudo[1430]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 20:53:17 volumio systemd[1]: Reloading. Sep 12 20:53:17 volumio sudo[1425]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop getty@tty1.service Sep 12 20:53:17 volumio sudo[1425]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 20:53:17 volumio kernel: pinctrl-bcm2835 fe200000.gpio: pin gpio20 already requested by fe203000.i2s; cannot claim for rotary@14 Sep 12 20:53:17 volumio kernel: pinctrl-bcm2835 fe200000.gpio: pin-20 (rotary@14) status -22 Sep 12 20:53:17 volumio kernel: pinctrl-bcm2835 fe200000.gpio: could not request pin 20 (gpio20) from group gpio20 on device pinctrl-bcm2711 Sep 12 20:53:17 volumio kernel: rotary-encoder rotary@14: Error applying setting, reverse things back Sep 12 20:53:17 volumio sudo[1421]: pam_unix(sudo:session): session closed for user root Sep 12 20:53:17 volumio volumio[1092]: info: [now-playing] Fetching API key... Sep 12 20:53:17 volumio volumio[1092]: info: [now-playing] App is listening on port 4004. Sep 12 20:53:17 volumio volumio[1092]: warn: [now-playing] MyBackgroundMonitor is now watching /data/INTERNAL/NowPlayingPlugin/My Backgrounds Sep 12 20:53:17 volumio volumio[1092]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Sep 12 20:53:17 volumio volumio[1092]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Sep 12 20:53:17 volumio volumio[1092]: info: Reading ALSA contributions from plugins. Sep 12 20:53:17 volumio volumio[1092]: info: touch_display: Backlight interface detected. Sep 12 20:53:17 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 12 20:53:17 volumio volumio[1092]: info: MPD Permissions set Sep 12 20:53:17 volumio volumio[1092]: info: Volumio called home Sep 12 20:53:17 volumio volumio[1092]: 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 12 20:53:17 volumio volumio[1092]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Sep 12 20:53:17 volumio volumio[1092]: info: /dev/input: Sep 12 20:53:17 volumio volumio[1092]: by-id Sep 12 20:53:17 volumio volumio[1092]: by-path Sep 12 20:53:17 volumio volumio[1092]: event0 Sep 12 20:53:17 volumio volumio[1092]: event1 Sep 12 20:53:17 volumio volumio[1092]: event2 Sep 12 20:53:17 volumio volumio[1092]: event3 Sep 12 20:53:17 volumio volumio[1092]: event4 Sep 12 20:53:17 volumio volumio[1092]: mice Sep 12 20:53:17 volumio volumio[1092]: mouse0 Sep 12 20:53:17 volumio volumio[1092]: mouse1 Sep 12 20:53:17 volumio volumio[1092]: /dev/input/by-id: Sep 12 20:53:17 volumio volumio[1092]: usb-123_COM_Smart_Control-event-if01 Sep 12 20:53:17 volumio volumio[1092]: usb-123_COM_Smart_Control-event-kbd Sep 12 20:53:17 volumio volumio[1092]: usb-123_COM_Smart_Control-if01-event-mouse Sep 12 20:53:17 volumio volumio[1092]: usb-123_COM_Smart_Control-if01-mouse Sep 12 20:53:17 volumio volumio[1092]: /dev/input/by-path: Sep 12 20:53:17 volumio volumio[1092]: platform-fd500000.pcie-pci-0000:01:00.0-usb-0:1.4:1.0-event-kbd Sep 12 20:53:17 volumio volumio[1092]: platform-fd500000.pcie-pci-0000:01:00.0-usb-0:1.4:1.1-event Sep 12 20:53:17 volumio volumio[1092]: platform-fd500000.pcie-pci-0000:01:00.0-usb-0:1.4:1.1-event-mouse Sep 12 20:53:17 volumio volumio[1092]: platform-fd500000.pcie-pci-0000:01:00.0-usb-0:1.4:1.1-mouse Sep 12 20:53:17 volumio volumio[1092]: platform-soc:firmware:touchscreen-event Sep 12 20:53:17 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 12 20:53:17 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 12 20:53:17 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 12 20:53:17 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 12 20:53:17 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 12 20:53:17 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 12 20:53:17 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 12 20:53:17 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 12 20:53:17 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 12 20:53:17 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 12 20:53:17 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 12 20:53:17 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 12 20:53:17 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 12 20:53:17 volumio volumio[1092]: info: touch_display: Raspberry Pi Foundation touch screen detected. Sep 12 20:53:17 volumio volumio[1092]: info: Starting Shairport Sync Sep 12 20:53:18 volumio volumio[1092]: info: Starting Shairport Sync Sep 12 20:53:18 volumio sudo[1466]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/99-vc4.conf Sep 12 20:53:18 volumio sudo[1466]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 20:53:18 volumio mpd[1401]: Sep 12 20:53 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Sep 12 20:53:18 volumio volumio[1092]: info: Starting Shairport Sync Sep 12 20:53:18 volumio sudo[1469]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 12 20:53:18 volumio sudo[1469]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 20:53:18 volumio volumio[1092]: info: CoreCommandRouter::volumioGetState Sep 12 20:53:18 volumio volumio[1092]: info: CorePlayQueue::getTrack 0 Sep 12 20:53:18 volumio sudo[1470]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+w /sys/class/backlight/rpi_backlight/brightness Sep 12 20:53:18 volumio sudo[1470]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 20:53:18 volumio sudo[1470]: pam_unix(sudo:session): session closed for user root Sep 12 20:53:18 volumio sudo[1474]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 12 20:53:18 volumio sudo[1474]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 20:53:18 volumio sudo[1472]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 12 20:53:18 volumio sudo[1466]: pam_unix(sudo:session): session closed for user root Sep 12 20:53:18 volumio sudo[1472]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 20:53:18 volumio sudo[1427]: pam_unix(sudo:session): session closed for user root Sep 12 20:53:18 volumio volumio[1092]: info: CoreCommandRouter::volumioGetState Sep 12 20:53:18 volumio volumio[1092]: info: CorePlayQueue::getTrack 0 Sep 12 20:53:18 volumio systemd[1]: Reloading. Sep 12 20:53:18 volumio volumio[1092]: info: touch_display: File permissions for backlight brightness control set. Sep 12 20:53:18 volumio volumio[1092]: info: Asound.conf file unchanged, so no further update is needed Sep 12 20:53:18 volumio volumio[1092]: info: Output device has changed, restarting MPD Sep 12 20:53:18 volumio sudo[1481]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Sep 12 20:53:18 volumio sudo[1481]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 20:53:18 volumio sudo[1481]: pam_unix(sudo:session): session closed for user root Sep 12 20:53:18 volumio volumio[1092]: info: Output device has changed, restarting Shairport Sync Sep 12 20:53:18 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 12 20:53:18 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 12 20:53:18 volumio sudo[1491]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Sep 12 20:53:18 volumio sudo[1491]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 20:53:18 volumio volumio[1092]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 12 20:53:18 volumio volumio[1092]: info: touch_display: systemctl disable getty@tty1.service succeeded. Sep 12 20:53:18 volumio volumio[1092]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/99-vc4.conf set. Sep 12 20:53:18 volumio volumio[1092]: info: MPD Permissions set Sep 12 20:53:18 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 12 20:53:18 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 12 20:53:18 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 12 20:53:18 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 12 20:53:18 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 12 20:53:18 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 12 20:53:18 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 12 20:53:18 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 12 20:53:18 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 12 20:53:18 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 12 20:53:18 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 12 20:53:18 volumio volumio[1092]: info: Starting Shairport Sync Sep 12 20:53:18 volumio sudo[1509]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 12 20:53:18 volumio sudo[1509]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 20:53:18 volumio volumio[1092]: verbose: New Socket.io Connection to 10.0.0.125 from 10.0.0.200 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/140.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Sep 12 20:53:18 volumio volumio[1092]: info: CoreCommandRouter::volumioGetState Sep 12 20:53:18 volumio volumio[1092]: info: CorePlayQueue::getTrack 0 Sep 12 20:53:18 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Sep 12 20:53:18 volumio volumio[1092]: info: Listing playlists Sep 12 20:53:18 volumio volumio[1092]: info: [ROTARYENCODER2] addOverlay for Button: 16 true up Sep 12 20:53:18 volumio volumio[1092]: info: [ROTARYENCODER2] addOverlay: executing command: /usr/bin/sudo /usr/bin/dtoverlay gpio-key gpio=16 active_low=1 gpio_pull=up keycode=20 & Sep 12 20:53:18 volumio sudo[1522]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay gpio-key gpio=16 active_low=1 gpio_pull=up keycode=20 Sep 12 20:53:18 volumio sudo[1522]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 20:53:18 volumio sudo[1522]: pam_unix(sudo:session): session closed for user root Sep 12 20:53:18 volumio kernel: input: button@10 as /devices/platform/button@10/input/input5 Sep 12 20:53:18 volumio systemd[1]: Started Music Player Daemon. Sep 12 20:53:18 volumio sudo[1377]: pam_unix(sudo:session): session closed for user root Sep 12 20:53:18 volumio sudo[1368]: pam_unix(sudo:session): session closed for user root Sep 12 20:53:18 volumio sudo[1430]: pam_unix(sudo:session): session closed for user root Sep 12 20:53:18 volumio volumio[1092]: info: touch_display: systemctl daemon-reload succeeded. Sep 12 20:53:18 volumio sudo[1538]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service Sep 12 20:53:18 volumio sudo[1538]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 20:53:18 volumio volumio[1092]: info: /dev/input: Sep 12 20:53:18 volumio volumio[1092]: by-id Sep 12 20:53:18 volumio volumio[1092]: by-path Sep 12 20:53:18 volumio volumio[1092]: event0 Sep 12 20:53:18 volumio volumio[1092]: event1 Sep 12 20:53:18 volumio volumio[1092]: event2 Sep 12 20:53:18 volumio volumio[1092]: event3 Sep 12 20:53:18 volumio volumio[1092]: event4 Sep 12 20:53:18 volumio volumio[1092]: event5 Sep 12 20:53:18 volumio volumio[1092]: mice Sep 12 20:53:18 volumio volumio[1092]: mouse0 Sep 12 20:53:18 volumio volumio[1092]: mouse1 Sep 12 20:53:18 volumio volumio[1092]: /dev/input/by-id: Sep 12 20:53:18 volumio volumio[1092]: usb-123_COM_Smart_Control-event-if01 Sep 12 20:53:18 volumio volumio[1092]: usb-123_COM_Smart_Control-event-kbd Sep 12 20:53:18 volumio volumio[1092]: usb-123_COM_Smart_Control-if01-event-mouse Sep 12 20:53:18 volumio volumio[1092]: usb-123_COM_Smart_Control-if01-mouse Sep 12 20:53:18 volumio volumio[1092]: /dev/input/by-path: Sep 12 20:53:18 volumio volumio[1092]: platform-fd500000.pcie-pci-0000:01:00.0-usb-0:1.4:1.0-event-kbd Sep 12 20:53:18 volumio volumio[1092]: platform-fd500000.pcie-pci-0000:01:00.0-usb-0:1.4:1.1-event Sep 12 20:53:18 volumio volumio[1092]: platform-fd500000.pcie-pci-0000:01:00.0-usb-0:1.4:1.1-event-mouse Sep 12 20:53:18 volumio volumio[1092]: platform-fd500000.pcie-pci-0000:01:00.0-usb-0:1.4:1.1-mouse Sep 12 20:53:18 volumio volumio[1092]: platform-soc:firmware:touchscreen-event Sep 12 20:53:18 volumio volumio[1092]: error: MPD error: The expression evaluated to a falsy value: Sep 12 20:53:18 volumio volumio[1092]: assert.ok(self.idling) Sep 12 20:53:18 volumio volumio[1092]: error: The expression evaluated to a falsy value: Sep 12 20:53:18 volumio volumio[1092]: assert.ok(self.idling) Sep 12 20:53:19 volumio volumio[1092]: info: MPD running with PID1401 Sep 12 20:53:19 volumio volumio[1092]: ,establishing connection Sep 12 20:53:19 volumio volumio[1092]: error: updateQueue error: null Sep 12 20:53:19 volumio volumio[1092]: error: updateQueue error: null Sep 12 20:53:19 volumio systemd[1]: Started Volumio Kiosk. Sep 12 20:53:19 volumio systemd[1]: Stopping Music Player Daemon... Sep 12 20:53:19 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Sep 12 20:53:19 volumio sudo[1538]: pam_unix(sudo:session): session closed for user root Sep 12 20:53:19 volumio volumio[1092]: info: touch_display: systemctl start volumio-kiosk.service succeeded. Sep 12 20:53:19 volumio volumio[1092]: info: touch_display: Volumio Kiosk started. Sep 12 20:53:19 volumio systemd-udevd[1437]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Sep 12 20:53:19 volumio volumio[1092]: info: CoreCommandRouter::volumioGetState Sep 12 20:53:19 volumio volumio[1092]: info: CorePlayQueue::getTrack 0 Sep 12 20:53:19 volumio systemd[1]: shairport-sync.service: Succeeded. Sep 12 20:53:19 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Sep 12 20:53:19 volumio systemd[1]: mpd.service: Succeeded. Sep 12 20:53:19 volumio systemd[1]: Stopped Music Player Daemon. Sep 12 20:53:19 volumio volumio[1092]: info: CoreCommandRouter::volumioGetState Sep 12 20:53:19 volumio volumio[1092]: info: CorePlayQueue::getTrack 0 Sep 12 20:53:19 volumio sudo[1425]: pam_unix(sudo:session): session closed for user root Sep 12 20:53:19 volumio volumio[1092]: info: touch_display: systemctl stop getty@tty1.service succeeded. Sep 12 20:53:19 volumio volumio[1092]: info: touch_display: X display number found: Sep 12 20:53:19 volumio sudo[1472]: pam_unix(sudo:session): session closed for user root Sep 12 20:53:19 volumio systemd[1]: Starting Music Player Daemon... Sep 12 20:53:19 volumio sudo[1509]: pam_unix(sudo:session): session closed for user root Sep 12 20:53:19 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Sep 12 20:53:19 volumio sudo[1469]: pam_unix(sudo:session): session closed for user root Sep 12 20:53:19 volumio sudo[1474]: pam_unix(sudo:session): session closed for user root Sep 12 20:53:19 volumio volumio[1092]: info: Shairport-Sync Started Sep 12 20:53:19 volumio volumio[1092]: Error adding Membership: Error: addMembership EINVAL Sep 12 20:53:19 volumio volumio[1092]: info: Shairport-Sync Started Sep 12 20:53:19 volumio startx[1545]: X.Org X Server 1.20.4 Sep 12 20:53:19 volumio startx[1545]: X Protocol Version 11, Revision 0 Sep 12 20:53:19 volumio startx[1545]: Build Operating System: Linux 5.4.0-109-generic armv8l Raspbian Sep 12 20:53:19 volumio startx[1545]: Current Operating System: Linux volumio 6.6.62-v7l+ #1816 SMP Mon Nov 18 15:33:33 GMT 2024 armv7l Sep 12 20:53:19 volumio startx[1545]: Kernel command line: coherent_pool=1M 8250.nr_uarts=0 snd_bcm2835.enable_headphones=0 cgroup_disable=memory numa_policy=interleave snd_bcm2835.enable_headphones=1 snd_bcm2835.enable_hdmi=1 bcm2708_fb.fbwidth=800 bcm2708_fb.fbheight=480 bcm2708_fb.fbswap=1 smsc95xx.macaddr=DC:A6:32:B7:B9:1A vc_mem.mem_base=0x3ec00000 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=ttyS0,115200 console=tty1 imgpart=UUID=fb80cb44-b4d3-4b36-be35-613cba0a09fb imgfile=/volumio_current.sqsh bootpart=UUID=51B1-040D datapart=UUID=2899bccc-8620-4c7a-b56a-43fd2f7a836a 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 Sep 12 20:53:19 volumio startx[1545]: Build Date: 04 April 2023 07:50:56AM Sep 12 20:53:19 volumio startx[1545]: xorg-server 2:1.20.4-1+rpt4+deb10u9 (https://www.debian.org/support) Sep 12 20:53:19 volumio startx[1545]: Current version of pixman: 0.36.0 Sep 12 20:53:19 volumio startx[1545]: Before reporting problems, check http://wiki.x.org Sep 12 20:53:19 volumio startx[1545]: to make sure that you have the latest version. Sep 12 20:53:19 volumio startx[1545]: Markers: (--) probed, (**) from config file, (==) default setting, Sep 12 20:53:19 volumio startx[1545]: (++) from command line, (!!) notice, (II) informational, Sep 12 20:53:19 volumio startx[1545]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown. Sep 12 20:53:19 volumio startx[1545]: (==) Log file: "/var/log/Xorg.0.log", Time: Fri Sep 12 20:53:19 2025 Sep 12 20:53:19 volumio startx[1545]: (==) Using config directory: "/etc/X11/xorg.conf.d" Sep 12 20:53:19 volumio startx[1545]: (==) Using system config directory "/usr/share/X11/xorg.conf.d" Sep 12 20:53:19 volumio sudo[1574]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Sep 12 20:53:19 volumio sudo[1574]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 20:53:19 volumio sudo[1574]: pam_unix(sudo:session): session closed for user root Sep 12 20:53:19 volumio volumio[1092]: info: camilladsp spawned new process with pid 1594, instance 1, run: true Sep 12 20:53:19 volumio volumio[1092]: info: camilladsp service started and running in background, instance 1 Sep 12 20:53:19 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 12 20:53:19 volumio volumio[1092]: info: FusionDsp - AAAAAAAAAAAAAA-> 22050 44100 48000 88200 96000 176400 192000 384000 <-AAAAAAAAAAAAA Sep 12 20:53:19 volumio volumio[1092]: info: FusionDsp loaded Sep 12 20:53:19 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 12 20:53:19 volumio sudo[1598]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Sep 12 20:53:19 volumio volumio[1092]: info: FusionDsp - Reporting Fusion DSP Enabled Sep 12 20:53:19 volumio volumio[1092]: info: Adding Signal Path Element [object Object] Sep 12 20:53:19 volumio volumio[1092]: info: Adding fusiondspeq DSP Signal Path Element Sep 12 20:53:19 volumio sudo[1598]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 20:53:19 volumio volumio[1092]: info: FusionDsp - ---- installed callbackRead Sep 12 20:53:19 volumio volumio[1092]: info: FusionDsp - If filter freq >samplerate/2 then disable it Sep 12 20:53:19 volumio volumio[1092]: info: [now-playing] OpenWeatherMap API key obtained. Sep 12 20:53:19 volumio volumio[1092]: info: touch_display: X display number found: 0 Sep 12 20:53:19 volumio volumio[1092]: info: Shairport-Sync Started Sep 12 20:53:19 volumio systemd[1]: Started FusionDsp Daemon. Sep 12 20:53:19 volumio volumio[1092]: error: FusionDsp - WebSocket error: [object Object] Sep 12 20:53:19 volumio volumio[1092]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Sep 12 20:53:19 volumio sudo[1598]: pam_unix(sudo:session): session closed for user root Sep 12 20:53:19 volumio volumio[1092]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Sep 12 20:53:19 volumio vncserver-x11[816]: ConsoleDisplay: Found running X server (pid=1579, binary=/usr/lib/xorg/Xorg) Sep 12 20:53:19 volumio volumio[1092]: info: touch_display: X display number found: 0 Sep 12 20:53:19 volumio volumio[1092]: info: [ROTARYENCODER2] attachAllListeners: 1,2,3 Sep 12 20:53:19 volumio volumio[1092]: info: [ROTARYENCODER2] attachAllListeners: 1,2 Sep 12 20:53:19 volumio volumio[1092]: info: [ROTARYENCODER2] attachAllListeners: 1 Sep 12 20:53:19 volumio volumio[1092]: info: [ROTARYENCODER2] attachAllListeners: Sep 12 20:53:19 volumio volumio[1092]: info: [ROTARYENCODER2] attachAllListeners: end of recursion. Sep 12 20:53:19 volumio volumio[1092]: info: [ROTARYENCODER2] checkOverlayExists: Checking for existing overlays for Rotary: 1 type: rotary Sep 12 20:53:19 volumio sudo[1619]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Sep 12 20:53:19 volumio sudo[1619]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 20:53:19 volumio sudo[1619]: pam_unix(sudo:session): session closed for user root Sep 12 20:53:19 volumio volumio[1092]: info: [ROTARYENCODER2] checkOverlayExists: check pinA=20pinB=21 in Overlays (in load order): Sep 12 20:53:19 volumio volumio[1092]: 0: rotary-encoder pin_a=20 pin_b=21 relative_axis=true steps-per-period=1 Sep 12 20:53:19 volumio volumio[1092]: 1: gpio-key gpio=16 active_low=1 gpio_pull=up keycode=20 Sep 12 20:53:19 volumio volumio[1092]: info: [ROTARYENCODER2] checkOverlayExists: rotary 1 uses overlay 0 Sep 12 20:53:19 volumio volumio[1092]: info: [ROTARYENCODER2] attachAllListeners: attach rotary 1 Sep 12 20:53:19 volumio volumio[1092]: info: [ROTARYENCODER2] attachListener: path: /dev/input/by-path/platform-rotary@14-event, type: rotary Sep 12 20:53:19 volumio volumio[1092]: info: [ROTARYENCODER2] checkOverlayExists: Checking for existing overlays for Rotary: 1 type: button Sep 12 20:53:20 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 12 20:53:20 volumio volumio[1092]: info: Discovery: Getting this device information Sep 12 20:53:20 volumio volumio[1092]: info: CoreCommandRouter::volumioGetState Sep 12 20:53:20 volumio volumio[1092]: info: CorePlayQueue::getTrack 0 Sep 12 20:53:20 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 12 20:53:20 volumio sudo[1631]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Sep 12 20:53:20 volumio sudo[1631]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 20:53:20 volumio sudo[1631]: pam_unix(sudo:session): session closed for user root Sep 12 20:53:20 volumio mpd[1593]: Sep 12 20:53 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Sep 12 20:53:20 volumio volumio[1092]: info: [ROTARYENCODER2] checkOverlayExists: check pinA=16pinB=undefined in Overlays (in load order): Sep 12 20:53:20 volumio volumio[1092]: 0: rotary-encoder pin_a=20 pin_b=21 relative_axis=true steps-per-period=1 Sep 12 20:53:20 volumio volumio[1092]: 1: gpio-key gpio=16 active_low=1 gpio_pull=up keycode=20 Sep 12 20:53:20 volumio volumio[1092]: info: [ROTARYENCODER2] checkOverlayExists: button 1 uses overlay 1 Sep 12 20:53:20 volumio volumio[1092]: info: [ROTARYENCODER2] attachAllListeners: attach button 1 Sep 12 20:53:20 volumio volumio[1092]: info: [ROTARYENCODER2] attachListener: path: /dev/input/by-path/platform-button@10-event, type: button Sep 12 20:53:20 volumio volumio[1092]: info: [ROTARYENCODER2] attachAllListeners rotaries: Sep 12 20:53:20 volumio volumio[1092]: info: [ROTARYENCODER2][{"_events":{},"_eventsCount":0,"_closesNeeded":3,"_closesGot":3,"connected":false,"signalCode":null,"exitCode":1,"killed":false,"spawnfile":"/bin/cat","_handle":null,"spawnargs":["/bin/cat","/dev/input/by-path/platform-rotary@14-event"],"pid":1624,"stdin":{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":false,"sync":true,"needReadable":false,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":true,"errored":null,"closed":true,"closeEmitted":true,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null,"readable":false},"_events":{},"_eventsCount":1,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":true,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":true,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},"stdout":{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":true,"endEmitted":true,"reading":false,"sync":false,"needReadable":false,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":true,"errored":null,"closed":true,"closeEmitted":true,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null},"_events":{},"_eventsCount":2,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":true,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":true,"writable":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},"stderr":{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":true,"ended":true,"endEmitted":true,"reading":false,"sync":false,"needReadable":false,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":true,"errored":null,"closed":true,"closeEmitted":true,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null},"_events":{},"_eventsCount":2,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":true,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":true,"writable":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},"stdio":[{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":false,"sync":true,"needReadable":false,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":true,"errored":null,"closed":true,"closeEmitted":true,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null,"readable":false},"_events":{},"_eventsCount":1,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":true,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":true,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":true,"endEmitted":true,"reading":false,"sync":false,"needReadable":false,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":true,"errored":null,"closed":true,"closeEmitted":true,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null},"_events":{},"_eventsCount":2,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":true,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":true,"writable":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":true,"ended":true,"endEmitted":true,"reading":false,"sync":false,"needReadable":false,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":true,"errored":null,"closed":true,"closeEmitted":true,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null},"_events":{},"_eventsCount":2,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":true,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":true,"writable":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null}]},null,null] Sep 12 20:53:20 volumio volumio[1092]: info: [ROTARYENCODER2] attachAllListeners buttons: Sep 12 20:53:20 volumio volumio[1092]: info: [ROTARYENCODER2][{"_events":{},"_eventsCount":0,"_closesNeeded":3,"_closesGot":0,"connected":false,"signalCode":null,"exitCode":null,"killed":false,"spawnfile":"/bin/cat","_handle":{"pid":1634},"spawnargs":["/bin/cat","/dev/input/by-path/platform-button@10-event"],"pid":1634,"stdin":{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":false,"sync":true,"needReadable":false,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null,"readable":false},"_events":{},"_eventsCount":1,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},"stdout":{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":true,"sync":false,"needReadable":true,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null},"_events":{},"_eventsCount":2,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"writable":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},"stderr":{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":true,"sync":false,"needReadable":true,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null},"_events":{},"_eventsCount":2,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"writable":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},"stdio":[{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":false,"sync":true,"needReadable":false,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null,"readable":false},"_events":{},"_eventsCount":1,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":true,"sync":false,"needReadable":true,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null},"_events":{},"_eventsCount":2,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"writable":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":true,"sync":false,"needReadable":true,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null},"_events":{},"_eventsCount":2,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"writable":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null}]},null,null] Sep 12 20:53:20 volumio volumio[1092]: info: [ROTARYENCODER2] attachAllListeners rotaries: Sep 12 20:53:20 volumio volumio[1092]: info: [ROTARYENCODER2][{"_events":{},"_eventsCount":0,"_closesNeeded":3,"_closesGot":3,"connected":false,"signalCode":null,"exitCode":1,"killed":false,"spawnfile":"/bin/cat","_handle":null,"spawnargs":["/bin/cat","/dev/input/by-path/platform-rotary@14-event"],"pid":1624,"stdin":{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":false,"sync":true,"needReadable":false,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":true,"errored":null,"closed":true,"closeEmitted":true,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null,"readable":false},"_events":{},"_eventsCount":1,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":true,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":true,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},"stdout":{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":true,"endEmitted":true,"reading":false,"sync":false,"needReadable":false,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":true,"errored":null,"closed":true,"closeEmitted":true,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null},"_events":{},"_eventsCount":2,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":true,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":true,"writable":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},"stderr":{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":true,"ended":true,"endEmitted":true,"reading":false,"sync":false,"needReadable":false,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":true,"errored":null,"closed":true,"closeEmitted":true,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null},"_events":{},"_eventsCount":2,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":true,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":true,"writable":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},"stdio":[{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":false,"sync":true,"needReadable":false,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":true,"errored":null,"closed":true,"closeEmitted":true,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null,"readable":false},"_events":{},"_eventsCount":1,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":true,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":true,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":true,"endEmitted":true,"reading":false,"sync":false,"needReadable":false,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":true,"errored":null,"closed":true,"closeEmitted":true,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null},"_events":{},"_eventsCount":2,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":true,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":true,"writable":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":true,"ended":true,"endEmitted":true,"reading":false,"sync":false,"needReadable":false,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":true,"errored":null,"closed":true,"closeEmitted":true,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null},"_events":{},"_eventsCount":2,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":true,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":true,"writable":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null}]},null,null] Sep 12 20:53:20 volumio volumio[1092]: info: [ROTARYENCODER2] attachAllListeners buttons: Sep 12 20:53:20 volumio volumio[1092]: info: [ROTARYENCODER2][{"_events":{},"_eventsCount":0,"_closesNeeded":3,"_closesGot":0,"connected":false,"signalCode":null,"exitCode":null,"killed":false,"spawnfile":"/bin/cat","_handle":{"pid":1634},"spawnargs":["/bin/cat","/dev/input/by-path/platform-button@10-event"],"pid":1634,"stdin":{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":false,"sync":true,"needReadable":false,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null,"readable":false},"_events":{},"_eventsCount":1,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},"stdout":{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":true,"sync":false,"needReadable":true,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null},"_events":{},"_eventsCount":2,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"writable":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},"stderr":{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":true,"sync":false,"needReadable":true,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null},"_events":{},"_eventsCount":2,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"writable":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},"stdio":[{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":false,"sync":true,"needReadable":false,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null,"readable":false},"_events":{},"_eventsCount":1,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":true,"sync":false,"needReadable":true,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null},"_events":{},"_eventsCount":2,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"writable":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":true,"sync":false,"needReadable":true,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null},"_events":{},"_eventsCount":2,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"writable":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null}]},null,null] Sep 12 20:53:20 volumio volumio[1092]: info: [ROTARYENCODER2] onStart: Attach Event-handles now. Sep 12 20:53:20 volumio volumio[1092]: info: [ROTARYENCODER2] Now addAllEventHandles for rotaries. Sep 12 20:53:20 volumio volumio[1092]: info: [ROTARYENCODER2] addEventHandle for rotary: 1 type: rotary Sep 12 20:53:20 volumio volumio[1092]: info: [ROTARYENCODER2] Now addAllEventHandles for buttons. Sep 12 20:53:20 volumio volumio[1092]: info: [ROTARYENCODER2] addEventHandle for rotary: 1 type: button Sep 12 20:53:20 volumio volumio[1092]: info: [ROTARYENCODER2] addEventHandle: adding handle : Sep 12 20:53:20 volumio volumio[1092]: info: [ROTARYENCODER2]{"_events":{},"_eventsCount":0,"_closesNeeded":3,"_closesGot":0,"connected":false,"signalCode":null,"exitCode":null,"killed":false,"spawnfile":"/bin/cat","_handle":{"pid":1634},"spawnargs":["/bin/cat","/dev/input/by-path/platform-button@10-event"],"pid":1634,"stdin":{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":false,"sync":true,"needReadable":false,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null,"readable":false},"_events":{},"_eventsCount":1,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},"stdout":{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":true,"sync":false,"needReadable":true,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null},"_events":{},"_eventsCount":2,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"writable":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},"stderr":{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":true,"sync":false,"needReadable":true,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null},"_events":{},"_eventsCount":2,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"writable":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},"stdio":[{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":false,"sync":true,"needReadable":false,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null,"readable":false},"_events":{},"_eventsCount":1,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":true,"sync":false,"needReadable":true,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null},"_events":{},"_eventsCount":2,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"writable":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null},{"connecting":false,"_hadError":false,"_parent":null,"_host":null,"_readableState":{"objectMode":false,"highWaterMark":16384,"buffer":{"head":null,"tail":null,"length":0},"length":0,"pipes":[],"flowing":null,"ended":false,"endEmitted":false,"reading":true,"sync":false,"needReadable":true,"emittedReadable":false,"readableListening":false,"resumeScheduled":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"destroyed":false,"errored":null,"closed":false,"closeEmitted":false,"defaultEncoding":"utf8","awaitDrainWriters":null,"multiAwaitDrain":false,"readingMore":false,"decoder":null,"encoding":null},"_events":{},"_eventsCount":2,"_writableState":{"objectMode":false,"highWaterMark":16384,"finalCalled":false,"needDrain":false,"ending":false,"ended":false,"finished":false,"destroyed":false,"decodeStrings":false,"defaultEncoding":"utf8","length":0,"writing":false,"corked":0,"sync":true,"bufferProcessing":false,"writecb":null,"writelen":0,"afterWriteTickInfo":null,"buffered":[],"bufferedIndex":0,"allBuffers":true,"allNoop":true,"pendingcb":0,"prefinished":false,"errorEmitted":false,"emitClose":false,"autoDestroy":false,"errored":null,"closed":false,"writable":false,"closeEmitted":false},"allowHalfOpen":false,"_sockname":null,"_pendingData":null,"_pendingEncoding":"","server":null,"_server":null}]} Sep 12 20:53:20 volumio volumio[1092]: info: [ROTARYENCODER2] onStart: Plugin successfully started. Sep 12 20:53:20 volumio volumio[1092]: info: Completed starting Core Plugins Sep 12 20:53:20 volumio volumio[1092]: info: ------------------------------------------- Sep 12 20:53:20 volumio volumio[1092]: info: ----- MyVolumio plugins startup ---- Sep 12 20:53:20 volumio volumio[1092]: info: ------------------------------------------- Sep 12 20:53:20 volumio volumio[1092]: info: [MyVolumio PluginManager] Fetching plans data.... Sep 12 20:53:20 volumio systemd[1]: Started Music Player Daemon. Sep 12 20:53:20 volumio sudo[1491]: pam_unix(sudo:session): session closed for user root Sep 12 20:53:20 volumio volumio[1092]: error: updateQueue error: null Sep 12 20:53:20 volumio volumio-remote-updater[637]: [2025-09-12 20:53:20] [connect] Successful connection Sep 12 20:53:20 volumio volumio-remote-updater[637]: [2025-09-12 20:53:20] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1757699600 101 Sep 12 20:53:20 volumio volumio[1092]: 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 12 20:53:21 volumio volumio[1092]: info: CoreCommandRouter::volumioGetState Sep 12 20:53:21 volumio volumio[1092]: info: CorePlayQueue::getTrack 0 Sep 12 20:53:21 volumio volumio[1092]: info: touch_display: Setting screensaver timeout to 3600 seconds. Sep 12 20:53:21 volumio sudo[1712]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=nextcloud-smb,password=Kr1njBog1234,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.82/smb-folder/Music /mnt/NAS/Треки Sep 12 20:53:21 volumio sudo[1712]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 20:53:21 volumio kernel: CIFS: Attempting to mount //192.168.1.82/smb-folder/Music Sep 12 20:53:21 volumio sudo[1424]: volumio : TTY=pts/0 ; PWD=/home/volumio ; USER=root ; COMMAND=/usr/bin/apt update Sep 12 20:53:21 volumio sudo[1424]: pam_unix(sudo:session): session opened for user root by volumio(uid=0) Sep 12 20:53:24 volumio volumio[1092]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Sep 12 20:53:24 volumio volumio[1092]: Cannot compose Albumart path Sep 12 20:53:24 volumio volumio[1092]: Cannot compose Albumart path Sep 12 20:53:24 volumio volumio[1092]: Cannot compose Albumart path Sep 12 20:53:26 volumio volumio[1349]: ........................................................................................................++++ Sep 12 20:53:27 volumio sudo[1424]: pam_unix(sudo:session): session closed for user root Sep 12 20:53:28 volumio volumio[1349]: ...............++++ Sep 12 20:53:28 volumio volumio[1349]: e is 65537 (0x010001) Sep 12 20:53:28 volumio volumio[1349]: writing RSA key Sep 12 20:53:28 volumio volumio[1092]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Sep 12 20:53:28 volumio volumio[1092]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Sep 12 20:53:28 volumio volumio[1092]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Sep 12 20:53:28 volumio volumio[1092]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Sep 12 20:53:28 volumio volumio[1092]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Sep 12 20:53:28 volumio volumio[1092]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Sep 12 20:53:28 volumio volumio[1092]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Sep 12 20:53:28 volumio volumio[1092]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Sep 12 20:53:28 volumio volumio[1092]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Sep 12 20:53:28 volumio volumio[1092]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Sep 12 20:53:28 volumio volumio[1092]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Sep 12 20:53:28 volumio volumio[1092]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Sep 12 20:53:28 volumio volumio[1092]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Sep 12 20:53:28 volumio volumio[1092]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Sep 12 20:53:28 volumio volumio[1092]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Sep 12 20:53:28 volumio volumio[1092]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Sep 12 20:53:28 volumio volumio[1092]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Sep 12 20:53:28 volumio volumio[1092]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Sep 12 20:53:28 volumio volumio[1092]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Sep 12 20:53:28 volumio volumio[1092]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Sep 12 20:53:28 volumio volumio[1092]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Sep 12 20:53:28 volumio volumio[1092]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Sep 12 20:53:28 volumio volumio[1092]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Sep 12 20:53:28 volumio volumio[1092]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Sep 12 20:53:28 volumio volumio[1092]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Sep 12 20:53:28 volumio volumio[1092]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Sep 12 20:53:28 volumio volumio[1092]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Sep 12 20:53:28 volumio volumio[1092]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Sep 12 20:53:28 volumio volumio[1092]: info: Adding plugin bluetooth to MyMusic Plugins Sep 12 20:53:28 volumio volumio[1092]: info: Adding plugin multiroom to MyMusic Plugins Sep 12 20:53:28 volumio volumio[1092]: info: Adding plugin metavolumio to MyMusic Plugins Sep 12 20:53:28 volumio volumio[1092]: info: Adding plugin cd_controller to MyMusic Plugins Sep 12 20:53:28 volumio volumio[1092]: info: Adding plugin qobuzconnect to MyMusic Plugins Sep 12 20:53:28 volumio volumio[1092]: info: Adding plugin smart_inputs to MyMusic Plugins Sep 12 20:53:28 volumio volumio[1092]: info: Adding plugin tidalconnect to MyMusic Plugins Sep 12 20:53:28 volumio volumio[1092]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Sep 12 20:53:30 volumio volumio[1092]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Sep 12 20:53:30 volumio volumio[1092]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Sep 12 20:53:30 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 12 20:53:30 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 12 20:53:30 volumio volumio[1092]: info: Starting MyVolumio Remote Streaming Endpoints Sep 12 20:53:30 volumio volumio[1092]: info: MyVolumio login type: Token Sep 12 20:53:30 volumio volumio[1092]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Sep 12 20:53:30 volumio volumio[1092]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Sep 12 20:53:30 volumio volumio[1092]: info: Starting Streaming Service Transparent Proxy Sep 12 20:53:30 volumio volumio[1092]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Sep 12 20:53:30 volumio volumio[1092]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Sep 12 20:53:30 volumio volumio[1092]: info: Streaming services startup Sep 12 20:53:30 volumio volumio[1092]: info: Starting Streaming Daemon Sep 12 20:53:30 volumio sudo[2136]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Sep 12 20:53:30 volumio sudo[2136]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 20:53:30 volumio sudo[2136]: pam_unix(sudo:session): session closed for user root Sep 12 20:53:30 volumio volumio[1092]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Sep 12 20:53:31 volumio volumio[1092]: error: Cannot start Volumio Streaming Daemon Sep 12 20:53:31 volumio volumio[1092]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Sep 12 20:53:31 volumio volumio[1092]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Sep 12 20:53:31 volumio volumio[1092]: STREAMING PROXY: Starting server on port 3245 Sep 12 20:53:31 volumio volumio[1092]: Node JS runtime: 14 Sep 12 20:53:31 volumio volumio[1092]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Sep 12 20:53:31 volumio sudo[1712]: pam_unix(sudo:session): session closed for user root Sep 12 20:53:31 volumio volumio[1092]: info: Cannot mount NAS Треки at system boot, trial number 2 ,retrying in 5 seconds Sep 12 20:53:31 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Sep 12 20:53:31 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -115 Sep 12 20:53:32 volumio volumio[1092]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11 Sep 12 20:53:32 volumio volumio[1092]: info: CALLMETHOD: user_interface now_playing getPluginInfo undefined Sep 12 20:53:32 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: now_playing , getPluginInfo Sep 12 20:53:32 volumio volumio[1092]: info: Listing playlists Sep 12 20:53:32 volumio volumio[1092]: info: CoreCommandRouter::volumioGetQueue Sep 12 20:53:32 volumio volumio[1092]: info: CoreStateMachine::getQueue Sep 12 20:53:32 volumio volumio[1092]: info: CorePlayQueue::getQueue Sep 12 20:53:32 volumio volumio[1092]: info: CoreCommandRouter::volumioGetVisibleSources Sep 12 20:53:32 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 12 20:53:32 volumio volumio[1092]: info: CoreCommandRouter::volumioGetState Sep 12 20:53:32 volumio volumio[1092]: info: CorePlayQueue::getTrack 0 Sep 12 20:53:33 volumio volumio[1092]: info: MyVolumio token set successfully Sep 12 20:53:33 volumio volumio[1092]: info: MYVOLUMIO: Adding device Sep 12 20:53:33 volumio volumio[1092]: info: MYVOLUMIO: Evaluating Server Sep 12 20:53:33 volumio volumio[1092]: info: MyVolumio status changed Sep 12 20:53:33 volumio volumio[1092]: info: Streaming services startup Sep 12 20:53:33 volumio volumio[1092]: info: Starting Streaming Daemon Sep 12 20:53:33 volumio volumio[1092]: info: Removing browser output: myVolumio user plan is not superstar Sep 12 20:53:33 volumio volumio[1092]: info: Removing audio output: Sep 12 20:53:33 volumio volumio[1092]: info: Stoppping Tunnel 1 Sep 12 20:53:33 volumio sudo[2170]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Sep 12 20:53:33 volumio sudo[2170]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 20:53:33 volumio sudo[2173]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Sep 12 20:53:33 volumio sudo[2173]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 20:53:33 volumio sudo[2170]: pam_unix(sudo:session): session closed for user root Sep 12 20:53:33 volumio volumio[1092]: error: Cannot start Volumio Streaming Daemon Sep 12 20:53:33 volumio volumio[1092]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Sep 12 20:53:33 volumio volumio[1092]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Sep 12 20:53:33 volumio sudo[2173]: pam_unix(sudo:session): session closed for user root Sep 12 20:53:33 volumio volumio[1092]: info: Remote SSH Stopped Sep 12 20:53:33 volumio volumio[1092]: info: Setting Geolocation for MyVolumio to eu6 Sep 12 20:53:33 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 12 20:53:33 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 12 20:53:33 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 12 20:53:34 volumio systemd[1]: systemd-timedated.service: Succeeded. Sep 12 20:53:34 volumio volumio[1092]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 12 Sep 12 20:53:34 volumio volumio[1092]: info: CALLMETHOD: user_interface now_playing getPluginInfo undefined Sep 12 20:53:34 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: now_playing , getPluginInfo Sep 12 20:53:34 volumio volumio[1092]: info: Listing playlists Sep 12 20:53:34 volumio volumio[1092]: info: CoreCommandRouter::volumioGetQueue Sep 12 20:53:34 volumio volumio[1092]: info: CoreStateMachine::getQueue Sep 12 20:53:34 volumio volumio[1092]: info: CorePlayQueue::getQueue Sep 12 20:53:34 volumio volumio[1092]: info: CoreCommandRouter::volumioGetVisibleSources Sep 12 20:53:34 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 12 20:53:34 volumio volumio[1092]: info: CoreCommandRouter::volumioGetState Sep 12 20:53:34 volumio volumio[1092]: info: CorePlayQueue::getTrack 0 Sep 12 20:53:34 volumio volumio[1092]: info: CALLMETHOD: user_interface now_playing getPluginInfo undefined Sep 12 20:53:34 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: now_playing , getPluginInfo Sep 12 20:53:34 volumio volumio[1092]: info: Listing playlists Sep 12 20:53:34 volumio volumio[1092]: info: CoreCommandRouter::volumioGetQueue Sep 12 20:53:34 volumio volumio[1092]: info: CoreStateMachine::getQueue Sep 12 20:53:34 volumio volumio[1092]: info: CorePlayQueue::getQueue Sep 12 20:53:34 volumio volumio[1092]: info: CoreCommandRouter::volumioGetVisibleSources Sep 12 20:53:34 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 12 20:53:34 volumio volumio[1092]: info: CoreCommandRouter::volumioGetState Sep 12 20:53:34 volumio volumio[1092]: info: CorePlayQueue::getTrack 0 Sep 12 20:53:34 volumio volumio[1092]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Sep 12 20:53:34 volumio volumio[1092]: info: Updating MyVolumio device info Sep 12 20:53:34 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 12 20:53:34 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 12 20:53:34 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 12 20:53:35 volumio volumio[1092]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Sep 12 20:53:35 volumio volumio[1092]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 13 Sep 12 20:53:35 volumio volumio[1092]: info: CALLMETHOD: user_interface now_playing getPluginInfo undefined Sep 12 20:53:35 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: now_playing , getPluginInfo Sep 12 20:53:35 volumio volumio[1092]: info: Listing playlists Sep 12 20:53:35 volumio volumio[1092]: info: CoreCommandRouter::volumioGetQueue Sep 12 20:53:35 volumio volumio[1092]: info: CoreStateMachine::getQueue Sep 12 20:53:35 volumio volumio[1092]: info: CorePlayQueue::getQueue Sep 12 20:53:35 volumio volumio[1092]: info: CoreCommandRouter::volumioGetVisibleSources Sep 12 20:53:35 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 12 20:53:35 volumio volumio[1092]: info: CoreCommandRouter::volumioGetState Sep 12 20:53:35 volumio volumio[1092]: info: CorePlayQueue::getTrack 0 Sep 12 20:53:35 volumio volumio[1092]: info: CALLMETHOD: user_interface now_playing getPluginInfo undefined Sep 12 20:53:35 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: now_playing , getPluginInfo Sep 12 20:53:35 volumio volumio[1092]: info: Listing playlists Sep 12 20:53:35 volumio volumio[1092]: info: CoreCommandRouter::volumioGetQueue Sep 12 20:53:35 volumio volumio[1092]: info: CoreStateMachine::getQueue Sep 12 20:53:35 volumio volumio[1092]: info: CorePlayQueue::getQueue Sep 12 20:53:35 volumio volumio[1092]: info: CoreCommandRouter::volumioGetVisibleSources Sep 12 20:53:35 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 12 20:53:35 volumio volumio[1092]: info: CoreCommandRouter::volumioGetState Sep 12 20:53:35 volumio volumio[1092]: info: CorePlayQueue::getTrack 0 Sep 12 20:53:36 volumio volumio[1092]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 14 Sep 12 20:53:36 volumio volumio[1092]: info: CALLMETHOD: user_interface now_playing getPluginInfo undefined Sep 12 20:53:36 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: now_playing , getPluginInfo Sep 12 20:53:36 volumio volumio[1092]: info: Listing playlists Sep 12 20:53:36 volumio volumio[1092]: info: CoreCommandRouter::volumioGetQueue Sep 12 20:53:36 volumio volumio[1092]: info: CoreStateMachine::getQueue Sep 12 20:53:36 volumio volumio[1092]: info: CorePlayQueue::getQueue Sep 12 20:53:36 volumio volumio[1092]: info: CoreCommandRouter::volumioGetVisibleSources Sep 12 20:53:36 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 12 20:53:36 volumio volumio[1092]: info: CoreCommandRouter::volumioGetState Sep 12 20:53:36 volumio volumio[1092]: info: CorePlayQueue::getTrack 0 Sep 12 20:53:36 volumio volumio[1092]: info: CALLMETHOD: user_interface now_playing getPluginInfo undefined Sep 12 20:53:36 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: now_playing , getPluginInfo Sep 12 20:53:36 volumio volumio[1092]: info: Listing playlists Sep 12 20:53:36 volumio volumio[1092]: info: CoreCommandRouter::volumioGetQueue Sep 12 20:53:36 volumio volumio[1092]: info: CoreStateMachine::getQueue Sep 12 20:53:36 volumio volumio[1092]: info: CorePlayQueue::getQueue Sep 12 20:53:36 volumio volumio[1092]: info: CoreCommandRouter::volumioGetVisibleSources Sep 12 20:53:36 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 12 20:53:36 volumio volumio[1092]: info: CoreCommandRouter::volumioGetState Sep 12 20:53:36 volumio volumio[1092]: info: CorePlayQueue::getTrack 0 Sep 12 20:53:36 volumio sudo[2371]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=nextcloud-smb,password=Kr1njBog1234,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.82/smb-folder/Music /mnt/NAS/Треки Sep 12 20:53:36 volumio sudo[2371]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 12 20:53:36 volumio kernel: CIFS: Attempting to mount //192.168.1.82/smb-folder/Music Sep 12 20:53:38 volumio volumio[1092]: info: MYVOLUMIO: Adding device Sep 12 20:53:38 volumio volumio[1092]: info: MYVOLUMIO: Evaluating Server Sep 12 20:53:39 volumio volumio[1092]: info: Setting Geolocation for MyVolumio to eu6 Sep 12 20:53:39 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 12 20:53:39 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 12 20:53:39 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 12 20:53:39 volumio volumio[1092]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Sep 12 20:53:40 volumio volumio[1092]: info: Updating MyVolumio device info Sep 12 20:53:40 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 12 20:53:40 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 12 20:53:40 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 12 20:53:40 volumio volumio[1092]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Sep 12 20:53:42 volumio volumio[1092]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 12 20:53:42 volumio volumio[1092]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 12 20:53:42 volumio volumio[1092]: info: Retrieving Cloud Streaming UI Sep 12 20:53:42 volumio volumio[1092]: info: Getting Tidal Cloud Configuration Sep 12 20:53:42 volumio volumio[1092]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 12 20:53:42 volumio volumio[1092]: info: Getting Qobuz Cloud Configuration Sep 12 20:53:42 volumio volumio[1092]: info: Asking plugin for UI Config Sep 12 20:53:42 volumio volumio[1092]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 12 20:53:42 volumio volumio[1092]: info: Getting Spotify Cloud Configuration Sep 12 20:53:42 volumio volumio[1092]: info: Asking plugin for UI Config Sep 12 20:53:42 volumio volumio[1092]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 12 20:53:42 volumio volumio[1092]: info: Saving Spotify Acccount Sep 12 20:53:42 volumio volumio[1092]: info: Got Tidal Cloud Configuration Sep 12 20:53:42 volumio volumio[1092]: info: Got it Sep 12 20:53:42 volumio volumio[1092]: info: Got it Sep 12 20:53:42 volumio volumio[1092]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Sep 12 20:53:42 volumio volumio[1092]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 12 20:53:42 volumio volumio[1092]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Sep 12 20:53:42 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Sep 12 20:53:42 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Sep 12 20:53:42 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Sep 12 20:53:42 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Sep 12 20:53:42 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 12 20:53:42 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 12 20:53:42 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 12 20:53:42 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 12 20:53:42 volumio volumio[1092]: info: CoreCommandRouter::volumioGetBrowseSources Sep 12 20:53:42 volumio volumio[1092]: info: CoreCommandRouter::volumioGetBrowseSources Sep 12 20:53:42 volumio volumio[1092]: info: CoreCommandRouter::volumioGetBrowseSources Sep 12 20:53:42 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 12 20:53:42 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Sep 12 20:53:45 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Sep 12 20:53:45 volumio volumio[1092]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 12 Sep 12 20:53:45 volumio volumio[1092]: info: CoreCommandRouter::volumioGetState Sep 12 20:53:45 volumio volumio[1092]: info: CorePlayQueue::getTrack 0 Sep 12 20:53:46 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 12 20:53:47 volumio sudo[2371]: pam_unix(sudo:session): session closed for user root Sep 12 20:53:47 volumio volumio[1092]: info: Cannot mount NAS Треки at system boot, trial number 3 ,retrying in 5 seconds Sep 12 20:53:47 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Sep 12 20:53:47 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -115 Sep 12 20:53:47 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 12 20:53:47 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 12 20:53:47 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Sep 12 20:53:47 volumio volumio-remote-updater[637]: No test mode Sep 12 20:53:47 volumio volumio-remote-updater[637]: No alpha test mode Sep 12 20:53:47 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Sep 12 20:53:47 volumio volumio[1092]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Sep 12 20:53:47 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Sep 12 20:53:47 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: networkfs , deleteShare Sep 12 20:53:48 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Sep 12 20:53:49 volumio ntpd[857]: Soliciting pool server 51.250.53.172 Sep 12 20:53:49 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Sep 12 20:53:49 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Sep 12 20:53:50 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 12 20:53:50 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Sep 12 20:53:50 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Sep 12 20:53:50 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Sep 12 20:53:50 volumio volumio[1092]: info: CoreCommandRouter::volumioGetBrowseSources Sep 12 20:53:50 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 12 20:53:50 volumio ntpd[857]: Soliciting pool server 94.141.164.123 Sep 12 20:53:50 volumio ntpd[857]: Soliciting pool server 87.103.245.205 Sep 12 20:53:50 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 12 20:53:50 volumio volumio[1092]: error: MyVolumio Plugin failed to authenticate in a timely fashion Sep 12 20:53:50 volumio volumio[1092]: info: Completed starting MyVolumio Plugin Sep 12 20:53:50 volumio volumio[1092]: [Metrics] CommandRouter: 46s 668.22ms Sep 12 20:53:50 volumio volumio[1092]: info: CoreCommandRouter::volumiosetStartupVolume Sep 12 20:53:50 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 12 20:53:50 volumio volumio[1092]: info: VolumeController:: Setting startup Volume 100 Sep 12 20:53:50 volumio volumio[1092]: info: VolumeController::SetAlsaVolume100 Sep 12 20:53:51 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 12 20:53:51 volumio volumio[1092]: info: CoreCommandRouter::Close All Modals sent Sep 12 20:53:51 volumio volumio[1092]: info: CoreCommandRouter::Close All Modals sent Sep 12 20:53:51 volumio volumio[1092]: info: CoreStateMachine::pushState Sep 12 20:53:51 volumio volumio[1092]: info: CorePlayQueue::getTrack 0 Sep 12 20:53:51 volumio volumio[1092]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 12 20:53:51 volumio volumio[1092]: info: CoreCommandRouter::volumioPushState Sep 12 20:53:51 volumio volumio[1092]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Sep 12 20:53:51 volumio volumio[1092]: info: FusionDsp - ---- read samplerate from file: 44100 Sep 12 20:53:51 volumio volumio[1092]: info: camilladsp stopping service pid 1594... Sep 12 20:53:51 volumio volumio[1092]: info: camilladsp service terminated, instance 1 Sep 12 20:53:51 volumio volumio[1092]: info: FusionDsp - If filter freq >samplerate/2 then disable it Sep 12 20:53:51 volumio volumio[1092]: info: camilladsp service started and running in background, instance 1 Sep 12 20:53:51 volumio volumio[1092]: info: camilladsp spawned new process with pid 2491, instance 1, run: true Sep 12 20:53:51 volumio ntpd[857]: Soliciting pool server 83.243.68.157 Sep 12 20:53:51 volumio ntpd[857]: Soliciting pool server 95.31.7.160 Sep 12 20:53:52 volumio volumio[1092]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 12 20:53:52 volumio volumio[1092]: TypeError: Cannot read property 'replace' of undefined Sep 12 20:53:52 volumio volumio[1092]: at ControllerNetworkfs.mountShare (/volumio/app/plugins/system_controller/networkfs/index.js:202:28) Sep 12 20:53:52 volumio volumio[1092]: at Timeout._onTimeout (/volumio/app/plugins/system_controller/networkfs/index.js:255:20) Sep 12 20:53:52 volumio volumio[1092]: at listOnTimeout (internal/timers.js:554:17) Sep 12 20:53:52 volumio volumio[1092]: at processTimers (internal/timers.js:497:7) Sep 12 20:53:52 volumio volumio[1092]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 12 20:53:52 volumio ntpd[857]: Soliciting pool server 109.111.178.39 Sep 12 20:53:52 volumio sudo[2510]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-09-12 20:52 Sep 12 20:53:52 volumio sudo[2510]: 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="29866754e5f1d7e4d0f581c10d9f22852f6f21db" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 10:25:36 AM CEST" VOLUMIO_VERSION="3.832" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="cf6e14681b2ecbbdc9a62186b0f3114c"