-- Logs begin at Sat 2024-04-27 14:12:01 CEST, end at Sat 2024-04-27 17:03:47 CEST. -- Apr 27 17:02:03 volumio-neo volumio[845]: verbose: New Socket.io Connection to 192.168.1.158 from 192.168.1.174 UA: okhttp/4.9.2 Total Clients: 9 Apr 27 17:02:03 volumio-neo volumio[845]: info: CoreCommandRouter::volumioGetState Apr 27 17:02:03 volumio-neo volumio[845]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 27 17:02:03 volumio-neo volumio[845]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 27 17:02:12 volumio-neo volumio[845]: info: Discovery: A device disappeared from network Apr 27 17:02:12 volumio-neo volumio[845]: info: Discovery: Device volumio-rpi disappeared from network Apr 27 17:02:12 volumio-neo volumio[845]: info: Discovery: Disconnected from remote: 192.168.1.136 Apr 27 17:02:12 volumio-neo volumio[845]: info: MRS: Cleaning up device: bb277caf-cb0c-41a5-9ea3-ee3d67494508 Apr 27 17:02:12 volumio-neo volumio[845]: info: Removing audio output: Apr 27 17:02:17 volumio-neo volumio[845]: info: Discovery: adding bb277caf-cb0c-41a5-9ea3-ee3d67494508 Apr 27 17:02:17 volumio-neo volumio[845]: info: Discovery: Found device Volumio-Marcin Apr 27 17:02:17 volumio-neo volumio[845]: info: Discovery: Connecting to remote: 192.168.1.136 Apr 27 17:02:17 volumio-neo volumio[845]: info: MRS: Pushing audio output on request Apr 27 17:02:17 volumio-neo volumio[845]: info: MRS: Pushing multiroomSync output Apr 27 17:02:17 volumio-neo volumio[845]: info: Discovery: Connected to remote: 192.168.1.136 Apr 27 17:02:30 volumio-neo volumio[845]: info: MRS: Adding multiroomSync output Apr 27 17:02:30 volumio-neo volumio[845]: info: Adding audio output: Apr 27 17:02:30 volumio-neo volumio[845]: info: MRS: Pushing multiroomSync output Apr 27 17:02:39 volumio-neo volumio[845]: error: error Apr 27 17:02:44 volumio-neo volumio[845]: info: Discovery: Disconnected from remote: 192.168.1.136 Apr 27 17:02:44 volumio-neo volumio[845]: info: MRS: Cleaning up device: bb277caf-cb0c-41a5-9ea3-ee3d67494508 Apr 27 17:02:44 volumio-neo volumio[845]: info: Removing audio output: Apr 27 17:02:45 volumio-neo volumio[845]: info: Discovery: A device disappeared from network Apr 27 17:02:50 volumio-neo volumio[845]: info: Discovery: Remote connection error: 192.168.1.136 Apr 27 17:02:50 volumio-neo volumio[845]: info: Discovery: Remote connection timeout: 192.168.1.136 Apr 27 17:02:52 volumio-neo volumio[845]: verbose: New Socket.io Connection to 9zwbjldudarly4jss9gkagncbkb2-67af4f7f69435cf201f001455640f919.eu4.myvolumio.org from 127.0.0.1 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/124.0.0.0 Safari/537.36 Total Clients: 9 Apr 27 17:02:53 volumio-neo volumio[845]: info: CoreCommandRouter::volumioGetState Apr 27 17:02:53 volumio-neo volumio[845]: info: Received Get System Info Apr 27 17:02:53 volumio-neo volumio[845]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 27 17:02:53 volumio-neo volumio[845]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 27 17:02:53 volumio-neo volumio[845]: info: Discovery: Getting this device information Apr 27 17:02:53 volumio-neo volumio[845]: info: CoreCommandRouter::volumioGetState Apr 27 17:02:53 volumio-neo volumio[845]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 27 17:02:53 volumio-neo volumio[845]: info: CoreCommandRouter::volumioGetState Apr 27 17:02:53 volumio-neo volumio[845]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Apr 27 17:02:53 volumio-neo volumio[845]: info: CoreCommandRouter::volumioGetVisibleSources Apr 27 17:02:53 volumio-neo volumio[845]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 27 17:02:53 volumio-neo volumio[845]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 27 17:02:53 volumio-neo volumio[845]: info: CoreCommandRouter::volumioGetState Apr 27 17:02:53 volumio-neo volumio[845]: info: CoreCommandRouter::volumioGetState Apr 27 17:02:53 volumio-neo volumio[845]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 27 17:02:53 volumio-neo volumio[845]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 27 17:02:53 volumio-neo volumio[845]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Apr 27 17:02:53 volumio-neo volumio[845]: info: Received Get System Info Apr 27 17:02:53 volumio-neo volumio[845]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 27 17:02:53 volumio-neo volumio[845]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 27 17:02:53 volumio-neo volumio[845]: info: Discovery: Getting this device information Apr 27 17:02:53 volumio-neo volumio[845]: info: CoreCommandRouter::volumioGetState Apr 27 17:02:53 volumio-neo volumio[845]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 27 17:02:53 volumio-neo volumio[845]: info: CoreCommandRouter::volumioGetState Apr 27 17:02:53 volumio-neo volumio[845]: info: Listing playlists Apr 27 17:02:53 volumio-neo volumio[845]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Apr 27 17:02:53 volumio-neo volumio[845]: info: CoreCommandRouter::volumioGetQueue Apr 27 17:02:53 volumio-neo volumio[845]: info: CoreStateMachine::getQueue Apr 27 17:02:53 volumio-neo volumio[845]: info: CorePlayQueue::getQueue Apr 27 17:02:55 volumio-neo volumio[845]: info: Executing endpoint metavolumio Apr 27 17:02:55 volumio-neo volumio[845]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Apr 27 17:02:55 volumio-neo volumio[845]: info: Executing endpoint metavolumio Apr 27 17:02:55 volumio-neo volumio[845]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Apr 27 17:02:55 volumio-neo volumio[845]: info: Executing endpoint metavolumio Apr 27 17:02:55 volumio-neo volumio[845]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Apr 27 17:02:58 volumio-neo volumio[845]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 27 17:02:58 volumio-neo volumio[845]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Apr 27 17:02:58 volumio-neo volumio[845]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Apr 27 17:02:58 volumio-neo volumio[845]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Apr 27 17:02:58 volumio-neo volumio[845]: info: Received Get System Version Apr 27 17:02:58 volumio-neo volumio[845]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 27 17:02:58 volumio-neo volumio[845]: info: Discovery: Remote connection error: 192.168.1.136 Apr 27 17:02:58 volumio-neo volumio[845]: info: Discovery: Remote connection timeout: 192.168.1.136 Apr 27 17:03:05 volumio-neo volumio[845]: info: CALLMETHOD: system_controller system saveGeneralSettings [object Object] Apr 27 17:03:05 volumio-neo volumio[845]: info: CoreCommandRouter::executeOnPlugin: system , saveGeneralSettings Apr 27 17:03:05 volumio-neo volumio[845]: info: System name has changed, restarting Shairport Sync Apr 27 17:03:05 volumio-neo volumio[845]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 17:03:05 volumio-neo volumio[845]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 27 17:03:05 volumio-neo volumio[845]: xcb_connection_has_error() returned true Apr 27 17:03:05 volumio-neo volumio[845]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 27 17:03:05 volumio-neo volumio[845]: xcb_connection_has_error() returned true Apr 27 17:03:05 volumio-neo volumio[845]: info: Updating MyVolumio device info Apr 27 17:03:05 volumio-neo volumio[845]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 27 17:03:05 volumio-neo volumio[845]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 27 17:03:05 volumio-neo volumio[845]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 27 17:03:05 volumio-neo vtcs[1391]: [2024-04-27 17:03:05.461] [tisoc] [warning] [SessionManagerImpl.cpp:243] Illegal State: IDLE Apr 27 17:03:05 volumio-neo vtcs[1391]: [2024-04-27 17:03:05.470] [tisoc] [error] [SpkconServer.cpp:382] recv error. client fd=8 errorno=104 error=Connection reset by peer Apr 27 17:03:05 volumio-neo vtcs[1391]: [2024-04-27 17:03:05.470] [tisoc] [error] [SpkconServer.cpp:377] recv error. socket disconnected Apr 27 17:03:05 volumio-neo sudo[8751]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Apr 27 17:03:05 volumio-neo sudo[8751]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 17:03:05 volumio-neo volumio[845]: info: Discovery: Restarting Advertising due to device name change Apr 27 17:03:05 volumio-neo sudo[8754]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall upmpdcli Apr 27 17:03:05 volumio-neo sudo[8754]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 17:03:05 volumio-neo systemd[1]: Stopping Volumio Tidal Connect Service... Apr 27 17:03:05 volumio-neo systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Apr 27 17:03:05 volumio-neo systemd[1]: vtcs.service: Succeeded. Apr 27 17:03:05 volumio-neo systemd[1]: Stopped Volumio Tidal Connect Service. Apr 27 17:03:05 volumio-neo sudo[8757]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/hciconfig hci0 name Volumio-Salon Apr 27 17:03:05 volumio-neo sudo[8751]: pam_unix(sudo:session): session closed for user root Apr 27 17:03:05 volumio-neo sudo[8754]: pam_unix(sudo:session): session closed for user root Apr 27 17:03:05 volumio-neo sudo[8757]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 17:03:05 volumio-neo sudo[8757]: pam_unix(sudo:session): session closed for user root Apr 27 17:03:05 volumio-neo sudo[8761]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Apr 27 17:03:05 volumio-neo sudo[8761]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 17:03:05 volumio-neo volumio[845]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 27 17:03:05 volumio-neo volumio[845]: error: Upnp client error: Error: This socket has been ended by the other party Apr 27 17:03:05 volumio-neo volumio[845]: error: Cannot set new Bluetooth Name : Error: Command failed: /usr/bin/sudo /bin/hciconfig hci0 name 'Volumio-Salon' Apr 27 17:03:05 volumio-neo volumio[845]: Can't get device info: No such device Apr 27 17:03:05 volumio-neo sudo[8761]: pam_unix(sudo:session): session closed for user root Apr 27 17:03:05 volumio-neo volumio[845]: info: Starting Shairport Sync Apr 27 17:03:05 volumio-neo sudo[8766]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/hosts Apr 27 17:03:05 volumio-neo sudo[8766]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 17:03:05 volumio-neo sudo[8766]: pam_unix(sudo:session): session closed for user root Apr 27 17:03:05 volumio-neo volumio[845]: info: MRS: Adding multiroomSync output Apr 27 17:03:05 volumio-neo volumio[845]: info: Adding audio output: Apr 27 17:03:05 volumio-neo volumio[845]: info: MRS: Pushing multiroomSync output Apr 27 17:03:05 volumio-neo volumio[845]: info: Permissions for /etc/hosts set Apr 27 17:03:05 volumio-neo sudo[8769]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 27 17:03:05 volumio-neo sudo[8769]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 17:03:06 volumio-neo systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 27 17:03:06 volumio-neo volumio[845]: info: Hostname now is volumio-salon Apr 27 17:03:06 volumio-neo systemd[1]: shairport-sync.service: Succeeded. Apr 27 17:03:06 volumio-neo systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 27 17:03:06 volumio-neo systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 27 17:03:06 volumio-neo sudo[8769]: pam_unix(sudo:session): session closed for user root Apr 27 17:03:06 volumio-neo sudo[8772]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/hostname volumio-salon Apr 27 17:03:06 volumio-neo sudo[8772]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 17:03:06 volumio-salon sudo[8772]: pam_unix(sudo:session): session closed for user root Apr 27 17:03:06 volumio-salon volumio[845]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 27 17:03:06 volumio-salon volumio[845]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Apr 27 17:03:06 volumio-salon sudo[8775]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /etc/avahi/services/ Apr 27 17:03:06 volumio-salon sudo[8775]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 17:03:06 volumio-salon sudo[8775]: pam_unix(sudo:session): session closed for user root Apr 27 17:03:06 volumio-salon volumio[845]: info: Permissions for /etc/avahi/services/volumio.service Apr 27 17:03:06 volumio-salon volumio[845]: info: New hostname set Apr 27 17:03:06 volumio-salon volumio[845]: info: Shairport-Sync Started Apr 27 17:03:06 volumio-salon avahi-daemon[598]: Files changed, reloading. Apr 27 17:03:06 volumio-salon avahi-daemon[598]: Service group file /services/volumio.service changed, reloading. Apr 27 17:03:06 volumio-salon volumio[845]: info: Avahi name changed to volumio-salon Apr 27 17:03:06 volumio-salon volumio[845]: error: Failed to update MyVolumio device: {"message":"Unauthenticated"} Apr 27 17:03:06 volumio-salon volumio[845]: info: Discovery: A device disappeared from network Apr 27 17:03:06 volumio-salon volumio[845]: info: Discovery: Device volumio-neo disappeared from network Apr 27 17:03:07 volumio-salon avahi-daemon[598]: Service "Volumio-Salon" (/services/volumio.service) successfully established. Apr 27 17:03:08 volumio-salon volumio[845]: info: TidalConnect service stoped! Apr 27 17:03:08 volumio-salon volumio[845]: info: Discovery: Remote connection error: 192.168.1.136 Apr 27 17:03:08 volumio-salon volumio[845]: info: Discovery: Remote connection timeout: 192.168.1.136 Apr 27 17:03:08 volumio-salon volumio[845]: info: TidalConnect service stoped! Apr 27 17:03:08 volumio-salon volumio[845]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Apr 27 17:03:08 volumio-salon volumio[845]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Apr 27 17:03:09 volumio-salon sudo[8790]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Apr 27 17:03:09 volumio-salon sudo[8790]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 17:03:09 volumio-salon systemd[1]: Started Volumio Tidal Connect Service. Apr 27 17:03:09 volumio-salon sudo[8790]: pam_unix(sudo:session): session closed for user root Apr 27 17:03:09 volumio-salon volumio[845]: info: Executing endpoint tc_getconfig Apr 27 17:03:09 volumio-salon volumio[845]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Apr 27 17:03:09 volumio-salon vtcs[8792]: STARTING TidalConnect services, version: 1.3.0.19 Apr 27 17:03:10 volumio-salon vtcs[8792]: STARTED TidalConnect services. Apr 27 17:03:10 volumio-salon volumio[845]: info: Executing endpoint tc_connect Apr 27 17:03:10 volumio-salon volumio[845]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Apr 27 17:03:10 volumio-salon volumio[845]: info: Connecting to TidalConnect Apr 27 17:03:10 volumio-salon volumio[845]: info: CoreCommandRouter::servicePushState Apr 27 17:03:10 volumio-salon volumio[845]: info: CoreStateMachine::pushState Apr 27 17:03:10 volumio-salon volumio[845]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 27 17:03:10 volumio-salon volumio[845]: info: CoreCommandRouter::volumioPushState Apr 27 17:03:10 volumio-salon volumio[845]: info: MRS: Pushing multiroomSync output update for this device Apr 27 17:03:10 volumio-salon volumio[845]: info: MRS: Pushing multiroomSync output Apr 27 17:03:10 volumio-salon volumio[845]: info: CoreCommandRouter::servicePushState Apr 27 17:03:10 volumio-salon volumio[845]: info: CoreStateMachine::pushState Apr 27 17:03:10 volumio-salon volumio[845]: info: CoreCommandRouter::volumioPushState Apr 27 17:03:10 volumio-salon volumio[845]: info: MRS: Pushing multiroomSync output update for this device Apr 27 17:03:10 volumio-salon volumio[845]: info: MRS: Pushing multiroomSync output Apr 27 17:03:10 volumio-salon volumio[845]: SPOTIFY: RECEIVED VOLUMIO VOLUME 74 Apr 27 17:03:10 volumio-salon volumio[845]: SPOTIFY: RECEIVED VOLUMIO VOLUME 74 Apr 27 17:03:10 volumio-salon volumio[845]: info: Discovery: Started advertising with name: Volumio-Salon Apr 27 17:03:11 volumio-salon volumio[845]: info: Discovery: adding c157b618-3cee-487c-962f-495272a3ea50 Apr 27 17:03:11 volumio-salon volumio[845]: info: Discovery: Found device Volumio-Salon Apr 27 17:03:11 volumio-salon volumio[845]: info: CoreCommandRouter::volumioGetState Apr 27 17:03:11 volumio-salon volumio[845]: verbose: New Socket.io Connection to 192.168.1.158:3000 from 192.168.1.125 UA: node-XMLHttpRequest Total Clients: 8 Apr 27 17:03:11 volumio-salon volumio[845]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Apr 27 17:03:11 volumio-salon volumio[845]: info: CoreCommandRouter::volumioGetState Apr 27 17:03:12 volumio-salon volumio[845]: info: TidalConnect service started! Apr 27 17:03:15 volumio-salon sudo[8819]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/samba/smb.conf Apr 27 17:03:15 volumio-salon sudo[8819]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 17:03:15 volumio-salon sudo[8819]: pam_unix(sudo:session): session closed for user root Apr 27 17:03:15 volumio-salon volumio[845]: info: smb.conf Permissions set Apr 27 17:03:15 volumio-salon sudo[8822]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /data/INTERNAL Apr 27 17:03:15 volumio-salon sudo[8822]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 17:03:15 volumio-salon sudo[8822]: pam_unix(sudo:session): session closed for user root Apr 27 17:03:15 volumio-salon volumio[845]: info: Internal perms successfully set Apr 27 17:03:15 volumio-salon sudo[8825]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart nmbd.service Apr 27 17:03:15 volumio-salon sudo[8825]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 17:03:15 volumio-salon nmbd[763]: [2024/04/27 17:03:15.767099, 0] ../source3/nmbd/nmbd.c:58(terminate) Apr 27 17:03:15 volumio-salon systemd[1]: Stopping Samba NMB Daemon... Apr 27 17:03:15 volumio-salon nmbd[763]: Got SIGTERM: going down... Apr 27 17:03:15 volumio-salon systemd[1]: nmbd.service: Succeeded. Apr 27 17:03:15 volumio-salon volumio[845]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 27 17:03:15 volumio-salon systemd[1]: Stopped Samba NMB Daemon. Apr 27 17:03:15 volumio-salon systemd[1]: Starting Samba NMB Daemon... Apr 27 17:03:15 volumio-salon volumio[845]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Apr 27 17:03:15 volumio-salon sudo[8830]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 27 17:03:15 volumio-salon sudo[8830]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 17:03:15 volumio-salon volumio[845]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 27 17:03:15 volumio-salon sudo[8830]: pam_unix(sudo:session): session closed for user root Apr 27 17:03:15 volumio-salon sudo[8833]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 27 17:03:15 volumio-salon sudo[8833]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 17:03:16 volumio-salon sudo[8833]: pam_unix(sudo:session): session closed for user root Apr 27 17:03:16 volumio-salon sudo[8838]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Apr 27 17:03:16 volumio-salon sudo[8838]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 17:03:16 volumio-salon sudo[8838]: pam_unix(sudo:session): session closed for user root Apr 27 17:03:16 volumio-salon volumio[845]: info: Upmpdcli Daemon Started Apr 27 17:03:16 volumio-salon nmbd[8829]: [2024/04/27 17:03:16.328284, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns) Apr 27 17:03:16 volumio-salon nmbd[8829]: started asyncdns process 8840 Apr 27 17:03:16 volumio-salon nmbd[8829]: [2024/04/27 17:03:16.337504, 0] ../lib/util/become_daemon.c:138(daemon_ready) Apr 27 17:03:16 volumio-salon nmbd[8829]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Apr 27 17:03:16 volumio-salon systemd[1]: Started Samba NMB Daemon. Apr 27 17:03:16 volumio-salon sudo[8825]: pam_unix(sudo:session): session closed for user root Apr 27 17:03:16 volumio-salon nmbd[8829]: [2024/04/27 17:03:16.354952, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Apr 27 17:03:16 volumio-salon nmbd[8829]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.1.158 for name WORKGROUP<1d>. Apr 27 17:03:16 volumio-salon nmbd[8829]: This response was from IP 192.168.1.149, reporting an IP address of 192.168.1.149. Apr 27 17:03:16 volumio-salon sudo[8842]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart smbd.service Apr 27 17:03:16 volumio-salon sudo[8842]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 17:03:16 volumio-salon systemd[1]: Stopping Samba SMB Daemon... Apr 27 17:03:16 volumio-salon volumio[845]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 27 17:03:16 volumio-salon systemd[1]: smbd.service: Main process exited, code=killed, status=15/TERM Apr 27 17:03:16 volumio-salon systemd[1]: smbd.service: Succeeded. Apr 27 17:03:16 volumio-salon systemd[1]: Stopped Samba SMB Daemon. Apr 27 17:03:16 volumio-salon volumio[845]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Apr 27 17:03:16 volumio-salon systemd[1]: Starting Samba SMB Daemon... Apr 27 17:03:16 volumio-salon volumio[845]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 27 17:03:17 volumio-salon winbindd[946]: [2024/04/27 17:03:17.601388, 0] ../source3/winbindd/winbindd_samr.c:672(sam_sid_to_name) Apr 27 17:03:17 volumio-salon winbindd[946]: sam_sid_to_name: possible deadlock - trying to lookup SID S-1-5-21-1808397631-1706459442-547783233-501 Apr 27 17:03:17 volumio-salon winbindd[946]: [2024/04/27 17:03:17.603021, 0] ../source3/winbindd/winbindd_samr.c:672(sam_sid_to_name) Apr 27 17:03:17 volumio-salon winbindd[946]: sam_sid_to_name: possible deadlock - trying to lookup SID S-1-5-21-1808397631-1706459442-547783233-514 Apr 27 17:03:17 volumio-salon smbd[8853]: [2024/04/27 17:03:17.650536, 0] ../lib/util/become_daemon.c:138(daemon_ready) Apr 27 17:03:17 volumio-salon smbd[8853]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Apr 27 17:03:17 volumio-salon systemd[1]: Started Samba SMB Daemon. Apr 27 17:03:17 volumio-salon sudo[8842]: pam_unix(sudo:session): session closed for user root Apr 27 17:03:17 volumio-salon volumio[845]: info: SAMBA Restarted Apr 27 17:03:18 volumio-salon volumio[845]: info: Discovery: Remote connection error: 192.168.1.136 Apr 27 17:03:18 volumio-salon volumio[845]: info: Discovery: Remote connection timeout: 192.168.1.136 Apr 27 17:03:23 volumio-salon volumio[845]: info: MRS: Pushing audio output on request Apr 27 17:03:23 volumio-salon volumio[845]: info: MRS: Pushing multiroomSync output Apr 27 17:03:28 volumio-salon volumio[845]: verbose: New Socket.io Connection to 192.168.1.158 from 192.168.1.174 UA: okhttp/4.9.2 Total Clients: 7 Apr 27 17:03:28 volumio-salon volumio[845]: info: CoreCommandRouter::volumioGetState Apr 27 17:03:28 volumio-salon volumio[845]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 27 17:03:28 volumio-salon volumio[845]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 27 17:03:28 volumio-salon volumio[845]: info: Discovery: Remote connection error: 192.168.1.136 Apr 27 17:03:28 volumio-salon volumio[845]: info: Discovery: Remote connection timeout: 192.168.1.136 Apr 27 17:03:29 volumio-salon volumio[845]: error: error Apr 27 17:03:30 volumio-salon volumio[845]: verbose: New Socket.io Connection to 192.168.1.158:3000 from 192.168.1.147 UA: node-XMLHttpRequest Total Clients: 8 Apr 27 17:03:33 volumio-salon volumio[845]: verbose: New Socket.io Connection to 9zwbjldudarly4jss9gkagncbkb2-67af4f7f69435cf201f001455640f919.eu4.myvolumio.org from 127.0.0.1 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/124.0.0.0 Safari/537.36 Total Clients: 9 Apr 27 17:03:33 volumio-salon volumio[845]: info: Received Get System Info Apr 27 17:03:33 volumio-salon volumio[845]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 27 17:03:33 volumio-salon volumio[845]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 27 17:03:33 volumio-salon volumio[845]: info: Discovery: Getting this device information Apr 27 17:03:33 volumio-salon volumio[845]: info: CoreCommandRouter::volumioGetState Apr 27 17:03:33 volumio-salon volumio[845]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 27 17:03:33 volumio-salon volumio[845]: info: CoreCommandRouter::volumioGetState Apr 27 17:03:33 volumio-salon volumio[845]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Apr 27 17:03:33 volumio-salon volumio[845]: info: CoreCommandRouter::volumioGetVisibleSources Apr 27 17:03:33 volumio-salon volumio[845]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 27 17:03:33 volumio-salon volumio[845]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 27 17:03:33 volumio-salon volumio[845]: info: CoreCommandRouter::volumioGetState Apr 27 17:03:33 volumio-salon volumio[845]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 27 17:03:33 volumio-salon volumio[845]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 27 17:03:33 volumio-salon volumio[845]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Apr 27 17:03:33 volumio-salon volumio[845]: info: Received Get System Info Apr 27 17:03:33 volumio-salon volumio[845]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 27 17:03:33 volumio-salon volumio[845]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 27 17:03:33 volumio-salon volumio[845]: info: Discovery: Getting this device information Apr 27 17:03:33 volumio-salon volumio[845]: info: CoreCommandRouter::volumioGetState Apr 27 17:03:33 volumio-salon volumio[845]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 27 17:03:33 volumio-salon volumio[845]: info: CoreCommandRouter::volumioGetState Apr 27 17:03:33 volumio-salon volumio[845]: info: Listing playlists Apr 27 17:03:33 volumio-salon volumio[845]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Apr 27 17:03:33 volumio-salon volumio[845]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 27 17:03:33 volumio-salon volumio[845]: info: Received Get System Info Apr 27 17:03:33 volumio-salon volumio[845]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 27 17:03:33 volumio-salon volumio[845]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 27 17:03:33 volumio-salon volumio[845]: info: Discovery: Getting this device information Apr 27 17:03:33 volumio-salon volumio[845]: info: CoreCommandRouter::volumioGetState Apr 27 17:03:33 volumio-salon volumio[845]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 27 17:03:33 volumio-salon volumio[845]: info: CoreCommandRouter::volumioGetState Apr 27 17:03:33 volumio-salon volumio[845]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 27 17:03:33 volumio-salon volumio[845]: info: Received Get System Info Apr 27 17:03:33 volumio-salon volumio[845]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 27 17:03:33 volumio-salon volumio[845]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 27 17:03:33 volumio-salon volumio[845]: info: Discovery: Getting this device information Apr 27 17:03:33 volumio-salon volumio[845]: info: CoreCommandRouter::volumioGetState Apr 27 17:03:33 volumio-salon volumio[845]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 27 17:03:35 volumio-salon volumio[845]: info: Executing endpoint metavolumio Apr 27 17:03:35 volumio-salon volumio[845]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Apr 27 17:03:35 volumio-salon volumio[845]: info: Executing endpoint metavolumio Apr 27 17:03:35 volumio-salon volumio[845]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Apr 27 17:03:35 volumio-salon volumio[845]: info: Executing endpoint metavolumio Apr 27 17:03:35 volumio-salon volumio[845]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Apr 27 17:03:36 volumio-salon volumio[845]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 27 17:03:36 volumio-salon volumio[845]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Apr 27 17:03:36 volumio-salon volumio[845]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Apr 27 17:03:36 volumio-salon volumio[845]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Apr 27 17:03:36 volumio-salon volumio[845]: info: Discovery: Remote connection error: 192.168.1.136 Apr 27 17:03:37 volumio-salon volumio[845]: info: Received Get System Version Apr 27 17:03:37 volumio-salon volumio[845]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 27 17:03:39 volumio-salon volumio[845]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Apr 27 17:03:39 volumio-salon volumio[845]: error: Failed request for metavolumio API Apr 27 17:03:39 volumio-salon volumio[845]: info: CoreCommandRouter::volumioGetState Apr 27 17:03:40 volumio-salon volumio[845]: info: CoreCommandRouter::volumioGetState Apr 27 17:03:42 volumio-salon volumio[845]: info: Executing endpoint metavolumio Apr 27 17:03:42 volumio-salon volumio[845]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Apr 27 17:03:42 volumio-salon volumio[845]: info: Executing endpoint metavolumio Apr 27 17:03:42 volumio-salon volumio[845]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Apr 27 17:03:42 volumio-salon volumio[845]: info: Executing endpoint metavolumio Apr 27 17:03:42 volumio-salon volumio[845]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Apr 27 17:03:43 volumio-salon volumio[845]: error: Failed request for metavolumio API Apr 27 17:03:44 volumio-salon volumio[845]: info: CoreCommandRouter::volumioGetQueue Apr 27 17:03:44 volumio-salon volumio[845]: info: CoreStateMachine::getQueue Apr 27 17:03:44 volumio-salon volumio[845]: info: CorePlayQueue::getQueue Apr 27 17:03:46 volumio-salon volumio[845]: info: CoreCommandRouter::volumioRemoveQueueItem Apr 27 17:03:46 volumio-salon volumio[845]: info: CoreStateMachine::removeQueueItem Apr 27 17:03:46 volumio-salon volumio[845]: info: CoreStateMachine::stop Apr 27 17:03:46 volumio-salon volumio[845]: info: CoreStateMachine::serviceStop Apr 27 17:03:46 volumio-salon volumio[845]: info: CoreCommandRouter::serviceStop Apr 27 17:03:46 volumio-salon vtcs[8792]: [2024-04-27 17:03:46.569] [tisoc] [warning] [SessionManagerImpl.cpp:243] Illegal State: IDLE Apr 27 17:03:46 volumio-salon volumio[845]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 27 17:03:46 volumio-salon volumio[845]: TypeError: Cannot read property 'then' of undefined Apr 27 17:03:46 volumio-salon volumio[845]: at CoreStateMachine.removeQueueItem (/volumio/app/statemachine.js:1358:7) Apr 27 17:03:46 volumio-salon volumio[845]: at CoreCommandRouter.volumioRemoveQueueItem (/volumio/app/index.js:119:28) Apr 27 17:03:46 volumio-salon volumio[845]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:149:33) Apr 27 17:03:46 volumio-salon volumio[845]: at Socket.emit (events.js:400:28) Apr 27 17:03:46 volumio-salon volumio[845]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Apr 27 17:03:46 volumio-salon volumio[845]: at processTicksAndRejections (internal/process/task_queues.js:77:11) Apr 27 17:03:46 volumio-salon volumio[845]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 27 17:03:47 volumio-salon sudo[8907]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-27 17:02 Apr 27 17:03:47 volumio-salon sudo[8907]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="7f9f1bf001add7a8b19a4516e3c74ef598b2730d" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="512433c3e91cdaed7ecd2808b21adeffc2137d7f" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat 24 Feb 2024 10:24:34 PM CET" VOLUMIO_VERSION="3.629" VOLUMIO_HARDWARE="nanopineo-armbian" VOLUMIO_DEVICENAME="NanoPi Neo" VOLUMIO_HASH="8631557bc21b1e4d7c33a58690a12691"