-- Logs begin at Sat 2024-04-13 18:14:07 CEST, end at Sat 2024-04-13 18:25:58 CEST. -- Apr 13 18:24:05 volumio systemd[1]: systemd-timedated.service: Succeeded. Apr 13 18:24:10 volumio kernel: nvme nvme0: controller is down; will reset: CSTS=0xffffffff, PCI_STATUS=0x10 Apr 13 18:24:10 volumio kernel: nvme nvme0: Does your device have a faulty power saving mode enabled? Apr 13 18:24:10 volumio kernel: nvme nvme0: Try "nvme_core.default_ps_max_latency_us=0 pcie_aspm=off" and report a bug Apr 13 18:24:10 volumio kernel: nvme0n1: I/O Cmd(0x2) @ LBA 1403096, 8 blocks, I/O Error (sct 0x3 / sc 0x71) Apr 13 18:24:10 volumio kernel: I/O error, dev nvme0n1, sector 1403096 op 0x0:(READ) flags 0x80700 phys_seg 1 prio class 2 Apr 13 18:24:10 volumio kernel: nvme 0000:01:00.0: enabling device (0000 -> 0002) Apr 13 18:24:10 volumio sudo[1628]: pam_unix(sudo:session): session closed for user root Apr 13 18:24:10 volumio kernel: nvme nvme0: 4/0/0 default/read/poll queues Apr 13 18:24:10 volumio sudo[1636]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Europe/Rome /etc/localtime Apr 13 18:24:10 volumio sudo[1636]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 18:24:10 volumio sudo[1636]: pam_unix(sudo:session): session closed for user root Apr 13 18:24:10 volumio sudo[1639]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Apr 13 18:24:10 volumio sudo[1639]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 18:24:10 volumio sudo[1639]: pam_unix(sudo:session): session closed for user root Apr 13 18:24:10 volumio sudo[1642]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Europe/Rome Apr 13 18:24:10 volumio sudo[1642]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 18:24:10 volumio dbus-daemon[656]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.46' (uid=0 pid=1643 comm="/usr/bin/timedatectl set-timezone Europe/Rome ") Apr 13 18:24:11 volumio systemd[1]: Starting Time & Date Service... Apr 13 18:24:11 volumio dbus-daemon[656]: [system] Successfully activated service 'org.freedesktop.timedate1' Apr 13 18:24:11 volumio systemd[1]: Started Time & Date Service. Apr 13 18:24:11 volumio sudo[1642]: pam_unix(sudo:session): session closed for user root Apr 13 18:24:11 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Apr 13 18:24:11 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Apr 13 18:24:11 volumio volumio[883]: info: Fetching Streaming Services browse cache Apr 13 18:24:11 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule Apr 13 18:24:11 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 13 18:24:11 volumio sudo[1646]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Apr 13 18:24:11 volumio sudo[1646]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 18:24:11 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: system , saveGeneralSettings Apr 13 18:24:11 volumio volumio[883]: info: System name has changed, restarting Shairport Sync Apr 13 18:24:11 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 18:24:11 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 13 18:24:11 volumio volumio[883]: xcb_connection_has_error() returned true Apr 13 18:24:11 volumio volumio[883]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 13 18:24:11 volumio volumio[883]: xcb_connection_has_error() returned true Apr 13 18:24:11 volumio volumio[883]: info: Updating MyVolumio device info Apr 13 18:24:11 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 13 18:24:11 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 13 18:24:11 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 13 18:24:11 volumio vtcs[1481]: [2024-04-13 18:24:11.122] [tisoc] [warning] [SessionManagerImpl.cpp:243] Illegal State: IDLE Apr 13 18:24:11 volumio vtcs[1481]: [2024-04-13 18:24:11.122] [tisoc] [error] [SpkconServer.cpp:474] socket write error. fd=3 errorno=32 error=Broken pipe Apr 13 18:24:11 volumio vtcs[1481]: [2024-04-13 18:24:11.122] [tisoc] [error] [SpkconServer.cpp:377] recv error. socket disconnected Apr 13 18:24:11 volumio sudo[1653]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Apr 13 18:24:11 volumio volumio[883]: info: Discovery: Restarting Advertising due to device name change Apr 13 18:24:11 volumio sudo[1653]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 18:24:11 volumio sudo[1655]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall upmpdcli Apr 13 18:24:11 volumio sudo[1655]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 18:24:11 volumio systemd[1]: Stopping Volumio Tidal Connect Service... Apr 13 18:24:11 volumio systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Apr 13 18:24:11 volumio systemd[1]: vtcs.service: Succeeded. Apr 13 18:24:11 volumio systemd[1]: Stopped Volumio Tidal Connect Service. Apr 13 18:24:11 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAudioDevices Apr 13 18:24:11 volumio sudo[1655]: pam_unix(sudo:session): session closed for user root Apr 13 18:24:11 volumio sudo[1653]: pam_unix(sudo:session): session closed for user root Apr 13 18:24:11 volumio sudo[1659]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/hciconfig hci0 name volumio Apr 13 18:24:11 volumio sudo[1659]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 18:24:11 volumio sudo[1659]: pam_unix(sudo:session): session closed for user root Apr 13 18:24:11 volumio volumio[883]: xcb_connection_has_error() returned true Apr 13 18:24:11 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Apr 13 18:24:11 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 13 18:24:11 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 13 18:24:11 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 13 18:24:11 volumio volumio[883]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Apr 13 18:24:11 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Apr 13 18:24:11 volumio volumio[883]: info: Received Get System Version Apr 13 18:24:11 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 13 18:24:11 volumio volumio[883]: info: Received Get System Info Apr 13 18:24:11 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 13 18:24:11 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 13 18:24:11 volumio volumio[883]: info: Discovery: Getting this device information Apr 13 18:24:11 volumio volumio[883]: info: CoreCommandRouter::volumioGetState Apr 13 18:24:11 volumio volumio[883]: info: CorePlayQueue::getTrack 0 Apr 13 18:24:11 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 13 18:24:11 volumio sudo[1665]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Apr 13 18:24:11 volumio sudo[1665]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 18:24:11 volumio volumio[883]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 13 18:24:11 volumio sudo[1665]: pam_unix(sudo:session): session closed for user root Apr 13 18:24:11 volumio volumio[883]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 13 18:24:11 volumio volumio[883]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Apr 13 18:24:11 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Apr 13 18:24:11 volumio volumio[883]: error: Upnp client error: Error: This socket has been ended by the other party Apr 13 18:24:11 volumio volumio[883]: info: Bluetooth name changed to volumio Apr 13 18:24:11 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 13 18:24:11 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 13 18:24:11 volumio volumio[883]: info: Discovery: Getting this device information Apr 13 18:24:11 volumio volumio[883]: info: CoreCommandRouter::volumioGetState Apr 13 18:24:11 volumio volumio[883]: info: CorePlayQueue::getTrack 0 Apr 13 18:24:11 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 13 18:24:11 volumio sudo[1670]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/hosts Apr 13 18:24:11 volumio sudo[1670]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 18:24:11 volumio volumio-remote-updater[667]: No test mode Apr 13 18:24:11 volumio volumio-remote-updater[667]: No alpha test mode Apr 13 18:24:11 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Apr 13 18:24:11 volumio sudo[1670]: pam_unix(sudo:session): session closed for user root Apr 13 18:24:11 volumio volumio[883]: info: Permissions for /etc/hosts set Apr 13 18:24:11 volumio volumio[883]: info: Starting Shairport Sync Apr 13 18:24:11 volumio sudo[1674]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/hostname volumio Apr 13 18:24:11 volumio sudo[1674]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 18:24:11 volumio sudo[1674]: pam_unix(sudo:session): session closed for user root Apr 13 18:24:11 volumio volumio[883]: info: Hostname now is volumio Apr 13 18:24:11 volumio sudo[1677]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 13 18:24:11 volumio sudo[1677]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 18:24:11 volumio volumio[883]: info: New hostname set Apr 13 18:24:11 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 13 18:24:11 volumio systemd[1]: shairport-sync.service: Succeeded. Apr 13 18:24:11 volumio volumio[883]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 13 18:24:11 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 13 18:24:11 volumio volumio[883]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Apr 13 18:24:11 volumio sudo[1680]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /etc/avahi/services/ Apr 13 18:24:11 volumio sudo[1680]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 18:24:11 volumio volumio[883]: info: Permissions for /etc/avahi/services/volumio.service Apr 13 18:24:11 volumio volumio[883]: info: Avahi name changed to volumio Apr 13 18:24:11 volumio sudo[1680]: pam_unix(sudo:session): session closed for user root Apr 13 18:24:11 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 13 18:24:11 volumio avahi-daemon[687]: Files changed, reloading. Apr 13 18:24:11 volumio avahi-daemon[687]: Loading service file /services/volumio.service. Apr 13 18:24:11 volumio sudo[1677]: pam_unix(sudo:session): session closed for user root Apr 13 18:24:11 volumio volumio[883]: info: Shairport-Sync Started Apr 13 18:24:11 volumio volumio[883]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Apr 13 18:24:11 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Apr 13 18:24:12 volumio kernel: pcieport 0000:00:00.0: AER: Corrected error received: 0000:00:00.0 Apr 13 18:24:12 volumio kernel: pcieport 0000:00:00.0: PCIe Bus Error: severity=Corrected, type=Data Link Layer, (Transmitter ID) Apr 13 18:24:12 volumio kernel: pcieport 0000:00:00.0: device [14e4:2712] error status/mask=00001000/00002000 Apr 13 18:24:12 volumio kernel: pcieport 0000:00:00.0: [12] Timeout Apr 13 18:24:12 volumio kernel: pcieport 0000:00:00.0: AER: Corrected error received: 0000:00:00.0 Apr 13 18:24:12 volumio kernel: nvme 0000:01:00.0: PCIe Bus Error: severity=Corrected, type=Data Link Layer, (Receiver ID) Apr 13 18:24:12 volumio kernel: nvme 0000:01:00.0: device [1987:5021] error status/mask=00002040/00006000 Apr 13 18:24:12 volumio kernel: nvme 0000:01:00.0: [ 6] BadTLP Apr 13 18:24:12 volumio kernel: pcieport 0000:00:00.0: AER: Corrected error received: 0000:00:00.0 Apr 13 18:24:12 volumio kernel: pcieport 0000:00:00.0: PCIe Bus Error: severity=Corrected, type=Data Link Layer, (Transmitter ID) Apr 13 18:24:12 volumio kernel: pcieport 0000:00:00.0: device [14e4:2712] error status/mask=00001100/00002000 Apr 13 18:24:12 volumio kernel: pcieport 0000:00:00.0: [ 8] Rollover Apr 13 18:24:12 volumio kernel: pcieport 0000:00:00.0: [12] Timeout Apr 13 18:24:12 volumio kernel: pcieport 0000:00:00.0: AER: Corrected error received: 0000:00:00.0 Apr 13 18:24:12 volumio kernel: nvme 0000:01:00.0: PCIe Bus Error: severity=Corrected, type=Data Link Layer, (Receiver ID) Apr 13 18:24:12 volumio kernel: nvme 0000:01:00.0: device [1987:5021] error status/mask=00000040/00006000 Apr 13 18:24:12 volumio kernel: nvme 0000:01:00.0: [ 6] BadTLP Apr 13 18:24:12 volumio kernel: pcieport 0000:00:00.0: AER: Corrected error received: 0000:00:00.0 Apr 13 18:24:12 volumio kernel: pcieport 0000:00:00.0: AER: can't find device of ID0000 Apr 13 18:24:12 volumio avahi-daemon[687]: Service "volumio" (/services/volumio.service) successfully established. Apr 13 18:24:12 volumio volumio[883]: info: Discovery: A device disappeared from network Apr 13 18:24:12 volumio volumio[883]: info: Discovery: Device volumio disappeared from network Apr 13 18:24:12 volumio volumio[883]: info: Discovery: A device disappeared from network Apr 13 18:24:12 volumio kernel: pcieport 0000:00:00.0: AER: Multiple Corrected error received: 0000:00:00.0 Apr 13 18:24:12 volumio kernel: pcieport 0000:00:00.0: PCIe Bus Error: severity=Corrected, type=Data Link Layer, (Transmitter ID) Apr 13 18:24:12 volumio kernel: pcieport 0000:00:00.0: device [14e4:2712] error status/mask=00001000/00002000 Apr 13 18:24:12 volumio kernel: pcieport 0000:00:00.0: [12] Timeout Apr 13 18:24:12 volumio kernel: nvme 0000:01:00.0: PCIe Bus Error: severity=Corrected, type=Data Link Layer, (Receiver ID) Apr 13 18:24:12 volumio kernel: nvme 0000:01:00.0: device [1987:5021] error status/mask=00000040/00006000 Apr 13 18:24:12 volumio kernel: nvme 0000:01:00.0: [ 6] BadTLP Apr 13 18:24:12 volumio volumio[883]: info: Successfully Updated MyVolumio device Apr 13 18:24:12 volumio volumio[883]: info: Tunnel connection is inactive, restarting it Apr 13 18:24:12 volumio volumio[883]: info: Starting Tunnel 1 Apr 13 18:24:12 volumio volumio[883]: info: Starting Tunnel Connection Checker Apr 13 18:24:14 volumio volumio[883]: info: TidalConnect service stoped! Apr 13 18:24:14 volumio volumio[883]: info: TidalConnect service stoped! Apr 13 18:24:14 volumio volumio[883]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Apr 13 18:24:14 volumio volumio[883]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Apr 13 18:24:14 volumio sudo[1699]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Apr 13 18:24:14 volumio sudo[1699]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 18:24:14 volumio systemd[1]: Started Volumio Tidal Connect Service. Apr 13 18:24:14 volumio sudo[1699]: pam_unix(sudo:session): session closed for user root Apr 13 18:24:14 volumio volumio[883]: info: Executing endpoint tc_getconfig Apr 13 18:24:14 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Apr 13 18:24:14 volumio vtcs[1701]: STARTING TidalConnect services, version: 1.3.0.19 Apr 13 18:24:14 volumio vtcs[1701]: STARTED TidalConnect services. Apr 13 18:24:14 volumio volumio[883]: info: Executing endpoint tc_connect Apr 13 18:24:14 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Apr 13 18:24:14 volumio volumio[883]: info: Connecting to TidalConnect Apr 13 18:24:14 volumio volumio[883]: info: CoreCommandRouter::servicePushState Apr 13 18:24:14 volumio volumio[883]: info: CoreStateMachine::pushState Apr 13 18:24:14 volumio volumio[883]: info: CorePlayQueue::getTrack 0 Apr 13 18:24:14 volumio volumio[883]: info: CoreCommandRouter::volumioPushState Apr 13 18:24:14 volumio volumio[883]: info: MRS: Pushing multiroomSync output update for this device Apr 13 18:24:14 volumio volumio[883]: info: MRS: Pushing multiroomSync output Apr 13 18:24:14 volumio volumio[883]: info: CorePlayQueue::getTrack 0 Apr 13 18:24:14 volumio volumio[883]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} Apr 13 18:24:14 volumio volumio[883]: verbose: CURRENT POSITION 0 Apr 13 18:24:14 volumio volumio[883]: info: CoreStateMachine::syncState stateService stop Apr 13 18:24:14 volumio volumio[883]: info: CoreStateMachine::syncState currentStatus stop Apr 13 18:24:14 volumio volumio[883]: info: CoreStateMachine::pushState Apr 13 18:24:14 volumio volumio[883]: info: CorePlayQueue::getTrack 0 Apr 13 18:24:14 volumio volumio[883]: info: CoreCommandRouter::volumioPushState Apr 13 18:24:14 volumio volumio[883]: info: MRS: Pushing multiroomSync output update for this device Apr 13 18:24:14 volumio volumio[883]: info: MRS: Pushing multiroomSync output Apr 13 18:24:14 volumio volumio[883]: info: No code Apr 13 18:24:14 volumio volumio[883]: info: CoreStateMachine::pushState Apr 13 18:24:14 volumio volumio[883]: info: CorePlayQueue::getTrack 0 Apr 13 18:24:14 volumio volumio[883]: info: CoreCommandRouter::volumioPushState Apr 13 18:24:14 volumio volumio[883]: info: MRS: Pushing multiroomSync output update for this device Apr 13 18:24:14 volumio volumio[883]: info: MRS: Pushing multiroomSync output Apr 13 18:24:14 volumio volumio[883]: info: CoreCommandRouter::servicePushState Apr 13 18:24:14 volumio volumio[883]: info: CoreStateMachine::pushState Apr 13 18:24:14 volumio volumio[883]: info: CorePlayQueue::getTrack 0 Apr 13 18:24:14 volumio volumio[883]: info: CoreCommandRouter::volumioPushState Apr 13 18:24:14 volumio volumio[883]: info: MRS: Pushing multiroomSync output update for this device Apr 13 18:24:14 volumio volumio[883]: info: MRS: Pushing multiroomSync output Apr 13 18:24:14 volumio volumio[883]: info: CorePlayQueue::getTrack 0 Apr 13 18:24:14 volumio volumio[883]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} Apr 13 18:24:14 volumio volumio[883]: verbose: CURRENT POSITION 0 Apr 13 18:24:14 volumio volumio[883]: info: CoreStateMachine::syncState stateService stop Apr 13 18:24:14 volumio volumio[883]: info: CoreStateMachine::syncState currentStatus stop Apr 13 18:24:14 volumio volumio[883]: info: CoreStateMachine::pushState Apr 13 18:24:14 volumio volumio[883]: info: CorePlayQueue::getTrack 0 Apr 13 18:24:14 volumio volumio[883]: info: CoreCommandRouter::volumioPushState Apr 13 18:24:14 volumio volumio[883]: info: MRS: Pushing multiroomSync output update for this device Apr 13 18:24:14 volumio volumio[883]: info: MRS: Pushing multiroomSync output Apr 13 18:24:14 volumio volumio[883]: info: No code Apr 13 18:24:14 volumio volumio[883]: info: CoreStateMachine::pushState Apr 13 18:24:14 volumio volumio[883]: info: CorePlayQueue::getTrack 0 Apr 13 18:24:14 volumio volumio[883]: info: CoreCommandRouter::volumioPushState Apr 13 18:24:14 volumio volumio[883]: info: MRS: Pushing multiroomSync output update for this device Apr 13 18:24:14 volumio volumio[883]: info: MRS: Pushing multiroomSync output Apr 13 18:24:14 volumio sudo[1646]: pam_unix(sudo:session): session closed for user root Apr 13 18:24:16 volumio volumio[883]: info: Discovery: Started advertising with name: volumio Apr 13 18:24:17 volumio volumio[883]: info: Discovery: adding aa0072f0-f7cc-4dcd-bd43-c3123bc7205d Apr 13 18:24:17 volumio volumio[883]: info: Discovery: Found device volumio Apr 13 18:24:17 volumio volumio[883]: info: CoreCommandRouter::volumioGetState Apr 13 18:24:17 volumio volumio[883]: info: CorePlayQueue::getTrack 0 Apr 13 18:24:17 volumio volumio[883]: info: Discovery: this is already registered, aa0072f0-f7cc-4dcd-bd43-c3123bc7205d Apr 13 18:24:17 volumio volumio[883]: info: Discovery: Found device volumio Apr 13 18:24:17 volumio volumio[883]: info: CoreCommandRouter::volumioGetState Apr 13 18:24:17 volumio volumio[883]: info: CorePlayQueue::getTrack 0 Apr 13 18:24:17 volumio volumio[883]: info: TidalConnect service started! Apr 13 18:24:19 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Apr 13 18:24:19 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 13 18:24:19 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Apr 13 18:24:19 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 13 18:24:19 volumio volumio[883]: info: Enabling I2S DAC: Allo BOSS Apr 13 18:24:19 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , enableI2SDAC Apr 13 18:24:19 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 13 18:24:19 volumio sudo[1723]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Apr 13 18:24:19 volumio sudo[1723]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 18:24:24 volumio volumio[883]: info: Cannot Remove all dtoverlays Apr 13 18:24:24 volumio volumio[883]: info: No Overlays Loaded Apr 13 18:24:24 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 13 18:24:24 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SAlsaName Apr 13 18:24:24 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 13 18:24:41 volumio systemd[1]: systemd-timedated.service: Succeeded. Apr 13 18:24:42 volumio kernel: nvme nvme0: controller is down; will reset: CSTS=0xffffffff, PCI_STATUS=0x10 Apr 13 18:24:42 volumio kernel: nvme nvme0: Does your device have a faulty power saving mode enabled? Apr 13 18:24:42 volumio kernel: nvme nvme0: Try "nvme_core.default_ps_max_latency_us=0 pcie_aspm=off" and report a bug Apr 13 18:24:42 volumio kernel: nvme0n1: I/O Cmd(0x2) @ LBA 805320, 8 blocks, I/O Error (sct 0x3 / sc 0x71) Apr 13 18:24:42 volumio kernel: I/O error, dev nvme0n1, sector 805320 op 0x0:(READ) flags 0x80700 phys_seg 1 prio class 2 Apr 13 18:24:42 volumio kernel: nvme 0000:01:00.0: enabling device (0000 -> 0002) Apr 13 18:24:42 volumio kernel: nvme nvme0: 4/0/0 default/read/poll queues Apr 13 18:24:42 volumio sudo[1726]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay allo-boss-dac-pcm512x-audio Apr 13 18:24:42 volumio sudo[1726]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 18:24:42 volumio volumio[883]: xcb_connection_has_error() returned true Apr 13 18:24:42 volumio volumio[883]: warn: Unable to locate the device Allo BOSS a reboot may be required. Apr 13 18:24:42 volumio sudo[1726]: pam_unix(sudo:session): session closed for user root Apr 13 18:24:42 volumio sudo[1723]: pam_unix(sudo:session): session closed for user root Apr 13 18:24:42 volumio volumio[883]: xcb_connection_has_error() returned true Apr 13 18:24:42 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 13 18:24:42 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SMixer Apr 13 18:24:42 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 13 18:24:42 volumio volumio[883]: info: Found match in i2s Card Database: setting mixer Digital for card Allo BOSS Apr 13 18:24:43 volumio volumio[883]: xcb_connection_has_error() returned true Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::volumioUpdateVolumeSettings Apr 13 18:24:43 volumio volumio[883]: info: Updating Volume Controller Parameters: Device: 2 Name: Allo BOSS Mixer: Digital Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Apr 13 18:24:43 volumio volumio[883]: info: Disabling external Volume Control Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: wizard , setWizardAction Apr 13 18:24:43 volumio volumio[883]: info: Preparing to generate the ALSA configuration file Apr 13 18:24:43 volumio sudo[1741]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/samba/smb.conf Apr 13 18:24:43 volumio sudo[1741]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 18:24:43 volumio sudo[1743]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /data/INTERNAL Apr 13 18:24:43 volumio sudo[1743]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 18:24:43 volumio sudo[1741]: pam_unix(sudo:session): session closed for user root Apr 13 18:24:43 volumio sudo[1743]: pam_unix(sudo:session): session closed for user root Apr 13 18:24:43 volumio sudo[1747]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 13 18:24:43 volumio sudo[1747]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 18:24:43 volumio sudo[1747]: pam_unix(sudo:session): session closed for user root Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 13 18:24:43 volumio sudo[1749]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 13 18:24:43 volumio sudo[1749]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 18:24:43 volumio sudo[1749]: pam_unix(sudo:session): session closed for user root Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Apr 13 18:24:43 volumio sudo[1753]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Apr 13 18:24:43 volumio sudo[1753]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 13 18:24:43 volumio volumio[883]: info: Retrieving Cloud Streaming UI Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 13 18:24:43 volumio volumio[883]: info: Retrieving Cloud Streaming UI Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 13 18:24:43 volumio volumio[883]: info: Retrieving Cloud Streaming UI Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 13 18:24:43 volumio volumio[883]: info: Retrieving Cloud Streaming UI Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 13 18:24:43 volumio volumio[883]: info: Retrieving Cloud Streaming UI Apr 13 18:24:43 volumio sudo[1755]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Apr 13 18:24:43 volumio sudo[1755]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 13 18:24:43 volumio volumio[883]: info: Retrieving Cloud Streaming UI Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 13 18:24:43 volumio volumio[883]: info: Retrieving Cloud Streaming UI Apr 13 18:24:43 volumio sudo[1755]: pam_unix(sudo:session): session closed for user root Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 13 18:24:43 volumio volumio[883]: info: Retrieving Cloud Streaming UI Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 13 18:24:43 volumio volumio[883]: info: Retrieving Cloud Streaming UI Apr 13 18:24:43 volumio volumio[883]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Apr 13 18:24:43 volumio volumio[883]: info: Reading ALSA contributions from plugins. Apr 13 18:24:43 volumio volumio[883]: info: Internal perms successfully set Apr 13 18:24:43 volumio volumio[883]: info: smb.conf Permissions set Apr 13 18:24:43 volumio volumio[883]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Apr 13 18:24:43 volumio volumio[883]: error: Cannot enable I2S Param: Error: Command failed: /usr/bin/sudo /usr/bin/dtoverlay allo-boss-dac-pcm512x-audio Apr 13 18:24:43 volumio volumio[883]: * Failed to create '/tmp/.dtoverlays' - 17 Apr 13 18:24:43 volumio sudo[1760]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service Apr 13 18:24:43 volumio sudo[1760]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 18:24:43 volumio volumio[883]: info: VolumeController:: Volume=undefined Mute =false Apr 13 18:24:43 volumio volumio[883]: info: CoreStateMachine::pushState Apr 13 18:24:43 volumio volumio[883]: info: CorePlayQueue::getTrack 0 Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::volumioPushState Apr 13 18:24:43 volumio volumio[883]: info: MRS: Pushing multiroomSync output update for this device Apr 13 18:24:43 volumio volumio[883]: info: MRS: Pushing multiroomSync output Apr 13 18:24:43 volumio autossh[1409]: received signal to exit (15) Apr 13 18:24:43 volumio systemd[1]: Stopping MyVolumio SSH Tunnel... Apr 13 18:24:43 volumio volumio[883]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Apr 13 18:24:43 volumio volumio[883]: wlan0 Interface doesn't support scanning : Device or resource busy Apr 13 18:24:43 volumio volumio[883]: info: Cannot use regular scanning, forcing with ap-force Apr 13 18:24:43 volumio systemd[1]: sshtunnel.service: Main process exited, code=killed, status=15/TERM Apr 13 18:24:43 volumio systemd[1]: sshtunnel.service: Succeeded. Apr 13 18:24:43 volumio systemd[1]: Stopped MyVolumio SSH Tunnel. Apr 13 18:24:43 volumio sudo[1764]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Apr 13 18:24:43 volumio sudo[1764]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 18:24:43 volumio volumio[883]: command failed: Device or resource busy (-16) Apr 13 18:24:43 volumio volumio[883]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Apr 13 18:24:43 volumio volumio[883]: command failed: Device or resource busy (-16) Apr 13 18:24:43 volumio volumio[883]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 13 18:24:43 volumio volumio[883]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Apr 13 18:24:43 volumio sudo[1764]: pam_unix(sudo:session): session closed for user root Apr 13 18:24:43 volumio systemd[1]: Started MyVolumio SSH Tunnel. Apr 13 18:24:43 volumio sudo[1760]: pam_unix(sudo:session): session closed for user root Apr 13 18:24:43 volumio autossh[1767]: port set to 0, monitoring disabled Apr 13 18:24:43 volumio autossh[1767]: starting ssh (count 1) Apr 13 18:24:43 volumio autossh[1767]: ssh child pid is 1771 Apr 13 18:24:43 volumio volumio[883]: xcb_connection_has_error() returned true Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 13 18:24:43 volumio volumio[883]: info: Getting Alsa Cards List without I2S DAC Apr 13 18:24:43 volumio volumio[883]: xcb_connection_has_error() returned true Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 13 18:24:43 volumio volumio[883]: xcb_connection_has_error() returned true Apr 13 18:24:43 volumio volumio[883]: Invalid card number. Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 13 18:24:43 volumio volumio[883]: info: Getting Tidal Cloud Configuration Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 13 18:24:43 volumio volumio[883]: info: Getting Qobuz Cloud Configuration Apr 13 18:24:43 volumio volumio[883]: info: Asking plugin for UI Config Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 13 18:24:43 volumio volumio[883]: info: Getting Spotify Cloud Configuration Apr 13 18:24:43 volumio volumio[883]: info: Asking plugin for UI Config Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 13 18:24:43 volumio volumio[883]: info: Saving Spotify Acccount Apr 13 18:24:43 volumio volumio[883]: info: Got it Apr 13 18:24:43 volumio volumio[883]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Apr 13 18:24:43 volumio volumio[883]: info: Getting Tidal Cloud Configuration Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 13 18:24:43 volumio volumio[883]: info: Getting Qobuz Cloud Configuration Apr 13 18:24:43 volumio volumio[883]: info: Asking plugin for UI Config Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 13 18:24:43 volumio volumio[883]: info: Getting Spotify Cloud Configuration Apr 13 18:24:43 volumio volumio[883]: info: Asking plugin for UI Config Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 13 18:24:43 volumio volumio[883]: info: Saving Spotify Acccount Apr 13 18:24:43 volumio volumio[883]: info: Got it Apr 13 18:24:43 volumio volumio[883]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Apr 13 18:24:43 volumio volumio[883]: info: Getting Tidal Cloud Configuration Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 13 18:24:43 volumio volumio[883]: info: Getting Qobuz Cloud Configuration Apr 13 18:24:43 volumio volumio[883]: info: Asking plugin for UI Config Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 13 18:24:43 volumio volumio[883]: info: Getting Spotify Cloud Configuration Apr 13 18:24:43 volumio volumio[883]: info: Asking plugin for UI Config Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 13 18:24:43 volumio volumio[883]: info: Saving Spotify Acccount Apr 13 18:24:43 volumio volumio[883]: info: Got it Apr 13 18:24:43 volumio volumio[883]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Apr 13 18:24:43 volumio volumio[883]: info: Getting Tidal Cloud Configuration Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 13 18:24:43 volumio volumio[883]: info: Getting Qobuz Cloud Configuration Apr 13 18:24:43 volumio volumio[883]: info: Asking plugin for UI Config Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 13 18:24:43 volumio volumio[883]: info: Getting Spotify Cloud Configuration Apr 13 18:24:43 volumio volumio[883]: info: Asking plugin for UI Config Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 13 18:24:43 volumio volumio[883]: info: Saving Spotify Acccount Apr 13 18:24:43 volumio volumio[883]: info: Got it Apr 13 18:24:43 volumio volumio[883]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Apr 13 18:24:43 volumio volumio[883]: info: Getting Tidal Cloud Configuration Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 13 18:24:43 volumio volumio[883]: info: Getting Qobuz Cloud Configuration Apr 13 18:24:43 volumio volumio[883]: info: Asking plugin for UI Config Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 13 18:24:43 volumio volumio[883]: info: Getting Spotify Cloud Configuration Apr 13 18:24:43 volumio volumio[883]: info: Asking plugin for UI Config Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 13 18:24:43 volumio volumio[883]: info: Saving Spotify Acccount Apr 13 18:24:43 volumio volumio[883]: info: Got it Apr 13 18:24:43 volumio volumio[883]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Apr 13 18:24:43 volumio volumio[883]: info: Getting Tidal Cloud Configuration Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 13 18:24:43 volumio volumio[883]: info: Getting Qobuz Cloud Configuration Apr 13 18:24:43 volumio volumio[883]: info: Asking plugin for UI Config Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 13 18:24:43 volumio volumio[883]: info: Getting Spotify Cloud Configuration Apr 13 18:24:43 volumio volumio[883]: info: Asking plugin for UI Config Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 13 18:24:43 volumio volumio[883]: info: Saving Spotify Acccount Apr 13 18:24:43 volumio volumio[883]: info: Got it Apr 13 18:24:43 volumio volumio[883]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Apr 13 18:24:43 volumio volumio[883]: info: Getting Tidal Cloud Configuration Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 13 18:24:43 volumio volumio[883]: info: Getting Qobuz Cloud Configuration Apr 13 18:24:43 volumio volumio[883]: info: Asking plugin for UI Config Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 13 18:24:43 volumio volumio[883]: info: Getting Spotify Cloud Configuration Apr 13 18:24:43 volumio volumio[883]: info: Asking plugin for UI Config Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 13 18:24:43 volumio volumio[883]: info: Saving Spotify Acccount Apr 13 18:24:43 volumio volumio[883]: info: Got it Apr 13 18:24:43 volumio volumio[883]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Apr 13 18:24:43 volumio volumio[883]: info: Getting Tidal Cloud Configuration Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 13 18:24:43 volumio volumio[883]: info: Getting Qobuz Cloud Configuration Apr 13 18:24:43 volumio volumio[883]: info: Asking plugin for UI Config Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 13 18:24:43 volumio volumio[883]: info: Getting Spotify Cloud Configuration Apr 13 18:24:43 volumio volumio[883]: info: Asking plugin for UI Config Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 13 18:24:43 volumio volumio[883]: info: Saving Spotify Acccount Apr 13 18:24:43 volumio volumio[883]: info: Got it Apr 13 18:24:43 volumio volumio[883]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Apr 13 18:24:43 volumio volumio[883]: info: Getting Tidal Cloud Configuration Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 13 18:24:43 volumio volumio[883]: info: Getting Qobuz Cloud Configuration Apr 13 18:24:43 volumio volumio[883]: info: Asking plugin for UI Config Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 13 18:24:43 volumio volumio[883]: info: Getting Spotify Cloud Configuration Apr 13 18:24:43 volumio volumio[883]: info: Asking plugin for UI Config Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 13 18:24:43 volumio volumio[883]: info: Saving Spotify Acccount Apr 13 18:24:43 volumio volumio[883]: info: Got it Apr 13 18:24:43 volumio volumio[883]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Apr 13 18:24:43 volumio volumio-remote-updater[667]: No test mode Apr 13 18:24:43 volumio volumio-remote-updater[667]: No alpha test mode Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Apr 13 18:24:43 volumio volumio[883]: info: Remote SSH Started Apr 13 18:24:43 volumio volumiossh-tunnel[1762]: Warning: Permanently added '[eu10.myvolumio.org]:2222,[46.101.141.203]:2222' (RSA) to the list of known hosts. Apr 13 18:24:43 volumio sudo[1780]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Apr 13 18:24:43 volumio sudo[1780]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 18:24:43 volumio sudo[1780]: pam_unix(sudo:session): session closed for user root Apr 13 18:24:43 volumio volumio[883]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 7 Apr 13 18:24:43 volumio volumio[883]: info: Got Tidal Cloud Configuration Apr 13 18:24:43 volumio volumio[883]: info: Got Tidal Cloud Configuration Apr 13 18:24:43 volumio volumio[883]: info: Got Tidal Cloud Configuration Apr 13 18:24:43 volumio volumio[883]: info: Got it Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 13 18:24:43 volumio sudo[1783]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart nmbd.service Apr 13 18:24:43 volumio volumio[883]: info: Got it Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 13 18:24:43 volumio sudo[1783]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 18:24:43 volumio volumio[883]: info: Got it Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 13 18:24:43 volumio volumio[883]: info: Got Tidal Cloud Configuration Apr 13 18:24:43 volumio volumio[883]: info: Got it Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 13 18:24:43 volumio volumio[883]: info: Got Tidal Cloud Configuration Apr 13 18:24:43 volumio volumio[883]: info: Got it Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 13 18:24:43 volumio volumio[883]: info: Got Tidal Cloud Configuration Apr 13 18:24:43 volumio volumio[883]: info: Got it Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 13 18:24:43 volumio volumio[883]: info: Got Tidal Cloud Configuration Apr 13 18:24:43 volumio volumio[883]: info: Got it Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 13 18:24:43 volumio volumio[883]: info: Got Tidal Cloud Configuration Apr 13 18:24:43 volumio volumio[883]: info: Got it Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 13 18:24:43 volumio volumio[883]: info: Got Tidal Cloud Configuration Apr 13 18:24:43 volumio volumio[883]: info: Got it Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 13 18:24:43 volumio volumio[883]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Apr 13 18:24:43 volumio nmbd[732]: [2024/04/13 18:24:43.443327, 0] ../source3/nmbd/nmbd.c:58(terminate) Apr 13 18:24:43 volumio nmbd[732]: Got SIGTERM: going down... Apr 13 18:24:43 volumio systemd[1]: Stopping Samba NMB Daemon... Apr 13 18:24:43 volumio volumio[883]: info: Upmpdcli Daemon Started Apr 13 18:24:43 volumio volumio[883]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 13 18:24:43 volumio volumio[883]: info: Asound.conf file written Apr 13 18:24:43 volumio sudo[1786]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Apr 13 18:24:43 volumio sudo[1786]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 18:24:43 volumio sudo[1786]: pam_unix(sudo:session): session closed for user root Apr 13 18:24:43 volumio systemd[1]: nmbd.service: Succeeded. Apr 13 18:24:43 volumio systemd[1]: Stopped Samba NMB Daemon. Apr 13 18:24:43 volumio volumio[883]: xcb_connection_has_error() returned true Apr 13 18:24:43 volumio volumio[883]: info: Output device has changed, restarting MPD Apr 13 18:24:43 volumio sudo[1792]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 13 18:24:43 volumio sudo[1792]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 18:24:43 volumio volumio[883]: info: Output device has changed, restarting Shairport Sync Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 13 18:24:43 volumio sudo[1792]: pam_unix(sudo:session): session closed for user root Apr 13 18:24:43 volumio systemd[1]: Starting Samba NMB Daemon... Apr 13 18:24:43 volumio sudo[1795]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 13 18:24:43 volumio sudo[1795]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 18:24:43 volumio systemd[1]: Stopping Music Player Daemon... Apr 13 18:24:43 volumio systemd[1]: mpd.service: Succeeded. Apr 13 18:24:43 volumio systemd[1]: Stopped Music Player Daemon. Apr 13 18:24:43 volumio systemd[1]: Starting Music Player Daemon... Apr 13 18:24:43 volumio volumio[883]: xcb_connection_has_error() returned true Apr 13 18:24:43 volumio volumio[883]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 13 18:24:43 volumio volumio[883]: xcb_connection_has_error() returned true Apr 13 18:24:43 volumio volumio[883]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 18:24:43 volumio vtcs[1701]: [2024-04-13 18:24:43.535] [tisoc] [warning] [SessionManagerImpl.cpp:243] Illegal State: IDLE Apr 13 18:24:43 volumio vtcs[1701]: [2024-04-13 18:24:43.535] [tisoc] [error] [SpkconServer.cpp:377] recv error. socket disconnected Apr 13 18:24:43 volumio nmbd[1800]: [2024/04/13 18:24:43.542758, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns) Apr 13 18:24:43 volumio nmbd[1800]: started asyncdns process 1805 Apr 13 18:24:43 volumio volumio[883]: info: Output device has changed, restarting MPD Apr 13 18:24:43 volumio nmbd[1800]: [2024/04/13 18:24:43.544525, 0] ../lib/util/become_daemon.c:138(daemon_ready) Apr 13 18:24:43 volumio nmbd[1800]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Apr 13 18:24:43 volumio systemd[1]: Started Samba NMB Daemon. Apr 13 18:24:43 volumio sudo[1783]: pam_unix(sudo:session): session closed for user root Apr 13 18:24:43 volumio sudo[1807]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart smbd.service Apr 13 18:24:43 volumio sudo[1807]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 18:24:43 volumio sudo[1809]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Apr 13 18:24:43 volumio sudo[1809]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 18:24:43 volumio sudo[1810]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 13 18:24:43 volumio sudo[1810]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 18:24:43 volumio systemd[1]: Stopping Samba SMB Daemon... Apr 13 18:24:43 volumio sudo[1814]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 13 18:24:43 volumio systemd[1]: smbd.service: Main process exited, code=killed, status=15/TERM Apr 13 18:24:43 volumio systemd[1]: smbd.service: Succeeded. Apr 13 18:24:43 volumio sudo[1814]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 18:24:43 volumio systemd[1]: Stopped Samba SMB Daemon. Apr 13 18:24:43 volumio volumio[883]: info: Output device has changed, restarting Shairport Sync Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 13 18:24:43 volumio systemd[1]: Stopping Volumio Tidal Connect Service... Apr 13 18:24:43 volumio sudo[1810]: pam_unix(sudo:session): session closed for user root Apr 13 18:24:43 volumio volumio[883]: xcb_connection_has_error() returned true Apr 13 18:24:43 volumio volumio[883]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 13 18:24:43 volumio volumio[883]: xcb_connection_has_error() returned true Apr 13 18:24:43 volumio volumio[883]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 18:24:43 volumio systemd[1]: Starting Samba SMB Daemon... Apr 13 18:24:43 volumio systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Apr 13 18:24:43 volumio systemd[1]: vtcs.service: Succeeded. Apr 13 18:24:43 volumio systemd[1]: Stopped Volumio Tidal Connect Service. Apr 13 18:24:43 volumio sudo[1809]: pam_unix(sudo:session): session closed for user root Apr 13 18:24:43 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Apr 13 18:24:43 volumio systemd[1]: mpd.service: Succeeded. Apr 13 18:24:43 volumio systemd[1]: Stopped Music Player Daemon. Apr 13 18:24:43 volumio systemd[1]: Starting Music Player Daemon... Apr 13 18:24:43 volumio sudo[1828]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Apr 13 18:24:43 volumio sudo[1828]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 18:24:43 volumio sudo[1828]: pam_unix(sudo:session): session closed for user root Apr 13 18:24:43 volumio sudo[1832]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Apr 13 18:24:43 volumio sudo[1832]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 18:24:43 volumio sudo[1832]: pam_unix(sudo:session): session closed for user root Apr 13 18:24:43 volumio volumio[883]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Apr 13 18:24:43 volumio volumio[883]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 13 18:24:43 volumio sudo[1835]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Apr 13 18:24:43 volumio sudo[1835]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 18:24:43 volumio volumio[883]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 13 18:24:43 volumio volumio[883]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Apr 13 18:24:43 volumio volumio[883]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 13 18:24:43 volumio volumio[883]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 13 18:24:43 volumio volumio[883]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Apr 13 18:24:43 volumio volumio[883]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 13 18:24:43 volumio volumio[883]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 13 18:24:43 volumio volumio[883]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Apr 13 18:24:43 volumio volumio[883]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 13 18:24:43 volumio volumio[883]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Apr 13 18:24:43 volumio volumio[883]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 13 18:24:43 volumio smbd[1824]: [2024/04/13 18:24:43.684923, 0] ../lib/util/become_daemon.c:138(daemon_ready) Apr 13 18:24:43 volumio smbd[1824]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Apr 13 18:24:43 volumio systemd[1]: Started Samba SMB Daemon. Apr 13 18:24:43 volumio sudo[1807]: pam_unix(sudo:session): session closed for user root Apr 13 18:24:43 volumio sudo[1835]: pam_unix(sudo:session): session closed for user root Apr 13 18:24:43 volumio volumio[883]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined Apr 13 18:24:43 volumio volumio[883]: info: MPD Permissions set Apr 13 18:24:43 volumio volumio[883]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined Apr 13 18:24:43 volumio volumio[883]: info: MPD Permissions set Apr 13 18:24:43 volumio volumio[883]: info: SAMBA Restarted Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 18:24:43 volumio volumio[883]: info: CoreCommandRouter::volumioGetState Apr 13 18:24:43 volumio volumio[883]: info: CorePlayQueue::getTrack 0 Apr 13 18:24:43 volumio volumio[883]: info: Starting Shairport Sync Apr 13 18:24:43 volumio volumio[883]: info: Starting Shairport Sync Apr 13 18:24:43 volumio sudo[1853]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 13 18:24:43 volumio sudo[1853]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 18:24:43 volumio sudo[1855]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 13 18:24:43 volumio sudo[1855]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 18:24:43 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 13 18:24:43 volumio volumio[883]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 13 18:24:43 volumio systemd[1]: shairport-sync.service: Succeeded. Apr 13 18:24:43 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 13 18:24:43 volumio volumio[883]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Apr 13 18:24:43 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 13 18:24:43 volumio sudo[1853]: pam_unix(sudo:session): session closed for user root Apr 13 18:24:43 volumio volumio[883]: info: Shairport-Sync Started Apr 13 18:24:43 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 13 18:24:43 volumio systemd[1]: shairport-sync.service: Succeeded. Apr 13 18:24:43 volumio volumio[883]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 13 18:24:43 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 13 18:24:43 volumio volumio[883]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Apr 13 18:24:43 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 13 18:24:43 volumio sudo[1855]: pam_unix(sudo:session): session closed for user root Apr 13 18:24:43 volumio volumio[883]: info: Shairport-Sync Started Apr 13 18:24:43 volumio mpd[1827]: Apr 13 18:24 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 13 18:24:43 volumio systemd[1]: Started Music Player Daemon. Apr 13 18:24:43 volumio sudo[1814]: pam_unix(sudo:session): session closed for user root Apr 13 18:24:43 volumio sudo[1795]: pam_unix(sudo:session): session closed for user root Apr 13 18:24:43 volumio volumio[883]: error: MPD error: The expression evaluated to a falsy value: Apr 13 18:24:43 volumio volumio[883]: assert.ok(self.idling) Apr 13 18:24:43 volumio volumio[883]: error: The expression evaluated to a falsy value: Apr 13 18:24:43 volumio volumio[883]: assert.ok(self.idling) Apr 13 18:24:43 volumio volumio[883]: error: updateQueue error: null Apr 13 18:24:46 volumio volumio[883]: info: TidalConnect service stoped! Apr 13 18:24:46 volumio volumio[883]: info: TidalConnect service stoped! Apr 13 18:24:46 volumio volumio[883]: info: TidalConnect service stoped! Apr 13 18:24:46 volumio volumio[883]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Apr 13 18:24:46 volumio volumio[883]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Apr 13 18:24:46 volumio volumio[883]: info: TidalConnect service stoped! Apr 13 18:24:46 volumio sudo[1874]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Apr 13 18:24:46 volumio sudo[1874]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 18:24:46 volumio volumio[883]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Apr 13 18:24:46 volumio volumio[883]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Apr 13 18:24:46 volumio sudo[1886]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Apr 13 18:24:46 volumio sudo[1886]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 18:24:46 volumio systemd[1]: Started Volumio Tidal Connect Service. Apr 13 18:24:46 volumio sudo[1874]: pam_unix(sudo:session): session closed for user root Apr 13 18:24:46 volumio sudo[1886]: pam_unix(sudo:session): session closed for user root Apr 13 18:24:46 volumio volumio[883]: info: Executing endpoint tc_getconfig Apr 13 18:24:46 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Apr 13 18:24:46 volumio vtcs[1884]: STARTING TidalConnect services, version: 1.3.0.19 Apr 13 18:24:46 volumio sudo[1753]: pam_unix(sudo:session): session closed for user root Apr 13 18:24:46 volumio vtcs[1884]: STARTED TidalConnect services. Apr 13 18:24:46 volumio volumio[883]: info: Executing endpoint tc_connect Apr 13 18:24:46 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Apr 13 18:24:46 volumio volumio[883]: info: Connecting to TidalConnect Apr 13 18:24:46 volumio volumio[883]: info: CoreCommandRouter::servicePushState Apr 13 18:24:46 volumio volumio[883]: info: CoreStateMachine::pushState Apr 13 18:24:46 volumio volumio[883]: info: CorePlayQueue::getTrack 0 Apr 13 18:24:46 volumio volumio[883]: info: CoreCommandRouter::volumioPushState Apr 13 18:24:46 volumio volumio[883]: info: MRS: Pushing multiroomSync output update for this device Apr 13 18:24:46 volumio volumio[883]: info: MRS: Pushing multiroomSync output Apr 13 18:24:46 volumio volumio[883]: info: CorePlayQueue::getTrack 0 Apr 13 18:24:46 volumio volumio[883]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} Apr 13 18:24:46 volumio volumio[883]: verbose: CURRENT POSITION 0 Apr 13 18:24:46 volumio volumio[883]: info: CoreStateMachine::syncState stateService stop Apr 13 18:24:46 volumio volumio[883]: info: CoreStateMachine::syncState currentStatus stop Apr 13 18:24:46 volumio volumio[883]: info: CoreStateMachine::pushState Apr 13 18:24:46 volumio volumio[883]: info: CorePlayQueue::getTrack 0 Apr 13 18:24:46 volumio volumio[883]: info: CoreCommandRouter::volumioPushState Apr 13 18:24:46 volumio volumio[883]: info: MRS: Pushing multiroomSync output update for this device Apr 13 18:24:46 volumio volumio[883]: info: MRS: Pushing multiroomSync output Apr 13 18:24:46 volumio volumio[883]: info: No code Apr 13 18:24:46 volumio volumio[883]: info: CoreStateMachine::pushState Apr 13 18:24:46 volumio volumio[883]: info: CorePlayQueue::getTrack 0 Apr 13 18:24:46 volumio volumio[883]: info: CoreCommandRouter::volumioPushState Apr 13 18:24:46 volumio volumio[883]: info: MRS: Pushing multiroomSync output update for this device Apr 13 18:24:46 volumio volumio[883]: info: MRS: Pushing multiroomSync output Apr 13 18:24:46 volumio volumio[883]: info: CoreCommandRouter::servicePushState Apr 13 18:24:46 volumio volumio[883]: info: CoreStateMachine::pushState Apr 13 18:24:46 volumio volumio[883]: info: CorePlayQueue::getTrack 0 Apr 13 18:24:46 volumio volumio[883]: info: CoreCommandRouter::volumioPushState Apr 13 18:24:46 volumio volumio[883]: info: MRS: Pushing multiroomSync output update for this device Apr 13 18:24:46 volumio volumio[883]: info: MRS: Pushing multiroomSync output Apr 13 18:24:46 volumio volumio[883]: info: CorePlayQueue::getTrack 0 Apr 13 18:24:46 volumio volumio[883]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} Apr 13 18:24:46 volumio volumio[883]: verbose: CURRENT POSITION 0 Apr 13 18:24:46 volumio volumio[883]: info: CoreStateMachine::syncState stateService stop Apr 13 18:24:46 volumio volumio[883]: info: CoreStateMachine::syncState currentStatus stop Apr 13 18:24:46 volumio volumio[883]: info: CoreStateMachine::pushState Apr 13 18:24:46 volumio volumio[883]: info: CorePlayQueue::getTrack 0 Apr 13 18:24:46 volumio volumio[883]: info: CoreCommandRouter::volumioPushState Apr 13 18:24:46 volumio volumio[883]: info: MRS: Pushing multiroomSync output update for this device Apr 13 18:24:46 volumio volumio[883]: info: MRS: Pushing multiroomSync output Apr 13 18:24:46 volumio volumio[883]: info: No code Apr 13 18:24:46 volumio volumio[883]: info: CoreStateMachine::pushState Apr 13 18:24:46 volumio volumio[883]: info: CorePlayQueue::getTrack 0 Apr 13 18:24:46 volumio volumio[883]: info: CoreCommandRouter::volumioPushState Apr 13 18:24:46 volumio volumio[883]: info: MRS: Pushing multiroomSync output update for this device Apr 13 18:24:46 volumio volumio[883]: info: MRS: Pushing multiroomSync output Apr 13 18:24:47 volumio volumio[883]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Apr 13 18:24:47 volumio volumio[883]: info: CoreStateMachine::getcurrentVolume Apr 13 18:24:47 volumio volumio[883]: info: CoreCommandRouter::volumioRetrievevolume Apr 13 18:24:47 volumio volumio[883]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Apr 13 18:24:47 volumio volumio[883]: info: VolumeController:: Volume=undefined Mute =false Apr 13 18:24:47 volumio volumio[883]: info: CoreStateMachine::pushState Apr 13 18:24:47 volumio volumio[883]: info: CorePlayQueue::getTrack 0 Apr 13 18:24:47 volumio volumio[883]: info: CoreCommandRouter::volumioPushState Apr 13 18:24:47 volumio volumio[883]: info: MRS: Pushing multiroomSync output update for this device Apr 13 18:24:47 volumio volumio[883]: info: MRS: Pushing multiroomSync output Apr 13 18:24:47 volumio volumio[883]: info: CoreStateMachine::updateTrackBlock Apr 13 18:24:47 volumio volumio[883]: info: CorePlayQueue::getTrackBlock Apr 13 18:24:47 volumio volumio[883]: info: CoreCommandRouter::volumioRetrievevolume Apr 13 18:24:47 volumio volumio[883]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Apr 13 18:24:47 volumio volumio[883]: info: VolumeController:: Volume=undefined Mute =false Apr 13 18:24:47 volumio volumio[883]: info: CoreStateMachine::pushState Apr 13 18:24:47 volumio volumio[883]: info: CorePlayQueue::getTrack 0 Apr 13 18:24:47 volumio volumio[883]: info: CoreCommandRouter::volumioPushState Apr 13 18:24:47 volumio volumio[883]: info: MRS: Pushing multiroomSync output update for this device Apr 13 18:24:47 volumio volumio[883]: info: MRS: Pushing multiroomSync output Apr 13 18:24:48 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 13 18:24:49 volumio volumio[883]: info: TidalConnect service started! Apr 13 18:24:49 volumio volumio[883]: info: TidalConnect service started! Apr 13 18:25:17 volumio kernel: nvme nvme0: controller is down; will reset: CSTS=0xffffffff, PCI_STATUS=0x10 Apr 13 18:25:17 volumio kernel: nvme nvme0: Does your device have a faulty power saving mode enabled? Apr 13 18:25:17 volumio kernel: nvme nvme0: Try "nvme_core.default_ps_max_latency_us=0 pcie_aspm=off" and report a bug Apr 13 18:25:17 volumio kernel: nvme 0000:01:00.0: enabling device (0000 -> 0002) Apr 13 18:25:18 volumio kernel: nvme nvme0: 4/0/0 default/read/poll queues Apr 13 18:25:18 volumio volumio[883]: info: Received OAUTH Data Apr 13 18:25:18 volumio volumio[883]: info: Refreshing TIDAL token Apr 13 18:25:18 volumio sudo[1950]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 13 18:25:18 volumio sudo[1950]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 18:25:18 volumio sudo[1950]: pam_unix(sudo:session): session closed for user root Apr 13 18:25:18 volumio sudo[1952]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 13 18:25:18 volumio sudo[1952]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 18:25:18 volumio sudo[1952]: pam_unix(sudo:session): session closed for user root Apr 13 18:25:18 volumio volumio[883]: verbose: New Socket.io Connection to 192.168.1.218 from 192.168.1.82 UA: okhttp/4.9.2 Total Clients: 7 Apr 13 18:25:18 volumio volumio[883]: info: TIDAL Access Token successfully retrieved Apr 13 18:25:18 volumio volumio[883]: info: CoreCommandRouter::volumioGetVisibleSources Apr 13 18:25:18 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 13 18:25:18 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps Apr 13 18:25:18 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode Apr 13 18:25:18 volumio volumio[883]: xcb_connection_has_error() returned true Apr 13 18:25:18 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Apr 13 18:25:18 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones Apr 13 18:25:18 volumio volumio[883]: info: Received Get System Info Apr 13 18:25:18 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 13 18:25:18 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 13 18:25:18 volumio volumio[883]: info: Discovery: Getting this device information Apr 13 18:25:18 volumio volumio[883]: info: CoreCommandRouter::volumioGetState Apr 13 18:25:18 volumio volumio[883]: info: CorePlayQueue::getTrack 0 Apr 13 18:25:18 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 13 18:25:18 volumio volumio-remote-updater[667]: No test mode Apr 13 18:25:18 volumio volumio-remote-updater[667]: No alpha test mode Apr 13 18:25:18 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Apr 13 18:25:18 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 13 18:25:18 volumio volumio[883]: info: Successfully retrieved User Session From TIDAL Apr 13 18:25:18 volumio volumio[883]: info: Adding TIDAL to Browse Sources Apr 13 18:25:18 volumio volumio[883]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 13 18:25:18 volumio volumio[883]: info: [1713025518669] CoreMusicLibrary::Adding element TIDAL Apr 13 18:25:18 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 13 18:25:18 volumio volumio[883]: Cannot find translation for source TIDAL Apr 13 18:25:18 volumio volumio[883]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 13 18:25:18 volumio volumio[883]: info: Retrieving Cloud Streaming UI Apr 13 18:25:18 volumio volumio[883]: info: Getting Tidal Cloud Configuration Apr 13 18:25:18 volumio volumio[883]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 13 18:25:18 volumio volumio[883]: info: Getting Qobuz Cloud Configuration Apr 13 18:25:18 volumio volumio[883]: info: Asking plugin for UI Config Apr 13 18:25:18 volumio volumio[883]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 13 18:25:18 volumio volumio[883]: info: Getting Spotify Cloud Configuration Apr 13 18:25:18 volumio volumio[883]: info: Asking plugin for UI Config Apr 13 18:25:18 volumio volumio[883]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 13 18:25:18 volumio volumio[883]: info: Saving Spotify Acccount Apr 13 18:25:18 volumio volumio[883]: info: Got it Apr 13 18:25:18 volumio volumio[883]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Apr 13 18:25:18 volumio volumio[883]: info: Got Tidal Cloud Configuration Apr 13 18:25:18 volumio volumio[883]: info: Got it Apr 13 18:25:18 volumio volumio[883]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 13 18:25:19 volumio volumio[883]: info: Successfully retrieved User Subscription From TIDAL Apr 13 18:25:19 volumio volumio[883]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Apr 13 18:25:19 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Apr 13 18:25:20 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 13 18:25:20 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: wizard , getDonation Apr 13 18:25:20 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: my_volumio , detectVolumioHardware Apr 13 18:25:20 volumio volumio[883]: xcb_connection_has_error() returned true Apr 13 18:25:20 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: wizard , getDonationsArray Apr 13 18:25:20 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: wizard , getDoneMessage Apr 13 18:25:20 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: my_volumio , detectVolumioHardware Apr 13 18:25:20 volumio volumio[883]: xcb_connection_has_error() returned true Apr 13 18:25:21 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 13 18:25:23 volumio volumio[883]: info: CALLMETHOD: system_controller system saveUpdateSettings [object Object] Apr 13 18:25:23 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: system , saveUpdateSettings Apr 13 18:25:23 volumio volumio[883]: error: Failed callmethod call: TypeError: Cannot read property 'value' of undefined Apr 13 18:25:38 volumio ntpd[772]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Apr 13 18:25:51 volumio kernel: nvme nvme0: controller is down; will reset: CSTS=0xffffffff, PCI_STATUS=0xffff Apr 13 18:25:51 volumio kernel: nvme nvme0: Does your device have a faulty power saving mode enabled? Apr 13 18:25:51 volumio kernel: nvme nvme0: Try "nvme_core.default_ps_max_latency_us=0 pcie_aspm=off" and report a bug Apr 13 18:25:54 volumio kernel: nvme0n1: I/O Cmd(0x2) @ LBA 1398096, 8 blocks, I/O Error (sct 0x3 / sc 0x71) Apr 13 18:25:54 volumio kernel: I/O error, dev nvme0n1, sector 1398096 op 0x0:(READ) flags 0x80700 phys_seg 1 prio class 2 Apr 13 18:25:55 volumio kernel: nvme 0000:01:00.0: Unable to change power state from D3cold to D0, device inaccessible Apr 13 18:25:57 volumio kernel: nvme nvme0: Removing after probe failure status: -19 Apr 13 18:25:57 volumio kernel: Buffer I/O error on dev nvme0n1p1, logical block 105181, lost async page write Apr 13 18:25:57 volumio kernel: EXT4-fs warning (device nvme0n1p3): ext4_end_bio:347: I/O error 10 writing to inode 29067475 starting block 3766318) Apr 13 18:25:57 volumio kernel: I/O error, dev loop0, sector 914768 op 0x0:(READ) flags 0x800 phys_seg 29 prio class 2 Apr 13 18:25:57 volumio kernel: EXT4-fs warning (device nvme0n1p3): ext4_end_bio:347: I/O error 10 writing to inode 29067503 starting block 3766809) Apr 13 18:25:57 volumio kernel: Buffer I/O error on device nvme0n1p3, logical block 1032238 Apr 13 18:25:57 volumio kernel: Buffer I/O error on device nvme0n1p3, logical block 1032729 Apr 13 18:25:57 volumio kernel: Buffer I/O error on dev nvme0n1p1, logical block 372, lost async page write Apr 13 18:25:57 volumio kernel: SQUASHFS error: Failed to read block 0x1beaa184: -5 Apr 13 18:25:57 volumio kernel: nvme0n1: detected capacity change from 250069680 to 0 Apr 13 18:25:57 volumio kernel: I/O error, dev loop0, sector 914768 op 0x0:(READ) flags 0x800 phys_seg 29 prio class 2 Apr 13 18:25:57 volumio kernel: JBD2: Detected IO errors while flushing file data on nvme0n1p3-8 Apr 13 18:25:57 volumio kernel: SQUASHFS error: Failed to read block 0x1beaa184: -5 Apr 13 18:25:57 volumio kernel: Aborting journal on device nvme0n1p3-8. Apr 13 18:25:57 volumio kernel: SQUASHFS error: Unable to read data cache entry [1beaa184] Apr 13 18:25:57 volumio kernel: SQUASHFS error: Unable to read page, block 1beaa184, size 1c470 Apr 13 18:25:57 volumio kernel: Buffer I/O error on dev nvme0n1p3, logical block 65537, lost sync page write Apr 13 18:25:57 volumio kernel: JBD2: I/O error when updating journal superblock for nvme0n1p3-8. Apr 13 18:25:57 volumio kernel: EXT4-fs error (device nvme0n1p3) in ext4_setattr:5611: Journal has aborted Apr 13 18:25:57 volumio kernel: EXT4-fs (nvme0n1p3): ext4_writepages: jbd2_start: 1024 pages, ino 29067553; err -30 Apr 13 18:25:57 volumio kernel: Buffer I/O error on dev nvme0n1p3, logical block 68, lost async page write Apr 13 18:25:57 volumio kernel: Buffer I/O error on dev nvme0n1p3, logical block 69, lost async page write Apr 13 18:25:57 volumio kernel: Buffer I/O error on dev nvme0n1p3, logical block 70, lost async page write Apr 13 18:25:57 volumio kernel: Buffer I/O error on dev nvme0n1p3, logical block 119537697, lost async page write Apr 13 18:25:57 volumio kernel: Buffer I/O error on dev nvme0n1p3, logical block 119537703, lost async page write Apr 13 18:25:57 volumio kernel: Buffer I/O error on dev nvme0n1p3, logical block 119537705, lost async page write Apr 13 18:25:57 volumio kernel: Buffer I/O error on dev nvme0n1p3, logical block 119537720, lost async page write Apr 13 18:25:57 volumio volumio[883]: Configuration write error: Error: EROFS: read-only file system, open '/data/configuration/system_controller/system/config.json' Apr 13 18:25:57 volumio volumio[883]: info: CoreCommandRouter::executeOnPlugin: wizard , setWizardAction Apr 13 18:25:57 volumio kernel: EXT4-fs (nvme0n1p3): I/O error while writing superblock Apr 13 18:25:58 volumio kernel: EXT4-fs error (device nvme0n1p3): ext4_journal_check_start:83: comm rm: Detected aborted journal Apr 13 18:25:58 volumio kernel: EXT4-fs (nvme0n1p3): I/O error while writing superblock Apr 13 18:25:58 volumio kernel: EXT4-fs (nvme0n1p3): Remounting filesystem read-only Apr 13 18:25:58 volumio volumio[883]: /bin/rm: cannot remove '/data/wizard': Read-only file system Apr 13 18:25:58 volumio volumio[883]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 13 18:25:58 volumio volumio[883]: Error: Command failed: /bin/rm -f /data/wizard Apr 13 18:25:58 volumio volumio[883]: /bin/rm: cannot remove '/data/wizard': Read-only file system Apr 13 18:25:58 volumio volumio[883]: at checkExecSyncError (child_process.js:616:11) Apr 13 18:25:58 volumio volumio[883]: at execSync (child_process.js:652:15) Apr 13 18:25:58 volumio volumio[883]: at volumioWizard.setCloseWizard (/volumio/app/plugins/miscellanea/wizard/index.js:304:3) Apr 13 18:25:58 volumio volumio[883]: at volumioWizard.setWizardAction (/volumio/app/plugins/miscellanea/wizard/index.js:266:14) Apr 13 18:25:58 volumio volumio[883]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1077:32) Apr 13 18:25:58 volumio volumio[883]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1566:33) Apr 13 18:25:58 volumio volumio[883]: at Socket.emit (events.js:315:20) Apr 13 18:25:58 volumio volumio[883]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Apr 13 18:25:58 volumio volumio[883]: at processTicksAndRejections (internal/process/task_queues.js:75:11) { Apr 13 18:25:58 volumio volumio[883]: status: 1, Apr 13 18:25:58 volumio volumio[883]: signal: null, Apr 13 18:25:58 volumio volumio[883]: output: [ Apr 13 18:25:58 volumio volumio[883]: null, Apr 13 18:25:58 volumio volumio[883]: , Apr 13 18:25:58 volumio volumio[883]: Apr 13 18:25:58 volumio volumio[883]: ], Apr 13 18:25:58 volumio volumio[883]: pid: 2003, Apr 13 18:25:58 volumio volumio[883]: stdout: , Apr 13 18:25:58 volumio volumio[883]: stderr: Apr 13 18:25:58 volumio volumio[883]: } Apr 13 18:25:58 volumio volumio[883]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 13 18:25:58 volumio systemd[1]: Stopped target Local File Systems. Apr 13 18:25:58 volumio systemd[1]: Unmounting /boot... Apr 13 18:25:58 volumio systemd[2015]: boot.mount: Failed to execute command: Input/output error Apr 13 18:25:58 volumio systemd[2015]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error Apr 13 18:25:58 volumio systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC Apr 13 18:25:58 volumio systemd[1]: Failed unmounting /boot. Apr 13 18:25:58 volumio systemd[1]: boot.mount: Unit is bound to inactive unit dev-disk-by\x2duuid-9AB2\x2d0FD6.device. Stopping, too. Apr 13 18:25:58 volumio systemd[1]: Unmounting /boot... Apr 13 18:25:58 volumio kernel: EXT4-fs error (device nvme0n1p3): __ext4_find_entry:1684: inode #29067304: comm (umount): reading directory lblock 0 Apr 13 18:25:58 volumio kernel: EXT4-fs error (device nvme0n1p3): __ext4_find_entry:1684: inode #29067304: comm (umount): reading directory lblock 0 Apr 13 18:25:58 volumio systemd[2016]: boot.mount: Failed to execute command: Input/output error Apr 13 18:25:58 volumio systemd[2016]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error Apr 13 18:25:58 volumio systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC Apr 13 18:25:58 volumio systemd[1]: Failed unmounting /boot. Apr 13 18:25:58 volumio systemd[1]: boot.mount: Unit is bound to inactive unit dev-disk-by\x2duuid-9AB2\x2d0FD6.device. Stopping, too. Apr 13 18:25:58 volumio systemd[1]: Unmounting /boot... Apr 13 18:25:58 volumio systemd[2017]: boot.mount: Failed to execute command: Input/output error Apr 13 18:25:58 volumio systemd[2017]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error Apr 13 18:25:58 volumio systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC Apr 13 18:25:58 volumio systemd[1]: Failed unmounting /boot. Apr 13 18:25:58 volumio systemd[1]: boot.mount: Unit is bound to inactive unit dev-disk-by\x2duuid-9AB2\x2d0FD6.device. Stopping, too. Apr 13 18:25:58 volumio kernel: EXT4-fs error (device nvme0n1p3): __ext4_find_entry:1684: inode #29067304: comm (umount): reading directory lblock 0 Apr 13 18:25:58 volumio systemd[1]: Unmounting /boot... Apr 13 18:25:58 volumio systemd[2018]: boot.mount: Failed to execute command: Input/output error Apr 13 18:25:58 volumio systemd[2018]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error Apr 13 18:25:58 volumio systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC Apr 13 18:25:58 volumio systemd[1]: Failed unmounting /boot. Apr 13 18:25:58 volumio systemd[1]: boot.mount: Unit is bound to inactive unit dev-disk-by\x2duuid-9AB2\x2d0FD6.device. Stopping, too. Apr 13 18:25:58 volumio kernel: EXT4-fs error (device nvme0n1p3): __ext4_find_entry:1684: inode #29067304: comm (umount): reading directory lblock 0 Apr 13 18:25:58 volumio systemd[1]: Unmounting /boot... Apr 13 18:25:58 volumio systemd[2019]: boot.mount: Failed to execute command: Input/output error Apr 13 18:25:58 volumio systemd[2019]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error Apr 13 18:25:58 volumio systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC Apr 13 18:25:58 volumio systemd[1]: Failed unmounting /boot. Apr 13 18:25:58 volumio systemd[1]: boot.mount: Unit is bound to inactive unit dev-disk-by\x2duuid-9AB2\x2d0FD6.device. Stopping, too. Apr 13 18:25:58 volumio kernel: EXT4-fs error (device nvme0n1p3): __ext4_find_entry:1684: inode #29067304: comm (umount): reading directory lblock 0 Apr 13 18:25:58 volumio kernel: EXT4-fs error (device nvme0n1p3): __ext4_find_entry:1684: inode #29067304: comm (umount): reading directory lblock 0 Apr 13 18:25:58 volumio systemd[1]: Unmounting /boot... Apr 13 18:25:58 volumio sudo[2021]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-13 18:24 Apr 13 18:25:58 volumio sudo[2021]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 13 18:25:58 volumio systemd[2022]: boot.mount: Failed to execute command: Input/output error Apr 13 18:25:58 volumio systemd[2022]: boot.mount: Failed at step EXEC spawning /bin/umount: Input/output error Apr 13 18:25:58 volumio systemd[1]: boot.mount: Mount process exited, code=exited, status=203/EXEC Apr 13 18:25:58 volumio systemd[1]: Failed unmounting /boot. Apr 13 18:25:58 volumio systemd[1]: boot.mount: Unit is bound to inactive unit dev-disk-by\x2duuid-9AB2\x2d0FD6.device. Stopping, too. Apr 13 18:25:58 volumio systemd[1]: Unmounting /boot... 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="8c0a8dce3a0435348590f0697c09ba39bd364767" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="c45f0e51c865f04fd4ec5869da59c5cfafdd1447" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 13 Mar 2024 09:16:28 PM CET" VOLUMIO_VERSION="3.639" VOLUMIO_HARDWARE="pi-uuid" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="5ba27c8c056b5ac07204061da58c4e30"