-- Logs begin at Mon 2025-06-09 05:20:54 JST, end at Mon 2025-06-09 05:59:45 JST. -- Jun 09 05:58:04 kaitef-rivo volumio-time-update[2825]: volumio-time-update-util: Fetching time from Volumio... Jun 09 05:58:08 kaitef-rivo ntpd[3053]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Jun 09 05:58:11 kaitef-rivo go-librespot[11631]: time="2025-06-09T05:58:11+09:00" level=fatal msg="failed running zeroconf" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Jun 09 05:58:11 kaitef-rivo systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jun 09 05:58:11 kaitef-rivo systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jun 09 05:58:11 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Jun 09 05:58:14 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Jun 09 05:58:14 kaitef-rivo systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Jun 09 05:58:14 kaitef-rivo systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 93. Jun 09 05:58:14 kaitef-rivo systemd[1]: Stopped go-librespot Daemon. Jun 09 05:58:14 kaitef-rivo systemd[1]: Started go-librespot Daemon. Jun 09 05:58:14 kaitef-rivo go-librespot[11739]: go-librespot daemon starting... Jun 09 05:58:14 kaitef-rivo go-librespot[11739]: time="2025-06-09T05:58:14+09:00" level=info msg="running go-librespot 0.1.3" Jun 09 05:58:14 kaitef-rivo go-librespot[11739]: time="2025-06-09T05:58:14+09:00" level=debug msg="app state loaded" Jun 09 05:58:14 kaitef-rivo go-librespot[11739]: time="2025-06-09T05:58:14+09:00" level=debug msg="stored credentials not found" Jun 09 05:58:14 kaitef-rivo go-librespot[11739]: time="2025-06-09T05:58:14+09:00" level=info msg="api server listening on 127.0.0.1:9879" Jun 09 05:58:24 kaitef-rivo volumio-time-update[2825]: volumio-time-update-util: Date not found in response Jun 09 05:58:24 kaitef-rivo volumio-time-update[2825]: volumio-time-update-util: Retrying in 5 seconds... Jun 09 05:58:28 kaitef-rivo ntpd[3053]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Jun 09 05:58:29 kaitef-rivo volumio-time-update[2825]: volumio-time-update-util: Fetching time from Volumio... Jun 09 05:58:31 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Jun 09 05:58:34 kaitef-rivo go-librespot[11739]: time="2025-06-09T05:58:34+09:00" level=fatal msg="failed running zeroconf" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Jun 09 05:58:34 kaitef-rivo systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jun 09 05:58:34 kaitef-rivo systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jun 09 05:58:37 kaitef-rivo systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Jun 09 05:58:37 kaitef-rivo systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 94. Jun 09 05:58:37 kaitef-rivo systemd[1]: Stopped go-librespot Daemon. Jun 09 05:58:37 kaitef-rivo systemd[1]: Started go-librespot Daemon. Jun 09 05:58:37 kaitef-rivo go-librespot[11813]: go-librespot daemon starting... Jun 09 05:58:37 kaitef-rivo go-librespot[11813]: time="2025-06-09T05:58:37+09:00" level=info msg="running go-librespot 0.1.3" Jun 09 05:58:37 kaitef-rivo go-librespot[11813]: time="2025-06-09T05:58:37+09:00" level=debug msg="app state loaded" Jun 09 05:58:37 kaitef-rivo go-librespot[11813]: time="2025-06-09T05:58:37+09:00" level=debug msg="stored credentials not found" Jun 09 05:58:37 kaitef-rivo go-librespot[11813]: time="2025-06-09T05:58:37+09:00" level=info msg="api server listening on 127.0.0.1:9879" Jun 09 05:58:48 kaitef-rivo ntpd[3053]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Jun 09 05:58:49 kaitef-rivo volumio-time-update[2825]: volumio-time-update-util: Date not found in response Jun 09 05:58:49 kaitef-rivo volumio-time-update[2825]: volumio-time-update-util: Retrying in 5 seconds... Jun 09 05:58:51 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Jun 09 05:58:54 kaitef-rivo volumio-time-update[2825]: volumio-time-update-util: Fetching time from Volumio... Jun 09 05:58:58 kaitef-rivo go-librespot[11813]: time="2025-06-09T05:58:58+09:00" level=fatal msg="failed running zeroconf" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Jun 09 05:58:58 kaitef-rivo systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jun 09 05:58:58 kaitef-rivo systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jun 09 05:59:01 kaitef-rivo systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Jun 09 05:59:01 kaitef-rivo systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 95. Jun 09 05:59:01 kaitef-rivo systemd[1]: Stopped go-librespot Daemon. Jun 09 05:59:01 kaitef-rivo systemd[1]: Started go-librespot Daemon. Jun 09 05:59:01 kaitef-rivo go-librespot[11872]: go-librespot daemon starting... Jun 09 05:59:01 kaitef-rivo go-librespot[11872]: time="2025-06-09T05:59:01+09:00" level=info msg="running go-librespot 0.1.3" Jun 09 05:59:01 kaitef-rivo go-librespot[11872]: time="2025-06-09T05:59:01+09:00" level=debug msg="app state loaded" Jun 09 05:59:01 kaitef-rivo go-librespot[11872]: time="2025-06-09T05:59:01+09:00" level=debug msg="stored credentials not found" Jun 09 05:59:01 kaitef-rivo go-librespot[11872]: time="2025-06-09T05:59:01+09:00" level=info msg="api server listening on 127.0.0.1:9879" Jun 09 05:59:08 kaitef-rivo ntpd[3053]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Jun 09 05:59:11 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Jun 09 05:59:11 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Jun 09 05:59:12 kaitef-rivo kernel: usb 1-1.4.2: new high-speed USB device number 5 using xhci-hcd Jun 09 05:59:12 kaitef-rivo kernel: usb 1-1.4.2: New USB device found, idVendor=0644, idProduct=806b Jun 09 05:59:12 kaitef-rivo kernel: usb 1-1.4.2: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Jun 09 05:59:12 kaitef-rivo kernel: usb 1-1.4.2: Product: MODEL_NAME Jun 09 05:59:12 kaitef-rivo kernel: usb 1-1.4.2: Manufacturer: TEAC Corporation Jun 09 05:59:12 kaitef-rivo kernel: [28B blob data] Jun 09 05:59:12 kaitef-rivo kernel: usb 1-1.4.2: Unsupported device Jun 09 05:59:12 kaitef-rivo kernel: usb 1-1.4.2: Unsupported device Jun 09 05:59:12 kaitef-rivo kernel: hid-generic 0003:0644:806B.0001: hiddev0,hidraw0: USB HID v1.10 Device [TEAC Corporation MODEL_NAME] on usb-xhci-hcd.0.auto-1.4.2/input2 Jun 09 05:59:12 kaitef-rivo kernel: hid-generic 0003:0644:806B.0002: hiddev0,hidraw1: USB HID v1.10 Device [TEAC Corporation MODEL_NAME] on usb-xhci-hcd.0.auto-1.4.2/input3 Jun 09 05:59:13 kaitef-rivo kernel: usbcore: registered new interface driver snd-usb-audio Jun 09 05:59:13 kaitef-rivo volumio[3269]: info: Jun 09 05:59:13 kaitef-rivo volumio[3269]: ---------------------------- USB Audio Device Attached Jun 09 05:59:13 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Jun 09 05:59:13 kaitef-rivo volumio[3269]: No protocol specified Jun 09 05:59:13 kaitef-rivo volumio[3269]: xcb_connection_has_error() returned true Jun 09 05:59:13 kaitef-rivo volumio[3269]: info: CoreCommandRouter::Close All Modals sent Jun 09 05:59:13 kaitef-rivo volumio[3269]: info: Preparing to save Alsa Options, stopping services first Jun 09 05:59:13 kaitef-rivo volumio[3269]: info: CoreCommandRouter::volumioGetState Jun 09 05:59:13 kaitef-rivo volumio[3269]: info: CorePlayQueue::getTrack 0 Jun 09 05:59:13 kaitef-rivo volumio[3269]: info: CoreCommandRouter::volumioPause Jun 09 05:59:13 kaitef-rivo volumio[3269]: info: CoreStateMachine::pause Jun 09 05:59:13 kaitef-rivo volumio[3269]: info: Saving Audio Output to: {"disallowPush":true,"output_device":{"value":"5","label":"MODEL_NAME","alsacard":"MODELNAME"},"i2s":false} Jun 09 05:59:13 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jun 09 05:59:13 kaitef-rivo volumio[3269]: No protocol specified Jun 09 05:59:13 kaitef-rivo volumio[3269]: xcb_connection_has_error() returned true Jun 09 05:59:13 kaitef-rivo volumio[3269]: No protocol specified Jun 09 05:59:13 kaitef-rivo volumio[3269]: xcb_connection_has_error() returned true Jun 09 05:59:13 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jun 09 05:59:13 kaitef-rivo volumio[3269]: No protocol specified Jun 09 05:59:13 kaitef-rivo volumio[3269]: xcb_connection_has_error() returned true Jun 09 05:59:13 kaitef-rivo volumio[3269]: info: Setting mixer PCM for card MODEL_NAME Jun 09 05:59:13 kaitef-rivo volumio[3269]: info: Reconfiguring and Restarting RAAT Plugin due to audio path changes Jun 09 05:59:13 kaitef-rivo vtcs[4184]: [2025-06-09 05:59:13.613] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE Jun 09 05:59:13 kaitef-rivo vtcs[4184]: [2025-06-09 05:59:13.616] [tisoc] [error] [SpkconServer.cpp:380] recv error. client fd=8 errorno=104 error=Connection reset by peer Jun 09 05:59:13 kaitef-rivo vtcs[4184]: [2025-06-09 05:59:13.616] [tisoc] [error] [SpkconServer.cpp:375] recv error. socket disconnected Jun 09 05:59:13 kaitef-rivo sudo[11961]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jun 09 05:59:13 kaitef-rivo sudo[11961]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 09 05:59:13 kaitef-rivo systemd[1]: Stopping Volumio Tidal Connect Service... Jun 09 05:59:13 kaitef-rivo systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Jun 09 05:59:13 kaitef-rivo systemd[1]: vtcs.service: Succeeded. Jun 09 05:59:13 kaitef-rivo systemd[1]: Stopped Volumio Tidal Connect Service. Jun 09 05:59:13 kaitef-rivo sudo[11961]: pam_unix(sudo:session): session closed for user root Jun 09 05:59:13 kaitef-rivo volumio[3269]: No protocol specified Jun 09 05:59:13 kaitef-rivo volumio[3269]: xcb_connection_has_error() returned true Jun 09 05:59:13 kaitef-rivo volumio[3269]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jun 09 05:59:13 kaitef-rivo volumio[3269]: info: Updating Volume Controller Parameters: Device: 5 Name: MODEL_NAME Mixer: PCM Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Jun 09 05:59:13 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Jun 09 05:59:13 kaitef-rivo volumio[3269]: info: Disabling external Volume Control Jun 09 05:59:13 kaitef-rivo volumio[3269]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 09 05:59:13 kaitef-rivo volumio[3269]: info: Preparing to generate the ALSA configuration file Jun 09 05:59:13 kaitef-rivo volumio[3269]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jun 09 05:59:13 kaitef-rivo volumio[3269]: info: Reading ALSA contributions from plugins. Jun 09 05:59:13 kaitef-rivo volumio[3269]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 09 05:59:13 kaitef-rivo sudo[11969]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jun 09 05:59:13 kaitef-rivo sudo[11969]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 09 05:59:13 kaitef-rivo volumio[3269]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: No protocol specified Jun 09 05:59:13 kaitef-rivo volumio[3269]: xcb_connection_has_error() returned true Jun 09 05:59:13 kaitef-rivo sudo[11969]: pam_unix(sudo:session): session closed for user root Jun 09 05:59:14 kaitef-rivo volumio[3269]: No protocol specified Jun 09 05:59:14 kaitef-rivo volumio[3269]: xcb_connection_has_error() returned true Jun 09 05:59:14 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jun 09 05:59:14 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 09 05:59:14 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jun 09 05:59:14 kaitef-rivo volumio[3269]: No protocol specified Jun 09 05:59:14 kaitef-rivo volumio[3269]: xcb_connection_has_error() returned true Jun 09 05:59:14 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 09 05:59:14 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 09 05:59:14 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 09 05:59:14 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 09 05:59:14 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 09 05:59:14 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 09 05:59:14 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 09 05:59:14 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jun 09 05:59:14 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jun 09 05:59:14 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: raat , getAdditionalUiSection Jun 09 05:59:14 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 09 05:59:14 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 09 05:59:14 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 09 05:59:14 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 09 05:59:14 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 09 05:59:14 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 09 05:59:14 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 09 05:59:14 kaitef-rivo volumio[3269]: info: Not Reporting Auto name since its the default one Jun 09 05:59:14 kaitef-rivo volumio[3269]: info: VolumeController:: Volume=undefined Mute =false Jun 09 05:59:14 kaitef-rivo volumio[3269]: info: CoreStateMachine::pushState Jun 09 05:59:14 kaitef-rivo volumio[3269]: info: CorePlayQueue::getTrack 0 Jun 09 05:59:14 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 09 05:59:14 kaitef-rivo volumio[3269]: info: CoreCommandRouter::volumioPushState Jun 09 05:59:14 kaitef-rivo volumio[3269]: info: MRS: Pushing multiroomSync output update for this device Jun 09 05:59:14 kaitef-rivo volumio-time-update[2825]: volumio-time-update-util: Date not found in response Jun 09 05:59:14 kaitef-rivo volumio-time-update[2825]: volumio-time-update-util: Retrying in 5 seconds... Jun 09 05:59:14 kaitef-rivo volumio[3269]: info: MRS: Pushing multiroomSync output Jun 09 05:59:14 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat Jun 09 05:59:14 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 09 05:59:14 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 09 05:59:14 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 09 05:59:14 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 09 05:59:14 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 09 05:59:14 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 09 05:59:14 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 09 05:59:14 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 09 05:59:14 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 09 05:59:14 kaitef-rivo volumio[3269]: info: Not Reporting Auto name since its the default one Jun 09 05:59:14 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 09 05:59:14 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 09 05:59:14 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Jun 09 05:59:14 kaitef-rivo volumio[3269]: No protocol specified Jun 09 05:59:14 kaitef-rivo volumio[3269]: xcb_connection_has_error() returned true Jun 09 05:59:14 kaitef-rivo volumio[3269]: info: Asound.conf file unchanged, so no further update is needed Jun 09 05:59:14 kaitef-rivo volumio[3269]: info: Output device has changed, restarting MPD Jun 09 05:59:14 kaitef-rivo sudo[11989]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Jun 09 05:59:14 kaitef-rivo sudo[11989]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 09 05:59:14 kaitef-rivo sudo[11989]: pam_unix(sudo:session): session closed for user root Jun 09 05:59:14 kaitef-rivo sudo[11992]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 09 05:59:14 kaitef-rivo sudo[11992]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 09 05:59:14 kaitef-rivo sudo[11993]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Jun 09 05:59:14 kaitef-rivo sudo[11993]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 09 05:59:14 kaitef-rivo sudo[11992]: pam_unix(sudo:session): session closed for user root Jun 09 05:59:14 kaitef-rivo volumio[3269]: info: Output device has changed, restarting Shairport Sync Jun 09 05:59:14 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 09 05:59:14 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 09 05:59:14 kaitef-rivo sudo[11997]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 09 05:59:14 kaitef-rivo sudo[11997]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 09 05:59:14 kaitef-rivo systemd[1]: Started RAAT DAEMON. Jun 09 05:59:14 kaitef-rivo sudo[11993]: pam_unix(sudo:session): session closed for user root Jun 09 05:59:14 kaitef-rivo systemd[1]: Stopping Music Player Daemon... Jun 09 05:59:14 kaitef-rivo volumio[3269]: No protocol specified Jun 09 05:59:14 kaitef-rivo volumio[3269]: xcb_connection_has_error() returned true Jun 09 05:59:14 kaitef-rivo volumio[3269]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 09 05:59:14 kaitef-rivo volumio[3269]: No protocol specified Jun 09 05:59:14 kaitef-rivo volumio[3269]: xcb_connection_has_error() returned true Jun 09 05:59:14 kaitef-rivo volumio[3269]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jun 09 05:59:14 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 09 05:59:14 kaitef-rivo systemd[1]: mpd.service: Succeeded. Jun 09 05:59:14 kaitef-rivo systemd[1]: Stopped Music Player Daemon. Jun 09 05:59:14 kaitef-rivo systemd[1]: Starting Music Player Daemon... Jun 09 05:59:14 kaitef-rivo volumio[3269]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes Jun 09 05:59:14 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 09 05:59:14 kaitef-rivo sudo[12011]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jun 09 05:59:14 kaitef-rivo sudo[12011]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 09 05:59:14 kaitef-rivo volumio[3269]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 09 05:59:14 kaitef-rivo volumio[3269]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jun 09 05:59:14 kaitef-rivo volumio[3269]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 09 05:59:14 kaitef-rivo volumio[3269]: info: MPD Permissions set Jun 09 05:59:14 kaitef-rivo volumio[3269]: info: Raat Daemon started successfully Jun 09 05:59:14 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Jun 09 05:59:14 kaitef-rivo sudo[12014]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jun 09 05:59:14 kaitef-rivo sudo[12014]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 09 05:59:14 kaitef-rivo sudo[12011]: pam_unix(sudo:session): session closed for user root Jun 09 05:59:14 kaitef-rivo sudo[12008]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 09 05:59:14 kaitef-rivo sudo[12008]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 09 05:59:14 kaitef-rivo sudo[12008]: pam_unix(sudo:session): session closed for user root Jun 09 05:59:14 kaitef-rivo sudo[12014]: pam_unix(sudo:session): session closed for user root Jun 09 05:59:14 kaitef-rivo volumio[3269]: No protocol specified Jun 09 05:59:14 kaitef-rivo volumio[3269]: xcb_connection_has_error() returned true Jun 09 05:59:15 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 09 05:59:15 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 09 05:59:15 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 09 05:59:15 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 09 05:59:15 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 09 05:59:15 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 09 05:59:15 kaitef-rivo sudo[12026]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Jun 09 05:59:15 kaitef-rivo sudo[12026]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 09 05:59:15 kaitef-rivo sudo[12026]: pam_unix(sudo:session): session closed for user root Jun 09 05:59:15 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 09 05:59:15 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jun 09 05:59:15 kaitef-rivo sudo[12032]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Jun 09 05:59:15 kaitef-rivo sudo[12032]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 09 05:59:15 kaitef-rivo systemd[1]: Stopping RAAT DAEMON... Jun 09 05:59:15 kaitef-rivo systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM Jun 09 05:59:15 kaitef-rivo systemd[1]: raat-daemon.service: Succeeded. Jun 09 05:59:15 kaitef-rivo systemd[1]: Stopped RAAT DAEMON. Jun 09 05:59:15 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 09 05:59:15 kaitef-rivo systemd[1]: Started RAAT DAEMON. Jun 09 05:59:15 kaitef-rivo sudo[12032]: pam_unix(sudo:session): session closed for user root Jun 09 05:59:15 kaitef-rivo volumio[3269]: info: VolumeController::SetAlsaVolume0 Jun 09 05:59:15 kaitef-rivo volumio[3269]: info: CoreStateMachine::pushState Jun 09 05:59:15 kaitef-rivo volumio[3269]: info: CorePlayQueue::getTrack 0 Jun 09 05:59:15 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 09 05:59:15 kaitef-rivo volumio[3269]: info: CoreCommandRouter::volumioPushState Jun 09 05:59:15 kaitef-rivo volumio[3269]: info: MRS: Pushing multiroomSync output update for this device Jun 09 05:59:15 kaitef-rivo volumio[3269]: info: MRS: Pushing multiroomSync output Jun 09 05:59:15 kaitef-rivo volumio[3269]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 09 05:59:15 kaitef-rivo volumio[3269]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jun 09 05:59:15 kaitef-rivo volumio[3269]: info: Raat Daemon started successfully Jun 09 05:59:15 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 09 05:59:15 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 09 05:59:15 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 09 05:59:15 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 09 05:59:15 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 09 05:59:15 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 09 05:59:15 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 09 05:59:15 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 09 05:59:15 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 09 05:59:15 kaitef-rivo volumio[3269]: info: Not Reporting Auto name since its the default one Jun 09 05:59:15 kaitef-rivo volumio[3269]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: No protocol specified Jun 09 05:59:15 kaitef-rivo volumio[3269]: xcb_connection_has_error() returned true Jun 09 05:59:15 kaitef-rivo volumio[3269]: info: Starting Shairport Sync Jun 09 05:59:15 kaitef-rivo volumio[3269]: info: Executing endpoint restartRAATSocket Jun 09 05:59:15 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Jun 09 05:59:15 kaitef-rivo sudo[12054]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 09 05:59:15 kaitef-rivo sudo[12054]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 09 05:59:15 kaitef-rivo volumio[3269]: info: Preparing to generate the ALSA configuration file Jun 09 05:59:15 kaitef-rivo systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jun 09 05:59:15 kaitef-rivo systemd[1]: shairport-sync.service: Succeeded. Jun 09 05:59:15 kaitef-rivo systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jun 09 05:59:15 kaitef-rivo systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 09 05:59:15 kaitef-rivo volumio[3269]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jun 09 05:59:15 kaitef-rivo sudo[12054]: pam_unix(sudo:session): session closed for user root Jun 09 05:59:15 kaitef-rivo volumio[3269]: info: Reading ALSA contributions from plugins. Jun 09 05:59:15 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Jun 09 05:59:15 kaitef-rivo volumio[3269]: No protocol specified Jun 09 05:59:15 kaitef-rivo volumio[3269]: xcb_connection_has_error() returned true Jun 09 05:59:15 kaitef-rivo volumio[3269]: info: CorePlayQueue::getTrack 0 Jun 09 05:59:15 kaitef-rivo volumio[3269]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 09 05:59:15 kaitef-rivo volumio[3269]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jun 09 05:59:15 kaitef-rivo volumio[3269]: info: MCU Signalled Sleep Mode Disabled Jun 09 05:59:15 kaitef-rivo sudo[12064]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Jun 09 05:59:15 kaitef-rivo sudo[12064]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 09 05:59:15 kaitef-rivo sudo[12064]: pam_unix(sudo:session): session closed for user root Jun 09 05:59:15 kaitef-rivo volumio[3269]: info: Shairport-Sync Started Jun 09 05:59:15 kaitef-rivo volumio[3269]: info: Asound.conf file unchanged, so no further update is needed Jun 09 05:59:15 kaitef-rivo volumio[3269]: info: Output device has changed, restarting MPD Jun 09 05:59:15 kaitef-rivo sudo[12067]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Jun 09 05:59:15 kaitef-rivo sudo[12067]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 09 05:59:15 kaitef-rivo sudo[12068]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/xset dpms force on Jun 09 05:59:15 kaitef-rivo sudo[12068]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 09 05:59:15 kaitef-rivo kernel: fb: osd[0] enable: 1 (Xorg) Jun 09 05:59:15 kaitef-rivo kernel: fb: osd[0] enable: 1 (Xorg) Jun 09 05:59:15 kaitef-rivo sudo[12068]: pam_unix(sudo:session): session closed for user root Jun 09 05:59:15 kaitef-rivo systemd[1]: Stopping RAAT DAEMON... Jun 09 05:59:15 kaitef-rivo systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM Jun 09 05:59:15 kaitef-rivo systemd[1]: raat-daemon.service: Succeeded. Jun 09 05:59:15 kaitef-rivo systemd[1]: Stopped RAAT DAEMON. Jun 09 05:59:15 kaitef-rivo systemd[1]: Started RAAT DAEMON. Jun 09 05:59:15 kaitef-rivo sudo[12067]: pam_unix(sudo:session): session closed for user root Jun 09 05:59:15 kaitef-rivo sudo[12072]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 09 05:59:15 kaitef-rivo sudo[12072]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 09 05:59:15 kaitef-rivo sudo[12072]: pam_unix(sudo:session): session closed for user root Jun 09 05:59:15 kaitef-rivo volumio[3269]: info: Output device has changed, restarting Shairport Sync Jun 09 05:59:15 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 09 05:59:15 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 09 05:59:15 kaitef-rivo sudo[12081]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 09 05:59:15 kaitef-rivo sudo[12081]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 09 05:59:16 kaitef-rivo volumio[3269]: No protocol specified Jun 09 05:59:16 kaitef-rivo volumio[3269]: xcb_connection_has_error() returned true Jun 09 05:59:16 kaitef-rivo volumio[3269]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 09 05:59:16 kaitef-rivo volumio[3269]: No protocol specified Jun 09 05:59:16 kaitef-rivo volumio[3269]: xcb_connection_has_error() returned true Jun 09 05:59:16 kaitef-rivo volumio[3269]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jun 09 05:59:16 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 09 05:59:16 kaitef-rivo systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Jun 09 05:59:16 kaitef-rivo systemd[1]: mpd.service: Succeeded. Jun 09 05:59:16 kaitef-rivo systemd[1]: Stopped Music Player Daemon. Jun 09 05:59:16 kaitef-rivo systemd[1]: Starting Music Player Daemon... Jun 09 05:59:16 kaitef-rivo volumio[3269]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes Jun 09 05:59:16 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 09 05:59:16 kaitef-rivo sudo[12104]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jun 09 05:59:16 kaitef-rivo sudo[12104]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 09 05:59:16 kaitef-rivo volumio[3269]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 09 05:59:16 kaitef-rivo volumio[3269]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jun 09 05:59:16 kaitef-rivo volumio[3269]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jun 09 05:59:16 kaitef-rivo sudo[12113]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jun 09 05:59:16 kaitef-rivo sudo[12113]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 09 05:59:16 kaitef-rivo volumio[3269]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 09 05:59:16 kaitef-rivo volumio[3269]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jun 09 05:59:16 kaitef-rivo volumio[3269]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 09 05:59:16 kaitef-rivo sudo[12092]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 09 05:59:16 kaitef-rivo sudo[12092]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 09 05:59:16 kaitef-rivo volumio[3269]: info: MPD Permissions set Jun 09 05:59:16 kaitef-rivo volumio[3269]: info: Raat Daemon started successfully Jun 09 05:59:16 kaitef-rivo sudo[12092]: pam_unix(sudo:session): session closed for user root Jun 09 05:59:16 kaitef-rivo sudo[12104]: pam_unix(sudo:session): session closed for user root Jun 09 05:59:16 kaitef-rivo volumio[3269]: info: Executing endpoint restartRAATSocket Jun 09 05:59:16 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Jun 09 05:59:16 kaitef-rivo sudo[12113]: pam_unix(sudo:session): session closed for user root Jun 09 05:59:16 kaitef-rivo sudo[12121]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/xset dpms 0 0 0 Jun 09 05:59:16 kaitef-rivo sudo[12121]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 09 05:59:16 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 09 05:59:16 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 09 05:59:16 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 09 05:59:16 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 09 05:59:16 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 09 05:59:16 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 09 05:59:16 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 09 05:59:16 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 09 05:59:16 kaitef-rivo sudo[12121]: pam_unix(sudo:session): session closed for user root Jun 09 05:59:16 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 09 05:59:16 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jun 09 05:59:16 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 09 05:59:16 kaitef-rivo volumio[3269]: info: CorePlayQueue::getTrack 0 Jun 09 05:59:16 kaitef-rivo volumio[3269]: info: Starting Shairport Sync Jun 09 05:59:16 kaitef-rivo sudo[12132]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 09 05:59:16 kaitef-rivo sudo[12132]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 09 05:59:16 kaitef-rivo systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jun 09 05:59:16 kaitef-rivo systemd[1]: shairport-sync.service: Succeeded. Jun 09 05:59:16 kaitef-rivo systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jun 09 05:59:16 kaitef-rivo systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 09 05:59:16 kaitef-rivo volumio[3269]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 09 05:59:16 kaitef-rivo sudo[12132]: pam_unix(sudo:session): session closed for user root Jun 09 05:59:16 kaitef-rivo volumio[3269]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jun 09 05:59:16 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 09 05:59:16 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 09 05:59:16 kaitef-rivo volumio[3269]: info: Not Reporting Auto name since its the default one Jun 09 05:59:16 kaitef-rivo volumio[3269]: info: Shairport-Sync Started Jun 09 05:59:16 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Jun 09 05:59:16 kaitef-rivo volumio[3269]: No protocol specified Jun 09 05:59:16 kaitef-rivo volumio[3269]: xcb_connection_has_error() returned true Jun 09 05:59:16 kaitef-rivo volumio[3269]: info: TidalConnect service stoped! Jun 09 05:59:16 kaitef-rivo sudo[12145]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Jun 09 05:59:16 kaitef-rivo sudo[12145]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 09 05:59:16 kaitef-rivo sudo[12145]: pam_unix(sudo:session): session closed for user root Jun 09 05:59:16 kaitef-rivo sudo[12147]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Jun 09 05:59:16 kaitef-rivo sudo[12147]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 09 05:59:16 kaitef-rivo systemd[1]: Stopping RAAT DAEMON... Jun 09 05:59:16 kaitef-rivo systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM Jun 09 05:59:16 kaitef-rivo systemd[1]: raat-daemon.service: Succeeded. Jun 09 05:59:16 kaitef-rivo volumio[3269]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 09 05:59:16 kaitef-rivo systemd[1]: Stopped RAAT DAEMON. Jun 09 05:59:16 kaitef-rivo volumio[3269]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jun 09 05:59:16 kaitef-rivo systemd[1]: Started RAAT DAEMON. Jun 09 05:59:16 kaitef-rivo sudo[12147]: pam_unix(sudo:session): session closed for user root Jun 09 05:59:16 kaitef-rivo volumio[3269]: info: Raat Daemon started successfully Jun 09 05:59:16 kaitef-rivo volumio[3269]: info: TidalConnect service stoped! Jun 09 05:59:17 kaitef-rivo volumio[3269]: info: Executing endpoint restartRAATSocket Jun 09 05:59:17 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Jun 09 05:59:17 kaitef-rivo volumio[3269]: info: CorePlayQueue::getTrack 0 Jun 09 05:59:17 kaitef-rivo volumio[3269]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jun 09 05:59:17 kaitef-rivo volumio[3269]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Jun 09 05:59:17 kaitef-rivo sudo[12169]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jun 09 05:59:17 kaitef-rivo sudo[12169]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 09 05:59:17 kaitef-rivo systemd[1]: Started Volumio Tidal Connect Service. Jun 09 05:59:17 kaitef-rivo sudo[12169]: pam_unix(sudo:session): session closed for user root Jun 09 05:59:17 kaitef-rivo volumio[3269]: info: RAAT: Requesting Headphone Status Jun 09 05:59:17 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus Jun 09 05:59:17 kaitef-rivo volumio[3269]: info: MCU Signalled Headphone Mode Disabled Jun 09 05:59:17 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: raat , reportHeadphoneState Jun 09 05:59:17 kaitef-rivo volumio[3269]: info: Reporting Headphone State: false Jun 09 05:59:17 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 09 05:59:17 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 09 05:59:17 kaitef-rivo volumio[3269]: info: Updating RAAT Signal Path Jun 09 05:59:17 kaitef-rivo volumio[3269]: info: Executing endpoint tc_getconfig Jun 09 05:59:17 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Jun 09 05:59:17 kaitef-rivo vtcs[12171]: STARTING TidalConnect services, version: 1.5.0.45 Jun 09 05:59:17 kaitef-rivo volumio[3269]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Jun 09 05:59:17 kaitef-rivo volumio[3269]: info: CoreStateMachine::getcurrentVolume Jun 09 05:59:17 kaitef-rivo volumio[3269]: info: CoreCommandRouter::volumioRetrievevolume Jun 09 05:59:17 kaitef-rivo vtcs[12171]: STARTED TidalConnect services. Jun 09 05:59:17 kaitef-rivo volumio[3269]: info: Executing endpoint tc_connect Jun 09 05:59:17 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Jun 09 05:59:17 kaitef-rivo volumio[3269]: info: Connecting to TidalConnect Jun 09 05:59:17 kaitef-rivo volumio[3269]: info: CoreCommandRouter::servicePushState Jun 09 05:59:17 kaitef-rivo volumio[3269]: info: CoreStateMachine::pushState Jun 09 05:59:17 kaitef-rivo volumio[3269]: info: CorePlayQueue::getTrack 0 Jun 09 05:59:17 kaitef-rivo volumio[3269]: info: CoreCommandRouter::volumioPushState Jun 09 05:59:17 kaitef-rivo volumio[3269]: info: MRS: Pushing multiroomSync output update for this device Jun 09 05:59:17 kaitef-rivo volumio[3269]: info: MRS: Pushing multiroomSync output Jun 09 05:59:17 kaitef-rivo volumio[3269]: info: CorePlayQueue::getTrack 0 Jun 09 05:59:17 kaitef-rivo volumio[3269]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current qobuz Received tidalconnect Jun 09 05:59:17 kaitef-rivo volumio[3269]: info: CoreCommandRouter::servicePushState Jun 09 05:59:17 kaitef-rivo volumio[3269]: info: CoreStateMachine::pushState Jun 09 05:59:17 kaitef-rivo volumio[3269]: info: CorePlayQueue::getTrack 0 Jun 09 05:59:17 kaitef-rivo volumio[3269]: info: CoreCommandRouter::volumioPushState Jun 09 05:59:17 kaitef-rivo volumio[3269]: info: MRS: Pushing multiroomSync output update for this device Jun 09 05:59:17 kaitef-rivo volumio[3269]: info: MRS: Pushing multiroomSync output Jun 09 05:59:17 kaitef-rivo volumio[3269]: info: CorePlayQueue::getTrack 0 Jun 09 05:59:17 kaitef-rivo volumio[3269]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current qobuz Received tidalconnect Jun 09 05:59:17 kaitef-rivo volumio[3269]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: No protocol specified Jun 09 05:59:17 kaitef-rivo volumio[3269]: xcb_connection_has_error() returned true Jun 09 05:59:17 kaitef-rivo volumio[3269]: info: TidalConnect service stoped! Jun 09 05:59:18 kaitef-rivo volumio[3269]: info: TidalConnect service stoped! Jun 09 05:59:18 kaitef-rivo volumio[3269]: info: VolumeController:: Volume=undefined Mute =false Jun 09 05:59:18 kaitef-rivo volumio[3269]: info: CoreStateMachine::pushState Jun 09 05:59:18 kaitef-rivo volumio[3269]: info: CorePlayQueue::getTrack 0 Jun 09 05:59:18 kaitef-rivo volumio[3269]: info: CoreCommandRouter::volumioPushState Jun 09 05:59:18 kaitef-rivo volumio[3269]: info: MRS: Pushing multiroomSync output update for this device Jun 09 05:59:18 kaitef-rivo volumio[3269]: info: MRS: Pushing multiroomSync output Jun 09 05:59:18 kaitef-rivo volumio[3269]: info: CoreStateMachine::updateTrackBlock Jun 09 05:59:18 kaitef-rivo volumio[3269]: info: CorePlayQueue::getTrackBlock Jun 09 05:59:18 kaitef-rivo volumio[3269]: info: CoreCommandRouter::volumioRetrievevolume Jun 09 05:59:18 kaitef-rivo volumio[3269]: info: RAAT: Requesting Headphone Status Jun 09 05:59:18 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus Jun 09 05:59:18 kaitef-rivo volumio[3269]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: No protocol specified Jun 09 05:59:18 kaitef-rivo volumio[3269]: xcb_connection_has_error() returned true Jun 09 05:59:18 kaitef-rivo volumio[3269]: info: MCU Signalled Headphone Mode Disabled Jun 09 05:59:18 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: raat , reportHeadphoneState Jun 09 05:59:18 kaitef-rivo volumio[3269]: info: Reporting Headphone State: false Jun 09 05:59:18 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 09 05:59:18 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 09 05:59:18 kaitef-rivo volumio[3269]: info: Updating RAAT Signal Path Jun 09 05:59:18 kaitef-rivo volumio[3269]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jun 09 05:59:18 kaitef-rivo volumio[3269]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Jun 09 05:59:18 kaitef-rivo volumio[3269]: info: VolumeController:: Volume=undefined Mute =false Jun 09 05:59:18 kaitef-rivo volumio[3269]: info: CoreStateMachine::pushState Jun 09 05:59:18 kaitef-rivo volumio[3269]: info: CorePlayQueue::getTrack 0 Jun 09 05:59:18 kaitef-rivo volumio[3269]: info: CoreCommandRouter::volumioPushState Jun 09 05:59:18 kaitef-rivo volumio[3269]: info: MRS: Pushing multiroomSync output update for this device Jun 09 05:59:18 kaitef-rivo volumio[3269]: info: MRS: Pushing multiroomSync output Jun 09 05:59:18 kaitef-rivo sudo[12205]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jun 09 05:59:18 kaitef-rivo sudo[12205]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 09 05:59:18 kaitef-rivo sudo[12205]: pam_unix(sudo:session): session closed for user root Jun 09 05:59:18 kaitef-rivo mpd[12120]: Jun 09 05:59 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jun 09 05:59:18 kaitef-rivo systemd[1]: Started Music Player Daemon. Jun 09 05:59:18 kaitef-rivo sudo[12081]: pam_unix(sudo:session): session closed for user root Jun 09 05:59:18 kaitef-rivo sudo[11997]: pam_unix(sudo:session): session closed for user root Jun 09 05:59:18 kaitef-rivo volumio[3269]: error: MPD error: The expression evaluated to a falsy value: Jun 09 05:59:18 kaitef-rivo volumio[3269]: assert.ok(self.idling) Jun 09 05:59:18 kaitef-rivo volumio[3269]: error: The expression evaluated to a falsy value: Jun 09 05:59:18 kaitef-rivo volumio[3269]: assert.ok(self.idling) Jun 09 05:59:18 kaitef-rivo volumio[3269]: error: updateQueue error: null Jun 09 05:59:18 kaitef-rivo volumio[3269]: info: RAAT: Requesting Headphone Status Jun 09 05:59:18 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus Jun 09 05:59:18 kaitef-rivo volumio[3269]: info: MCU Signalled Headphone Mode Disabled Jun 09 05:59:18 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: raat , reportHeadphoneState Jun 09 05:59:18 kaitef-rivo volumio[3269]: info: Reporting Headphone State: false Jun 09 05:59:18 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 09 05:59:18 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 09 05:59:18 kaitef-rivo volumio[3269]: info: Updating RAAT Signal Path Jun 09 05:59:19 kaitef-rivo volumio-time-update[2825]: volumio-time-update-util: Fetching time from Volumio... Jun 09 05:59:19 kaitef-rivo volumio[3269]: info: TidalConnect service stoped! Jun 09 05:59:19 kaitef-rivo volumio[3269]: info: TidalConnect service stoped! Jun 09 05:59:19 kaitef-rivo volumio[3269]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jun 09 05:59:19 kaitef-rivo volumio[3269]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Jun 09 05:59:19 kaitef-rivo sudo[12223]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jun 09 05:59:19 kaitef-rivo sudo[12223]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 09 05:59:19 kaitef-rivo sudo[12223]: pam_unix(sudo:session): session closed for user root Jun 09 05:59:19 kaitef-rivo volumio[3269]: info: RAAT: Requesting Headphone Status Jun 09 05:59:19 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus Jun 09 05:59:19 kaitef-rivo volumio[3269]: info: MCU Signalled Headphone Mode Disabled Jun 09 05:59:19 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: raat , reportHeadphoneState Jun 09 05:59:19 kaitef-rivo volumio[3269]: info: Reporting Headphone State: false Jun 09 05:59:19 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 09 05:59:19 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 09 05:59:19 kaitef-rivo volumio[3269]: info: Updating RAAT Signal Path Jun 09 05:59:20 kaitef-rivo volumio[3269]: info: TidalConnect service started! Jun 09 05:59:21 kaitef-rivo go-librespot[11872]: time="2025-06-09T05:59:21+09:00" level=fatal msg="failed running zeroconf" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Jun 09 05:59:21 kaitef-rivo systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jun 09 05:59:21 kaitef-rivo systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jun 09 05:59:21 kaitef-rivo volumio[3269]: info: TidalConnect service started! Jun 09 05:59:21 kaitef-rivo dhcpcd[3264]: eth0: carrier acquired Jun 09 05:59:21 kaitef-rivo kernel: meson6-dwmac ff3f0000.ethernet eth0: Link is Up - 1Gbps/Full - flow control rx/tx Jun 09 05:59:21 kaitef-rivo dhcpcd[3264]: eth0: IAID 00:17:22:01 Jun 09 05:59:21 kaitef-rivo dhcpcd[3264]: eth0: rebinding lease of 192.168.10.111 Jun 09 05:59:22 kaitef-rivo ifplugd(eth0)[3081]: Link beat detected. Jun 09 05:59:22 kaitef-rivo ifplugd(eth0)[3081]: Executing '/etc/ifplugd/ifplugd.action eth0 up'. Jun 09 05:59:22 kaitef-rivo ifplugd(eth0)[3081]: client: sending commands to master dhcpcd process Jun 09 05:59:22 kaitef-rivo dhcpcd[12246]: sending commands to master dhcpcd process Jun 09 05:59:22 kaitef-rivo dhcpcd[3264]: control command: /sbin/dhcpcd eth0 Jun 09 05:59:22 kaitef-rivo volumio[3269]: info: TidalConnect service started! Jun 09 05:59:22 kaitef-rivo ifplugd(eth0)[3081]: Program executed successfully. Jun 09 05:59:22 kaitef-rivo dhcpcd[3264]: eth0: soliciting an IPv6 router Jun 09 05:59:24 kaitef-rivo systemd[1]: go-librespot-daemon.service: Service RestartSec=3s expired, scheduling restart. Jun 09 05:59:24 kaitef-rivo systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 96. Jun 09 05:59:24 kaitef-rivo systemd[1]: Stopped go-librespot Daemon. Jun 09 05:59:24 kaitef-rivo systemd[1]: Started go-librespot Daemon. Jun 09 05:59:24 kaitef-rivo go-librespot[12272]: go-librespot daemon starting... Jun 09 05:59:24 kaitef-rivo go-librespot[12272]: time="2025-06-09T05:59:24+09:00" level=info msg="running go-librespot 0.1.3" Jun 09 05:59:24 kaitef-rivo go-librespot[12272]: time="2025-06-09T05:59:24+09:00" level=debug msg="app state loaded" Jun 09 05:59:24 kaitef-rivo go-librespot[12272]: time="2025-06-09T05:59:24+09:00" level=debug msg="stored credentials not found" Jun 09 05:59:24 kaitef-rivo go-librespot[12272]: time="2025-06-09T05:59:24+09:00" level=info msg="api server listening on 127.0.0.1:9879" Jun 09 05:59:26 kaitef-rivo dhcpcd[3264]: eth0: probing address 192.168.10.111/24 Jun 09 05:59:28 kaitef-rivo ntpd[3053]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Jun 09 05:59:31 kaitef-rivo dhcpcd[3264]: eth0: leased 192.168.10.111 for 86400 seconds Jun 09 05:59:31 kaitef-rivo dhcpcd[3264]: eth0: adding route to 192.168.10.0/24 Jun 09 05:59:31 kaitef-rivo dhcpcd[3264]: eth0: adding default route via 192.168.10.1 Jun 09 05:59:31 kaitef-rivo dhcpcd[3264]: wlan0: deleting default route Jun 09 05:59:31 kaitef-rivo avahi-daemon[2818]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.10.111. Jun 09 05:59:31 kaitef-rivo avahi-daemon[2818]: New relevant interface eth0.IPv4 for mDNS. Jun 09 05:59:31 kaitef-rivo avahi-daemon[2818]: Registering new address record for 192.168.10.111 on eth0.IPv4. Jun 09 05:59:31 kaitef-rivo ntpd[3053]: ntpd exiting on signal 15 (Terminated) Jun 09 05:59:31 kaitef-rivo systemd[1]: Stopping Network Time Service... Jun 09 05:59:31 kaitef-rivo volumio[3269]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 09 05:59:31 kaitef-rivo systemd[1]: ntp.service: Succeeded. Jun 09 05:59:31 kaitef-rivo systemd[1]: Stopped Network Time Service. Jun 09 05:59:31 kaitef-rivo volumio[3269]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jun 09 05:59:31 kaitef-rivo systemd[1]: Starting Network Time Service... Jun 09 05:59:31 kaitef-rivo volumio[3269]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 09 05:59:31 kaitef-rivo ntpd[12334]: ntpd 4.2.8p12@1.3728-o (1): Starting Jun 09 05:59:31 kaitef-rivo ntpd[12334]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Jun 09 05:59:31 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Jun 09 05:59:31 kaitef-rivo systemd[1]: Started Network Time Service. Jun 09 05:59:31 kaitef-rivo ntpd[12350]: proto: precision = 1.250 usec (-20) Jun 09 05:59:31 kaitef-rivo ntpd[12350]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Jun 09 05:59:31 kaitef-rivo ntpd[12350]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Jun 09 05:59:31 kaitef-rivo ntpd[12350]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 894 days ago Jun 09 05:59:31 kaitef-rivo ntpd[12350]: Listen and drop on 0 v6wildcard [::]:123 Jun 09 05:59:31 kaitef-rivo ntpd[12350]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Jun 09 05:59:31 kaitef-rivo ntpd[12350]: Listen normally on 2 lo 127.0.0.1:123 Jun 09 05:59:31 kaitef-rivo ntpd[12350]: Listen normally on 3 eth0 192.168.10.111:123 Jun 09 05:59:31 kaitef-rivo ntpd[12350]: Listen normally on 4 wlan0 169.254.213.3:123 Jun 09 05:59:31 kaitef-rivo ntpd[12350]: Listening on routing socket on fd #21 for interface updates Jun 09 05:59:31 kaitef-rivo ntpd[12350]: kernel reports TIME_ERROR: 0x4041: Clock Unsynchronized Jun 09 05:59:31 kaitef-rivo ntpd[12350]: kernel reports TIME_ERROR: 0x4041: Clock Unsynchronized Jun 09 05:59:31 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Jun 09 05:59:31 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Jun 09 05:59:31 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Jun 09 05:59:31 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Jun 09 05:59:31 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Jun 09 05:59:31 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 11 Jun 09 05:59:31 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 12 Jun 09 05:59:31 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 13 Jun 09 05:59:31 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 14 Jun 09 05:59:31 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 15 Jun 09 05:59:31 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 16 Jun 09 05:59:31 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 17 Jun 09 05:59:31 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 18 Jun 09 05:59:31 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 19 Jun 09 05:59:31 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 20 Jun 09 05:59:31 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 21 Jun 09 05:59:31 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 22 Jun 09 05:59:32 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 23 Jun 09 05:59:32 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 24 Jun 09 05:59:32 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 25 Jun 09 05:59:32 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 26 Jun 09 05:59:32 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 27 Jun 09 05:59:32 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 28 Jun 09 05:59:32 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 29 Jun 09 05:59:32 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 30 Jun 09 05:59:32 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 31 Jun 09 05:59:32 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 32 Jun 09 05:59:32 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 33 Jun 09 05:59:32 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 34 Jun 09 05:59:32 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 35 Jun 09 05:59:32 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 36 Jun 09 05:59:32 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 37 Jun 09 05:59:32 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 38 Jun 09 05:59:32 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 39 Jun 09 05:59:32 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 40 Jun 09 05:59:32 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 41 Jun 09 05:59:32 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 42 Jun 09 05:59:32 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 43 Jun 09 05:59:32 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 44 Jun 09 05:59:32 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 45 Jun 09 05:59:32 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 46 Jun 09 05:59:32 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 47 Jun 09 05:59:32 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 48 Jun 09 05:59:32 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 49 Jun 09 05:59:32 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 50 Jun 09 05:59:32 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 51 Jun 09 05:59:32 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 52 Jun 09 05:59:32 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 53 Jun 09 05:59:32 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 54 Jun 09 05:59:32 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 55 Jun 09 05:59:32 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 56 Jun 09 05:59:32 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 57 Jun 09 05:59:32 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 58 Jun 09 05:59:32 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 59 Jun 09 05:59:32 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 60 Jun 09 05:59:32 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 61 Jun 09 05:59:32 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 62 Jun 09 05:59:32 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 63 Jun 09 05:59:32 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 64 Jun 09 05:59:32 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 65 Jun 09 05:59:32 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 66 Jun 09 05:59:32 kaitef-rivo ntpd[12350]: Soliciting pool server 172.237.12.44 Jun 09 05:59:32 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 67 Jun 09 05:59:32 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 68 Jun 09 05:59:32 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 69 Jun 09 05:59:32 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 70 Jun 09 05:59:32 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 71 Jun 09 05:59:32 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 72 Jun 09 05:59:32 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 73 Jun 09 05:59:32 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 74 Jun 09 05:59:32 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 75 Jun 09 05:59:32 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 76 Jun 09 05:59:32 kaitef-rivo go-librespot[12272]: time="2025-06-09T05:59:32+09:00" level=debug msg="new websocket client" Jun 09 05:59:32 kaitef-rivo volumio[3269]: info: Connection to go-librespot Websocket established Jun 09 05:59:32 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 77 Jun 09 05:59:32 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 78 Jun 09 05:59:32 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 79 Jun 09 05:59:32 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 80 Jun 09 05:59:32 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 81 Jun 09 05:59:32 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 82 Jun 09 05:59:32 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 83 Jun 09 05:59:32 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 84 Jun 09 05:59:32 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 85 Jun 09 05:59:33 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 86 Jun 09 05:59:33 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 87 Jun 09 05:59:33 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 88 Jun 09 05:59:33 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 89 Jun 09 05:59:33 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 90 Jun 09 05:59:33 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 91 Jun 09 05:59:33 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 92 Jun 09 05:59:33 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 93 Jun 09 05:59:33 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 94 Jun 09 05:59:33 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 95 Jun 09 05:59:33 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 96 Jun 09 05:59:33 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 97 Jun 09 05:59:33 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 98 Jun 09 05:59:33 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 99 Jun 09 05:59:33 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 100 Jun 09 05:59:33 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 101 Jun 09 05:59:33 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 102 Jun 09 05:59:33 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 103 Jun 09 05:59:33 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 104 Jun 09 05:59:33 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 105 Jun 09 05:59:33 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 106 Jun 09 05:59:33 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 107 Jun 09 05:59:33 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 108 Jun 09 05:59:33 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 109 Jun 09 05:59:33 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 110 Jun 09 05:59:33 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 111 Jun 09 05:59:33 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 112 Jun 09 05:59:33 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 113 Jun 09 05:59:33 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 114 Jun 09 05:59:33 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 115 Jun 09 05:59:33 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 116 Jun 09 05:59:33 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 117 Jun 09 05:59:33 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 118 Jun 09 05:59:33 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 119 Jun 09 05:59:33 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 120 Jun 09 05:59:33 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 121 Jun 09 05:59:33 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 122 Jun 09 05:59:33 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 123 Jun 09 05:59:33 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 124 Jun 09 05:59:33 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 125 Jun 09 05:59:33 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 126 Jun 09 05:59:33 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 127 Jun 09 05:59:33 kaitef-rivo volumio[3269]: info: MRS: Found cast device: Google-Nest-Hub-d18510fc594530b19ec73ebb3422af7f Jun 09 05:59:33 kaitef-rivo volumio[3269]: info: Adding audio output: Jun 09 05:59:33 kaitef-rivo volumio[3269]: info: Discovery: this is already registered, 83c8e2e3-2311-47a9-82b5-2a67e112d0b2 Jun 09 05:59:33 kaitef-rivo volumio[3269]: info: Discovery: Found device Kaitef-Rivo Jun 09 05:59:33 kaitef-rivo volumio[3269]: info: CoreCommandRouter::volumioGetState Jun 09 05:59:33 kaitef-rivo volumio[3269]: info: CorePlayQueue::getTrack 0 Jun 09 05:59:33 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 128 Jun 09 05:59:33 kaitef-rivo ntpd[12350]: Soliciting pool server 129.250.35.250 Jun 09 05:59:33 kaitef-rivo volumio[3269]: info: CoreCommandRouter::volumioGetState Jun 09 05:59:33 kaitef-rivo volumio[3269]: info: CorePlayQueue::getTrack 0 Jun 09 05:59:33 kaitef-rivo ntpd[12350]: Soliciting pool server 139.162.81.45 Jun 09 05:59:33 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 129 Jun 09 05:59:33 kaitef-rivo volumio[3269]: info: CoreCommandRouter::volumioGetState Jun 09 05:59:33 kaitef-rivo volumio[3269]: info: CorePlayQueue::getTrack 0 Jun 09 05:59:34 kaitef-rivo volumio[3269]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Jun 09 05:59:34 kaitef-rivo volumio[3269]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Jun 09 05:59:34 kaitef-rivo volumio[3269]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Jun 09 05:59:34 kaitef-rivo volumio[3269]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Jun 09 05:59:34 kaitef-rivo volumio[3269]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Jun 09 05:59:34 kaitef-rivo volumio[3269]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Jun 09 05:59:34 kaitef-rivo volumio[3269]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Jun 09 05:59:34 kaitef-rivo volumio[3269]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Jun 09 05:59:34 kaitef-rivo volumio[3269]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Jun 09 05:59:34 kaitef-rivo volumio[3269]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Jun 09 05:59:34 kaitef-rivo volumio[3269]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Jun 09 05:59:34 kaitef-rivo volumio[3269]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Jun 09 05:59:34 kaitef-rivo volumio[3269]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Jun 09 05:59:34 kaitef-rivo volumio[3269]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Jun 09 05:59:34 kaitef-rivo volumio[3269]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Jun 09 05:59:34 kaitef-rivo volumio[3269]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Jun 09 05:59:34 kaitef-rivo volumio[3269]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Jun 09 05:59:34 kaitef-rivo volumio[3269]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Jun 09 05:59:34 kaitef-rivo volumio[3269]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Jun 09 05:59:34 kaitef-rivo volumio[3269]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Jun 09 05:59:34 kaitef-rivo volumio[3269]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Jun 09 05:59:34 kaitef-rivo volumio[3269]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Jun 09 05:59:34 kaitef-rivo volumio[3269]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Jun 09 05:59:34 kaitef-rivo volumio[3269]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Jun 09 05:59:34 kaitef-rivo volumio[3269]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Jun 09 05:59:34 kaitef-rivo volumio[3269]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Jun 09 05:59:34 kaitef-rivo volumio[3269]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Jun 09 05:59:34 kaitef-rivo volumio[3269]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Jun 09 05:59:34 kaitef-rivo volumio[3269]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Jun 09 05:59:34 kaitef-rivo ntpd[12350]: Soliciting pool server 162.159.200.1 Jun 09 05:59:34 kaitef-rivo ntpd[12350]: Soliciting pool server 162.159.200.123 Jun 09 05:59:34 kaitef-rivo ntpd[12350]: Soliciting pool server 129.250.35.251 Jun 09 05:59:35 kaitef-rivo volumio[3269]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Jun 09 05:59:35 kaitef-rivo volumio[3269]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Jun 09 05:59:35 kaitef-rivo ntpd[12350]: Soliciting pool server 45.76.211.39 Jun 09 05:59:35 kaitef-rivo ntpd[12350]: Soliciting pool server 167.179.119.205 Jun 09 05:59:35 kaitef-rivo ntpd[12350]: Soliciting pool server 45.77.20.103 Jun 09 05:59:35 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 09 05:59:35 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 09 05:59:35 kaitef-rivo volumio[3269]: info: Starting MyVolumio Remote Streaming Endpoints Jun 09 05:59:35 kaitef-rivo volumio[3269]: info: MyVolumio login type: Token Jun 09 05:59:35 kaitef-rivo ntpd[12350]: Soliciting pool server 202.181.103.212 Jun 09 05:59:35 kaitef-rivo volumio[3269]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Jun 09 05:59:35 kaitef-rivo volumio[3269]: error: [MyVolumio PluginManager] Could not read package.json file: Error: /myvolumio/plugins/music_service/streaming_services//package.json: ENOENT: no such file or directory, open '/myvolumio/plugins/music_service/streaming_services//package.json' Jun 09 05:59:35 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 129 Jun 09 05:59:35 kaitef-rivo volumio[3269]: info: CoreCommandRouter::volumioGetState Jun 09 05:59:35 kaitef-rivo volumio[3269]: info: CorePlayQueue::getTrack 0 Jun 09 05:59:35 kaitef-rivo volumio[3269]: info: Getting Spotify volume Jun 09 05:59:35 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 129 Jun 09 05:59:35 kaitef-rivo volumio[3269]: info: CoreCommandRouter::volumioGetState Jun 09 05:59:35 kaitef-rivo volumio[3269]: info: CorePlayQueue::getTrack 0 Jun 09 05:59:36 kaitef-rivo volumio[3269]: error: MyVolumio Custom Token format not valid, refreshing it Jun 09 05:59:36 kaitef-rivo volumio[3269]: info: Reporting MCU Network Status: 3 Jun 09 05:59:36 kaitef-rivo volumio[3269]: info: Volumio Network Manager: Network status updated: 3 Jun 09 05:59:36 kaitef-rivo ntpd[12350]: Soliciting pool server 133.130.121.141 Jun 09 05:59:36 kaitef-rivo ntpd[12350]: Soliciting pool server 47.79.37.210 Jun 09 05:59:36 kaitef-rivo ntpd[12350]: Soliciting pool server 23.81.40.154 Jun 09 05:59:36 kaitef-rivo ntpd[12350]: Soliciting pool server 103.131.151.20 Jun 09 05:59:37 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 129 Jun 09 05:59:37 kaitef-rivo volumio[3269]: info: CoreCommandRouter::volumioGetState Jun 09 05:59:37 kaitef-rivo volumio[3269]: info: CorePlayQueue::getTrack 0 Jun 09 05:59:37 kaitef-rivo volumio[3269]: info: MyVolumio login type: Token Jun 09 05:59:37 kaitef-rivo ntpd[12350]: Soliciting pool server 138.3.216.120 Jun 09 05:59:37 kaitef-rivo ntpd[12350]: Soliciting pool server 108.160.132.224 Jun 09 05:59:37 kaitef-rivo ntpd[12350]: Soliciting pool server 45.76.221.157 Jun 09 05:59:38 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 129 Jun 09 05:59:38 kaitef-rivo volumio[3269]: info: CoreCommandRouter::volumioGetState Jun 09 05:59:38 kaitef-rivo volumio[3269]: info: CorePlayQueue::getTrack 0 Jun 09 05:59:38 kaitef-rivo volumio[3269]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Jun 09 05:59:39 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 129 Jun 09 05:59:39 kaitef-rivo volumio[3269]: info: MyVolumio token set successfully Jun 09 05:59:39 kaitef-rivo volumio[3269]: info: MYVOLUMIO: Adding device Jun 09 05:59:39 kaitef-rivo volumio[3269]: info: MYVOLUMIO: Evaluating Server Jun 09 05:59:39 kaitef-rivo volumio-time-update[2825]: volumio-time-update-util: Date not found in response Jun 09 05:59:39 kaitef-rivo volumio-time-update[2825]: volumio-time-update-util: Retrying in 5 seconds... Jun 09 05:59:39 kaitef-rivo volumio[3269]: info: CoreCommandRouter::volumioGetState Jun 09 05:59:39 kaitef-rivo volumio[3269]: info: CorePlayQueue::getTrack 0 Jun 09 05:59:40 kaitef-rivo volumio[3269]: info: MyVolumio status changed Jun 09 05:59:40 kaitef-rivo volumio[3269]: info: Streaming services startup Jun 09 05:59:40 kaitef-rivo volumio[3269]: info: Starting Streaming Daemon Jun 09 05:59:40 kaitef-rivo volumio[3269]: info: Removing browser output: myVolumio user plan is not superstar Jun 09 05:59:40 kaitef-rivo volumio[3269]: info: Removing audio output: Jun 09 05:59:40 kaitef-rivo volumio[3269]: info: Stoppping Tunnel 1 Jun 09 05:59:40 kaitef-rivo sudo[12399]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jun 09 05:59:40 kaitef-rivo sudo[12399]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 09 05:59:40 kaitef-rivo sudo[12399]: pam_unix(sudo:session): session closed for user root Jun 09 05:59:40 kaitef-rivo sudo[12402]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Jun 09 05:59:40 kaitef-rivo sudo[12402]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 09 05:59:40 kaitef-rivo volumio[3269]: error: Cannot start Volumio Streaming Daemon Jun 09 05:59:40 kaitef-rivo volumio[3269]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jun 09 05:59:40 kaitef-rivo volumio[3269]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jun 09 05:59:40 kaitef-rivo volumio[3269]: info: Setting Geolocation for MyVolumio to as1 Jun 09 05:59:40 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 09 05:59:40 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 09 05:59:40 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 09 05:59:40 kaitef-rivo sudo[12402]: pam_unix(sudo:session): session closed for user root Jun 09 05:59:40 kaitef-rivo volumio[3269]: info: Remote SSH Stopped Jun 09 05:59:40 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 129 Jun 09 05:59:40 kaitef-rivo volumio[3269]: info: CoreCommandRouter::volumioGetState Jun 09 05:59:40 kaitef-rivo volumio[3269]: info: CorePlayQueue::getTrack 0 Jun 09 05:59:40 kaitef-rivo volumio[3269]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Jun 09 05:59:41 kaitef-rivo volumio[3269]: info: Updating MyVolumio device info Jun 09 05:59:41 kaitef-rivo volumio[3269]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 09 05:59:41 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 127 Jun 09 05:59:41 kaitef-rivo volumio[3269]: info: CoreCommandRouter::volumioGetState Jun 09 05:59:41 kaitef-rivo volumio[3269]: info: CorePlayQueue::getTrack 0 Jun 09 05:59:40 kaitef-rivo ntpd[12350]: receive: Unexpected origin timestamp 0xebf0783d.ac67d075 does not match aorg 0000000000.00000000 from server@162.159.200.1 xmt 0xebf0783c.fe70152a Jun 09 05:59:40 kaitef-rivo ntpd[12350]: receive: Unexpected origin timestamp 0xebf0783d.ac65bd79 does not match aorg 0000000000.00000000 from server@129.250.35.251 xmt 0xebf0783c.fe2bf484 Jun 09 05:59:40 kaitef-rivo ntpd[12350]: receive: Unexpected origin timestamp 0xebf0783d.ac549ac5 does not match aorg 0000000000.00000000 from server@103.131.151.20 xmt 0xebf0783c.fe24aada Jun 09 05:59:40 kaitef-rivo ntpd[12350]: receive: Unexpected origin timestamp 0xebf0783d.ac616815 does not match aorg 0000000000.00000000 from server@23.81.40.154 xmt 0xebf0783c.fe401ddc Jun 09 05:59:40 kaitef-rivo ntpd[12350]: receive: Unexpected origin timestamp 0xebf0783d.ac5f393d does not match aorg 0000000000.00000000 from server@47.79.37.210 xmt 0xebf0783c.fe70a1bc Jun 09 05:59:41 kaitef-rivo ntpd[12350]: receive: Unexpected origin timestamp 0xebf0783d.ac69f565 does not match aorg 0000000000.00000000 from server@162.159.200.123 xmt 0xebf0783d.00f54136 Jun 09 05:59:41 kaitef-rivo ntpd[12350]: receive: Unexpected origin timestamp 0xebf0783d.ac5cb2fc does not match aorg 0000000000.00000000 from server@133.130.121.141 xmt 0xebf0783c.fdfd21a4 Jun 09 05:59:41 kaitef-rivo volumio[3269]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Jun 09 05:59:42 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 127 Jun 09 05:59:42 kaitef-rivo volumio[3269]: info: CoreCommandRouter::volumioGetState Jun 09 05:59:42 kaitef-rivo volumio[3269]: info: CorePlayQueue::getTrack 0 Jun 09 05:59:43 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 128 Jun 09 05:59:43 kaitef-rivo volumio[3269]: info: CoreCommandRouter::volumioGetState Jun 09 05:59:43 kaitef-rivo volumio[3269]: info: CorePlayQueue::getTrack 0 Jun 09 05:59:43 kaitef-rivo volumio-time-update[2825]: volumio-time-update-util: Fetching time from Volumio... Jun 09 05:59:43 kaitef-rivo volumio[3269]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 128 Jun 09 05:59:43 kaitef-rivo volumio[3269]: info: CoreCommandRouter::volumioGetState Jun 09 05:59:43 kaitef-rivo volumio[3269]: info: CorePlayQueue::getTrack 0 Jun 09 05:59:43 kaitef-rivo go-librespot[12272]: time="2025-06-09T05:59:43+09:00" level=fatal msg="failed running zeroconf" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": dial tcp: lookup apresolve.spotify.com: device or resource busy" Jun 09 05:59:43 kaitef-rivo systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Jun 09 05:59:43 kaitef-rivo systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Jun 09 05:59:43 kaitef-rivo volumio[3269]: (node:3269) UnhandledPromiseRejectionWarning: Error: socket hang up Jun 09 05:59:43 kaitef-rivo volumio[3269]: at connResetException (internal/errors.js:639:14) Jun 09 05:59:43 kaitef-rivo volumio[3269]: at Socket.socketOnEnd (_http_client.js:499:23) Jun 09 05:59:43 kaitef-rivo volumio[3269]: at Socket.emit (events.js:412:35) Jun 09 05:59:43 kaitef-rivo volumio[3269]: at endReadableNT (internal/streams/readable.js:1333:12) Jun 09 05:59:43 kaitef-rivo volumio[3269]: at processTicksAndRejections (internal/process/task_queues.js:82:21) Jun 09 05:59:43 kaitef-rivo volumio[3269]: (node:3269) UnhandledPromiseRejectionWarning: Unhandled promise rejection. This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). To terminate the node process on unhandled promise rejection, use the CLI flag `--unhandled-rejections=strict` (see https://nodejs.org/api/cli.html#cli_unhandled_rejections_mode). (rejection id: 8) Jun 09 05:59:43 kaitef-rivo volumio[3269]: info: Connection to go-librespot Websocket closed Jun 09 05:59:44 kaitef-rivo volumio[3269]: info: MYVOLUMIO: Adding device Jun 09 05:59:44 kaitef-rivo volumio[3269]: info: MYVOLUMIO: Evaluating Server Jun 09 05:59:44 kaitef-rivo volumio-time-update[2825]: volumio-time-update-util: Setting system time to: 2025-06-09 05:59:44 Jun 09 05:59:44 kaitef-rivo sudo[12411]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-time 2025-06-09 05:59:44 Jun 09 05:59:44 kaitef-rivo sudo[12411]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 09 05:59:44 kaitef-rivo dbus-daemon[2817]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.51' (uid=0 pid=12414 comm="timedatectl set-time 2025-06-09 05:59:44 " label="kernel") Jun 09 05:59:44 kaitef-rivo systemd[1]: Starting Time & Date Service... Jun 09 05:59:44 kaitef-rivo dbus-daemon[2817]: [system] Successfully activated service 'org.freedesktop.timedate1' Jun 09 05:59:44 kaitef-rivo systemd[1]: Started Time & Date Service. Jun 09 05:59:44 kaitef-rivo systemd-timedated[12417]: Changed local time to Mon Jun 9 05:59:44 2025 Jun 09 05:59:44 kaitef-rivo sudo[12411]: pam_unix(sudo:session): session closed for user root Jun 09 05:59:44 kaitef-rivo volumio-time-update[2825]: volumio-time-update-util: System time updated successfully. Jun 09 05:59:44 kaitef-rivo systemd[1]: Started Volumio Time Update Utility. Jun 09 05:59:44 kaitef-rivo systemd[1]: Reached target Multi-User System. Jun 09 05:59:44 kaitef-rivo systemd[1]: Reached target Graphical Interface. Jun 09 05:59:44 kaitef-rivo systemd[1]: Starting Update UTMP about System Runlevel Changes... Jun 09 05:59:44 kaitef-rivo systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Jun 09 05:59:44 kaitef-rivo systemd[1]: Started Update UTMP about System Runlevel Changes. Jun 09 05:59:44 kaitef-rivo systemd[1]: Startup finished in 12.937s (kernel) + 38min 51.236s (userspace) = 39min 4.174s. Jun 09 05:59:44 kaitef-rivo volumio[3269]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 09 05:59:44 kaitef-rivo volumio[3269]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 09 05:59:44 kaitef-rivo volumio[3269]: error: Failed to ping endpoint eu3.myvolumio.org : unknown error Jun 09 05:59:44 kaitef-rivo volumio[3269]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 09 05:59:44 kaitef-rivo volumio[3269]: Error: Unable to resolve or reject the same promise twice Jun 09 05:59:44 kaitef-rivo volumio[3269]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Jun 09 05:59:44 kaitef-rivo volumio[3269]: at Socket. (/myvolumio/plugins/system_controller/my_volumio/my_volumio_real:1:32367) Jun 09 05:59:44 kaitef-rivo volumio[3269]: at Socket.emit (events.js:400:28) Jun 09 05:59:44 kaitef-rivo volumio[3269]: at addChunk (internal/streams/readable.js:293:12) Jun 09 05:59:44 kaitef-rivo volumio[3269]: at readableAddChunk (internal/streams/readable.js:267:9) Jun 09 05:59:44 kaitef-rivo volumio[3269]: at Socket.Readable.push (internal/streams/readable.js:206:10) Jun 09 05:59:44 kaitef-rivo volumio[3269]: at Pipe.onStreamRead (internal/stream_base_commons.js:188:23) Jun 09 05:59:44 kaitef-rivo volumio[3269]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 09 05:59:45 kaitef-rivo sudo[12453]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-09 05:58 Jun 09 05:59:45 kaitef-rivo sudo[12453]: 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="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="e32c2c71ae78852844c70357816bdd871c155ab8" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="rivo" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 31 Mar 2025 08:01:39 PM CEST" VOLUMIO_VERSION="3.799" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Rivo" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Rivo" VOLUMIO_HASH="71b19b3a3eb3d257ef93eee35eba5cf1"