-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Thu 2025-12-25 11:04:24 CET. -- Dec 25 11:03:53 motivo systemd-timedated[1371]: Changed local time to Thu Dec 25 11:03:53 2025 Dec 25 11:03:53 motivo sudo[1364]: pam_unix(sudo:session): session closed for user root Dec 25 11:03:53 motivo volumio-time-update[706]: volumio-time-update-util: System time updated successfully. Dec 25 11:03:53 motivo sudo[1375]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Dec 25 11:03:53 motivo sudo[1375]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 25 11:03:53 motivo systemd[1]: Starting Daily apt download activities... Dec 25 11:03:53 motivo systemd[1]: Starting Daily man-db regeneration... Dec 25 11:03:53 motivo systemd[1]: Started Volumio Time Update Utility. Dec 25 11:03:53 motivo volumio[872]: info: VolumeController:: Volume=46 Mute =false Dec 25 11:03:53 motivo volumio[872]: info: CoreStateMachine::pushState Dec 25 11:03:53 motivo volumio[872]: info: CorePlayQueue::getTrack 0 Dec 25 11:03:53 motivo volumio[872]: info: CoreCommandRouter::volumioPushState Dec 25 11:03:53 motivo systemd[1]: Started UPnP Renderer front-end to MPD. Dec 25 11:03:53 motivo volumio[872]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Dec 25 11:03:53 motivo volumio[872]: info: Reading ALSA contributions from plugins. Dec 25 11:03:53 motivo sudo[1375]: pam_unix(sudo:session): session closed for user root Dec 25 11:03:53 motivo volumio[872]: info: Discovery: A device disappeared from network Dec 25 11:03:53 motivo volumio[872]: info: Discovery: Browse raised the following error TypeError: Cannot read property 'toLowerCase' of undefined Dec 25 11:03:53 motivo volumio[872]: info: Discovery: adding 189a6d24-5a15-488b-8edc-a85c4bfac0d2 Dec 25 11:03:53 motivo volumio[872]: info: Discovery: Found device Motivo Dec 25 11:03:53 motivo volumio[872]: info: CoreCommandRouter::volumioGetState Dec 25 11:03:53 motivo volumio[872]: info: CorePlayQueue::getTrack 0 Dec 25 11:03:53 motivo volumio[872]: info: MRS: Pushing multiroomSync output for this device Dec 25 11:03:53 motivo volumio[872]: info: MRS: Pushing multiroomSync output Dec 25 11:03:53 motivo volumio[872]: info: Adding audio output: Dec 25 11:03:53 motivo volumio[872]: info: Adding audio output: Dec 25 11:03:53 motivo volumio[872]: info: Upmpdcli Daemon Started Dec 25 11:03:53 motivo volumio[872]: info: Asound.conf file unchanged, so no further update is needed Dec 25 11:03:53 motivo volumio[872]: info: Output device has changed, restarting MPD Dec 25 11:03:53 motivo systemd[1]: man-db.service: Succeeded. Dec 25 11:03:53 motivo systemd[1]: Started Daily man-db regeneration. Dec 25 11:03:53 motivo sudo[1396]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 25 11:03:53 motivo volumio[872]: info: Output device has changed, restarting Shairport Sync Dec 25 11:03:53 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 11:03:53 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 25 11:03:53 motivo sudo[1396]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 25 11:03:53 motivo sudo[1396]: pam_unix(sudo:session): session closed for user root Dec 25 11:03:53 motivo sudo[1399]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 25 11:03:53 motivo sudo[1399]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 25 11:03:53 motivo systemd[1]: Stopping Music Player Daemon... Dec 25 11:03:53 motivo volumio[872]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 25 11:03:53 motivo volumio[872]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Dec 25 11:03:53 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 11:03:53 motivo volumio[872]: info: ___________ START PLUGINS ___________ Dec 25 11:03:53 motivo volumio[872]: info: ControllerMpd::onStart: Initializing MPD Dec 25 11:03:53 motivo volumio[872]: info: Creating MPD Configuration file Dec 25 11:03:53 motivo systemd[1]: mpd.service: Succeeded. Dec 25 11:03:53 motivo systemd[1]: Stopped Music Player Daemon. Dec 25 11:03:53 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 25 11:03:53 motivo volumio[872]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 25 11:03:53 motivo systemd[1]: Starting Music Player Daemon... Dec 25 11:03:53 motivo volumio[872]: info: [1766657033417] CoreMusicLibrary::Adding element Server multimediali Dec 25 11:03:53 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 25 11:03:53 motivo sudo[1411]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 25 11:03:53 motivo sudo[1411]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 25 11:03:53 motivo sudo[1415]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 25 11:03:53 motivo sudo[1415]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 25 11:03:53 motivo sudo[1411]: pam_unix(sudo:session): session closed for user root Dec 25 11:03:53 motivo systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Dec 25 11:03:53 motivo systemd[1]: mpd.service: Succeeded. Dec 25 11:03:53 motivo systemd[1]: Stopped Music Player Daemon. Dec 25 11:03:53 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 11:03:53 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 25 11:03:53 motivo systemd[1]: Starting Music Player Daemon... Dec 25 11:03:53 motivo volumio[872]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 25 11:03:53 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 11:03:53 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 25 11:03:53 motivo volumio[872]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 25 11:03:53 motivo volumio[872]: info: Preparing CD Folders Dec 25 11:03:53 motivo volumio[872]: info: Adding CD REST API Endpoints Dec 25 11:03:53 motivo volumio[872]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller Dec 25 11:03:53 motivo volumio[872]: info: Starting UDEV Watcher for CD Dec 25 11:03:53 motivo volumio[872]: info: Detecting CD presence with UDEV Dec 25 11:03:53 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: networkfs , getUdevDevices Dec 25 11:03:53 motivo sudo[1424]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 25 11:03:53 motivo sudo[1424]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 25 11:03:53 motivo sudo[1424]: pam_unix(sudo:session): session closed for user root Dec 25 11:03:53 motivo volumio[872]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 25 11:03:53 motivo volumio[872]: info: [1766657033596] CoreMusicLibrary::Adding element Last_100 Dec 25 11:03:53 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 25 11:03:53 motivo volumio[872]: info: Adding qc_getconfig REST Endpoint for plugin: music_service/qobuzconnect Dec 25 11:03:53 motivo volumio[872]: info: QobuzConnect: Starting Qobuz Connect socket and service Dec 25 11:03:53 motivo volumio[872]: info: Starting RAAT Plugin Dec 25 11:03:53 motivo sudo[1449]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Dec 25 11:03:53 motivo sudo[1449]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 25 11:03:53 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , addAdditionalUISections Dec 25 11:03:53 motivo volumio[872]: info: Additional UI Settings Added for plugin music_service/raat Dec 25 11:03:53 motivo volumio[872]: info: Registering DSP Elements listener and retrieving current ones Dec 25 11:03:53 motivo volumio[872]: info: Additional DSP elements updated Dec 25 11:03:53 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 11:03:53 motivo volumio[872]: info: Updating RAAT Signal Path Dec 25 11:03:53 motivo volumio[872]: error: Cannot write to RAAT Client: TypeError: Cannot read property 'write' of undefined Dec 25 11:03:53 motivo volumio[872]: info: Streaming services startup Dec 25 11:03:53 motivo sudo[1449]: pam_unix(sudo:session): session closed for user root Dec 25 11:03:53 motivo volumio[872]: info: Starting Streaming Daemon Dec 25 11:03:53 motivo sudo[1455]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Dec 25 11:03:53 motivo sudo[1455]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 25 11:03:53 motivo sudo[1458]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Dec 25 11:03:53 motivo sudo[1458]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 25 11:03:53 motivo systemd[1]: Started Volumio Qobuz Connect Service. Dec 25 11:03:53 motivo sudo[1455]: pam_unix(sudo:session): session closed for user root Dec 25 11:03:53 motivo sudo[1458]: pam_unix(sudo:session): session closed for user root Dec 25 11:03:53 motivo volumio[872]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 25 11:03:53 motivo volumio[872]: info: [1766657033856] CoreMusicLibrary::Adding element Webradio Dec 25 11:03:53 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 25 11:03:53 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 25 11:03:53 motivo volumio[872]: info: Initializing BBC Radios Dec 25 11:03:53 motivo sudo[1474]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 25 11:03:53 motivo sudo[1474]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 25 11:03:53 motivo sudo[1474]: pam_unix(sudo:session): session closed for user root Dec 25 11:03:54 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 25 11:03:54 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 25 11:03:54 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , pushMultiRoomStatus Dec 25 11:03:54 motivo volumio[872]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Dec 25 11:03:54 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 11:03:54 motivo volumio[872]: error: Hi Res Audio Failed Login: Missing Login Data Dec 25 11:03:54 motivo volumio[872]: info: Adding HIGHRESAUDIO REST API Endpoints Dec 25 11:03:54 motivo volumio[872]: info: Adding getStreamUrlhi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Dec 25 11:03:54 motivo volumio[872]: info: Initializing Serial Communication on port /dev/ttyAMA4 Dec 25 11:03:54 motivo volumio[872]: info: Touch Event Listener Process Starting Dec 25 11:03:54 motivo systemd[1]: apt-daily.service: Succeeded. Dec 25 11:03:54 motivo kernel: uart-pl011 fe201800.serial: no DMA platform data Dec 25 11:03:54 motivo systemd[1]: Started Daily apt download activities. Dec 25 11:03:54 motivo volumio[872]: info: Refreshing QOBUZ token Dec 25 11:03:54 motivo sudo[1506]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/xinput --test-xi2 --root Dec 25 11:03:54 motivo sudo[1506]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 25 11:03:54 motivo systemd[1]: Starting Daily apt upgrade and clean activities... Dec 25 11:03:54 motivo volumio[872]: info: Adding inputs REST Endpoints Dec 25 11:03:54 motivo volumio[872]: info: Adding scanAudioInputs REST Endpoint for plugin: music_service/smart_inputs Dec 25 11:03:54 motivo volumio[872]: info: Scanning Audio Inputs Dec 25 11:03:54 motivo volumio[872]: info: Checking against Known Cards name Dec 25 11:03:54 motivo volumio[872]: info: Checking against Known Cards name Dec 25 11:03:54 motivo volumio[872]: info: Adding Server instance for streaming Dec 25 11:03:54 motivo volumio[872]: info: Volumio Calling Home Dec 25 11:03:54 motivo volumio[872]: info: QobuzConnect: Opened /tmp/qbz-connect.socket socket, listening for connections Dec 25 11:03:54 motivo volumio[872]: (node:872) [DEP0005] DeprecationWarning: Buffer() is deprecated due to security and usability issues. Please use the Buffer.alloc(), Buffer.allocUnsafe(), or Buffer.from() methods instead. Dec 25 11:03:54 motivo volumio[872]: (Use `node --trace-deprecation ...` to show where the warning was created) Dec 25 11:03:54 motivo nmbd[780]: [2025/12/25 11:03:54.405657, 0] ../lib/util/become_daemon.c:138(daemon_ready) Dec 25 11:03:54 motivo nmbd[780]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Dec 25 11:03:54 motivo systemd[1]: Started Samba NMB Daemon. Dec 25 11:03:54 motivo volumio[872]: info: Stopping AccessToken refresher cron Dec 25 11:03:54 motivo systemd[1]: Starting Samba Winbind Daemon... Dec 25 11:03:54 motivo volumio[872]: info: AccessToken refresher cron started Dec 25 11:03:54 motivo volumio[872]: info: Adding TIDAL REST API Endpoints Dec 25 11:03:54 motivo volumio[872]: info: Adding getStreamUrltidal REST Endpoint for plugin: music_service/tidal Dec 25 11:03:54 motivo volumio[872]: info: Discovery: this is already registered, 189a6d24-5a15-488b-8edc-a85c4bfac0d2 Dec 25 11:03:54 motivo volumio[872]: info: Discovery: Found device Motivo Dec 25 11:03:54 motivo volumio[872]: info: CoreCommandRouter::volumioGetState Dec 25 11:03:54 motivo volumio[872]: info: CorePlayQueue::getTrack 0 Dec 25 11:03:54 motivo volumio[872]: info: Serial port opened successfully Dec 25 11:03:54 motivo volumio[872]: info: Sending serial start messages Dec 25 11:03:54 motivo volumio[872]: info: Display with brightness control is connected, setting display brightness Dec 25 11:03:54 motivo volumio[872]: info: Setting Display Brightness to 12 Dec 25 11:03:54 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 11:03:54 motivo volumio[872]: info: Reporting MCU Network Status: 0 Dec 25 11:03:54 motivo mpd[1440]: Dec 25 11:03 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Dec 25 11:03:54 motivo systemd[1]: Started Music Player Daemon. Dec 25 11:03:54 motivo sudo[1415]: pam_unix(sudo:session): session closed for user root Dec 25 11:03:54 motivo sudo[1399]: pam_unix(sudo:session): session closed for user root Dec 25 11:03:54 motivo winbindd[1528]: [2025/12/25 11:03:54.739886, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Dec 25 11:03:54 motivo winbindd[1528]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Dec 25 11:03:54 motivo volumio[872]: error: Cannot start Volumio Streaming Daemon Dec 25 11:03:54 motivo volumio[872]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Dec 25 11:03:54 motivo volumio[872]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Dec 25 11:03:54 motivo volumio[872]: info: RAAT Albumart path created successfully Dec 25 11:03:54 motivo volumio[872]: info: MPD Permissions set Dec 25 11:03:54 motivo volumio[872]: info: MPD Permissions set Dec 25 11:03:54 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setDeviceVolumeOverride Dec 25 11:03:54 motivo volumio[872]: info: Setting Device Volume Override Dec 25 11:03:54 motivo winbindd[1528]: [2025/12/25 11:03:54.764968, 0] ../lib/util/become_daemon.c:138(daemon_ready) Dec 25 11:03:54 motivo winbindd[1528]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Dec 25 11:03:54 motivo systemd[1]: Started Samba Winbind Daemon. Dec 25 11:03:54 motivo systemd[1]: Starting Samba SMB Daemon... Dec 25 11:03:54 motivo volumio[872]: info: Applying Volume Override Dec 25 11:03:54 motivo volumio[872]: info: CoreCommandRouter::volumioUpdateVolumeSettings Dec 25 11:03:54 motivo volumio[872]: info: Updating Volume Controller Parameters: Device: 5 Name: Analog + I2S + Headphones Mixer: PCM Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Dec 25 11:03:54 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Dec 25 11:03:54 motivo volumio[872]: info: Enabling external Volume Control Dec 25 11:03:54 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: inputs , updateVolumeSettings Dec 25 11:03:54 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: inputs , retrievevolume Dec 25 11:03:54 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 11:03:54 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 11:03:54 motivo volumio[872]: info: CoreStateMachine::pushState Dec 25 11:03:54 motivo volumio[872]: info: CorePlayQueue::getTrack 0 Dec 25 11:03:54 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 25 11:03:54 motivo volumio[872]: info: CoreCommandRouter::volumioPushState Dec 25 11:03:54 motivo volumio[872]: info: CoreCommandRouter::volumioGetState Dec 25 11:03:54 motivo volumio[872]: info: CorePlayQueue::getTrack 0 Dec 25 11:03:54 motivo volumio[872]: info: MRS: Pushing multiroomSync output update for this device Dec 25 11:03:54 motivo volumio[872]: info: MRS: Pushing multiroomSync output Dec 25 11:03:55 motivo volumio[872]: info: Executing endpoint qc_getconfig Dec 25 11:03:55 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Dec 25 11:03:55 motivo qobuz-connect[1467]: 20251225 11:03:55.019 [1467.1467] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Dec 25 11:03:55 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: system , setAdditionalSVInfo Dec 25 11:03:55 motivo volumio[872]: info: Setting Additional System Software info: Hardware Revision: 2.2 Dec 25 11:03:55 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: system , setHwFwVersion Dec 25 11:03:55 motivo volumio[872]: info: Setting HW Firmware info: undefined Dec 25 11:03:55 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: system , setHwVersion Dec 25 11:03:55 motivo volumio[872]: info: Setting HW Version info: 2.2 Dec 25 11:03:55 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: system , setAdditionalSVInfo Dec 25 11:03:55 motivo volumio[872]: info: Setting Additional System Software info: Hardware Revision: 2.2, Firmware Version: 0.1.9 Dec 25 11:03:55 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: system , setHwFwVersion Dec 25 11:03:55 motivo volumio[872]: info: Setting HW Firmware info: 0.1.9 Dec 25 11:03:55 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: system , setHwVersion Dec 25 11:03:55 motivo volumio[872]: info: Setting HW Version info: 2.2 Dec 25 11:03:55 motivo volumio[872]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Dec 25 11:03:55 motivo volumio[872]: info: MCU Signalled Headphone Mode Disabled Dec 25 11:03:55 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: raat , reportHeadphoneState Dec 25 11:03:55 motivo volumio[872]: info: Reporting Headphone State: false Dec 25 11:03:55 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 11:03:55 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 11:03:55 motivo volumio[872]: info: Updating RAAT Signal Path Dec 25 11:03:55 motivo volumio[872]: error: Cannot write to RAAT Client: TypeError: Cannot read property 'write' of undefined Dec 25 11:03:55 motivo volumio[872]: info: MCU Signalled Sleep Mode Disabled Dec 25 11:03:55 motivo volumio[872]: info: Enabling Advanced system settings configuration Dec 25 11:03:55 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: system , addAdditionalUISections Dec 25 11:03:55 motivo volumio[872]: info: Additional UI Settings Added for plugin music_service/inputs Dec 25 11:03:55 motivo volumio[872]: info: MCU Signalled Auto Boot Mode On Power Disabled Dec 25 11:03:55 motivo qobuz-connect[1467]: 20251225 11:03:55.120 [1467.1467] INFO VolumeManager: [0x139c958]: Setting new playback volume: 75 Dec 25 11:03:55 motivo qobuz-connect[1467]: 20251225 11:03:55.120 [1467.1467] INFO VolumeManager: [0x139c958]: Setting new mute state: 0 Dec 25 11:03:55 motivo qobuz-connect[1467]: 20251225 11:03:55.121 [1467.1467] INFO QobuzConnect: [0x139d328]: Client initialized! Dec 25 11:03:55 motivo qobuz-connect[1467]: 20251225 11:03:55.121 [1467.1467] INFO SampleApp: Starting Avahi advertising, name: Motivo, service name: _qobuz-connect._tcp Dec 25 11:03:55 motivo qobuz-connect[1467]: 20251225 11:03:55.136 [1467.1467] INFO LocalConfigManager: [0x139c238]: Starting Local Configuration server Dec 25 11:03:55 motivo qobuz-connect[1467]: 20251225 11:03:55.136 [1467.1467] INFO SampleApp: Starting Local configuration server Dec 25 11:03:55 motivo qobuz-connect[1467]: 20251225 11:03:55.137 [1467.1467] INFO SampleApp: Connected to UNIX socket client 0x1391f60 Dec 25 11:03:55 motivo sudo[1583]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/xset dpms force on Dec 25 11:03:55 motivo qobuz-connect[1467]: 20251225 11:03:55.170 [1467.1467] INFO SampleApp: Playback volume changed: 75 Dec 25 11:03:55 motivo sudo[1583]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 25 11:03:55 motivo systemd[1]: apt-daily-upgrade.service: Succeeded. Dec 25 11:03:55 motivo systemd[1]: Started Daily apt upgrade and clean activities. Dec 25 11:03:55 motivo sudo[1583]: pam_unix(sudo:session): session closed for user root Dec 25 11:03:55 motivo volumio[872]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Dec 25 11:03:55 motivo volumio[872]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Dec 25 11:03:55 motivo volumio[872]: info: QobuzConnect: QOBUZ Connect daemon connected Dec 25 11:03:55 motivo volumio[872]: info: Volumio called home Dec 25 11:03:55 motivo smbd[1556]: [2025/12/25 11:03:55.292513, 0] ../lib/util/become_daemon.c:138(daemon_ready) Dec 25 11:03:55 motivo smbd[1556]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Dec 25 11:03:55 motivo systemd[1]: Started Samba SMB Daemon. Dec 25 11:03:55 motivo systemd[1]: Reached target Multi-User System. Dec 25 11:03:55 motivo systemd[1]: Reached target Graphical Interface. Dec 25 11:03:55 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 11:03:55 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 11:03:55 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 11:03:55 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 11:03:55 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 11:03:55 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 11:03:55 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 11:03:55 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 11:03:55 motivo systemd[1]: Starting Update UTMP about System Runlevel Changes... Dec 25 11:03:55 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 25 11:03:55 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 11:03:55 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 11:03:55 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 11:03:55 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 11:03:55 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 11:03:55 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 11:03:55 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 11:03:55 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 11:03:55 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 11:03:55 motivo systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Dec 25 11:03:55 motivo systemd[1]: Started Update UTMP about System Runlevel Changes. Dec 25 11:03:55 motivo systemd[1]: Startup finished in 13.255s (kernel) + 30.746s (userspace) = 44.001s. Dec 25 11:03:55 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 25 11:03:55 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 11:03:55 motivo volumio[872]: error: Serial API: Failed to decode command: MAXVOL, message: 100 Dec 25 11:03:55 motivo volumio[872]: error: Serial API: Failed to decode command: MAXVOL, message: 100 Dec 25 11:03:55 motivo volumio[872]: error: MPD error: The expression evaluated to a falsy value: Dec 25 11:03:55 motivo volumio[872]: assert.ok(self.idling) Dec 25 11:03:55 motivo volumio[872]: error: The expression evaluated to a falsy value: Dec 25 11:03:55 motivo volumio[872]: assert.ok(self.idling) Dec 25 11:03:55 motivo volumio[872]: info: CoreCommandRouter::volumioGetState Dec 25 11:03:55 motivo volumio[872]: info: CorePlayQueue::getTrack 0 Dec 25 11:03:55 motivo volumio[872]: info: MPD running with PID1440 Dec 25 11:03:55 motivo volumio[872]: ,establishing connection Dec 25 11:03:55 motivo sudo[1608]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/xset dpms 0 0 0 Dec 25 11:03:55 motivo sudo[1608]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 25 11:03:55 motivo sudo[1608]: pam_unix(sudo:session): session closed for user root Dec 25 11:03:55 motivo volumio[872]: error: updateQueue error: null Dec 25 11:03:55 motivo volumio[872]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Dec 25 11:03:55 motivo volumio[872]: info: Starting Shairport Sync Dec 25 11:03:55 motivo volumio[872]: info: Starting Shairport Sync Dec 25 11:03:55 motivo volumio[872]: info: Starting Shairport Sync Dec 25 11:03:55 motivo sudo[1611]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 25 11:03:55 motivo sudo[1611]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 25 11:03:55 motivo sudo[1613]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 25 11:03:55 motivo sudo[1613]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 25 11:03:55 motivo volumio[872]: info: Adding Inputs via Serial API Dec 25 11:03:55 motivo sudo[1617]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 25 11:03:55 motivo sudo[1617]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 25 11:03:55 motivo systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Dec 25 11:03:55 motivo systemd[1]: shairport-sync.service: Succeeded. Dec 25 11:03:55 motivo systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Dec 25 11:03:55 motivo volumio[872]: info: Adding Advanced Audio Settings via Serial API Dec 25 11:03:55 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , addAdditionalUISections Dec 25 11:03:55 motivo volumio[872]: info: Additional UI Settings Added for plugin music_service/inputs Dec 25 11:03:55 motivo volumio[872]: info: Adding Advanced Audio Settings via Serial API Dec 25 11:03:55 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , addAdditionalUISections Dec 25 11:03:55 motivo volumio[872]: error: updateQueue error: null Dec 25 11:03:55 motivo systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Dec 25 11:03:55 motivo sudo[1613]: pam_unix(sudo:session): session closed for user root Dec 25 11:03:55 motivo systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Dec 25 11:03:55 motivo systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Dec 25 11:03:55 motivo systemd[1]: shairport-sync.service: Succeeded. Dec 25 11:03:55 motivo volumio[872]: info: Access Token successfully retrieved Dec 25 11:03:55 motivo volumio[872]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 25 11:03:55 motivo volumio[872]: info: [1766657035779] CoreMusicLibrary::Adding element QOBUZ Dec 25 11:03:55 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 25 11:03:55 motivo systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Dec 25 11:03:55 motivo volumio[872]: Cannot find translation for source QOBUZ Dec 25 11:03:55 motivo volumio[872]: info: Stopping AccessToken refresher cron for QOBUZ Dec 25 11:03:55 motivo systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Dec 25 11:03:55 motivo sudo[1611]: pam_unix(sudo:session): session closed for user root Dec 25 11:03:55 motivo sudo[1617]: pam_unix(sudo:session): session closed for user root Dec 25 11:03:55 motivo volumio[872]: info: AccessToken refresher cron started for QOBUZ Dec 25 11:03:55 motivo volumio[872]: info: Adding QOBUZ REST API Endpoints Dec 25 11:03:55 motivo volumio[872]: info: Adding getStreamUrlqobuz REST Endpoint for plugin: music_service/qobuz Dec 25 11:03:55 motivo volumio[872]: info: CoreCommandRouter::volumioGetState Dec 25 11:03:55 motivo volumio[872]: info: CorePlayQueue::getTrack 0 Dec 25 11:03:55 motivo volumio[872]: info: MRS: Found cast device: S700D-eac77bb3f5fb97dfaa4ae8d353c4a6a0 Dec 25 11:03:55 motivo volumio[872]: info: Adding audio output: Dec 25 11:03:55 motivo volumio[872]: info: CoreStateMachine::pushState Dec 25 11:03:55 motivo volumio[872]: info: CorePlayQueue::getTrack 0 Dec 25 11:03:55 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 25 11:03:55 motivo volumio[872]: info: CoreCommandRouter::volumioPushState Dec 25 11:03:55 motivo volumio[872]: info: CoreCommandRouter::volumioGetState Dec 25 11:03:55 motivo volumio[872]: info: CorePlayQueue::getTrack 0 Dec 25 11:03:55 motivo volumio[872]: info: MRS: Pushing multiroomSync output update for this device Dec 25 11:03:55 motivo volumio[872]: info: MRS: Pushing multiroomSync output Dec 25 11:03:55 motivo volumio[872]: info: CoreStateMachine::pushState Dec 25 11:03:55 motivo volumio[872]: info: CorePlayQueue::getTrack 0 Dec 25 11:03:55 motivo volumio[872]: info: CoreCommandRouter::volumioPushState Dec 25 11:03:55 motivo volumio[872]: info: CoreCommandRouter::volumioGetState Dec 25 11:03:55 motivo volumio[872]: info: CorePlayQueue::getTrack 0 Dec 25 11:03:55 motivo volumio[872]: info: MRS: Pushing multiroomSync output update for this device Dec 25 11:03:55 motivo volumio[872]: info: MRS: Pushing multiroomSync output Dec 25 11:03:55 motivo volumio[872]: info: CoreCommandRouter::servicePushState Dec 25 11:03:55 motivo volumio[872]: info: CorePlayQueue::getTrack 0 Dec 25 11:03:55 motivo volumio[872]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current qobuz Received inputs Dec 25 11:03:55 motivo volumio[872]: info: CoreCommandRouter::volumiosetSourceActiveno-source Dec 25 11:03:55 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 25 11:03:55 motivo volumio[872]: Cannot find translation for source QOBUZ Dec 25 11:03:55 motivo volumio[872]: info: Shairport-Sync Started Dec 25 11:03:55 motivo volumio[872]: Error adding Membership: Error: addMembership EINVAL Dec 25 11:03:55 motivo volumio[872]: info: Shairport-Sync Started Dec 25 11:03:55 motivo volumio[872]: info: Shairport-Sync Started Dec 25 11:03:55 motivo volumio[872]: info: CoreCommandRouter::volumioGetState Dec 25 11:03:55 motivo volumio[872]: info: CorePlayQueue::getTrack 0 Dec 25 11:03:55 motivo volumio[1388]: Generating RSA private key, 4096 bit long modulus (2 primes) Dec 25 11:03:56 motivo volumio[872]: Upnp client error: Error: read ECONNRESET Dec 25 11:03:56 motivo volumio[872]: info: MCU Signalled Playback Inactive Dec 25 11:03:56 motivo volumio[872]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: volumiokiosk-touch Engine version: 3 Transport: polling Total Clients: 4 Dec 25 11:03:56 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 25 11:03:56 motivo volumio[872]: info: TidalConnect service stoped! Dec 25 11:03:57 motivo volumio[872]: info: Adding tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Dec 25 11:03:57 motivo volumio[872]: info: Adding tc_connect REST Endpoint for plugin: music_service/tidalconnect Dec 25 11:03:57 motivo sudo[1650]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Dec 25 11:03:57 motivo sudo[1650]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 25 11:03:57 motivo systemd[1]: Started Volumio Tidal Connect Service. Dec 25 11:03:57 motivo sudo[1650]: pam_unix(sudo:session): session closed for user root Dec 25 11:03:57 motivo volumio[872]: info: Initializing I2S Bus Dec 25 11:03:57 motivo volumio[872]: info: Executing endpoint tc_getconfig Dec 25 11:03:57 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Dec 25 11:03:57 motivo vtcs[1652]: STARTING TidalConnect services, version: 1.5.1-beta1 Dec 25 11:03:57 motivo vtcs[1652]: STARTED TidalConnect services. Dec 25 11:03:57 motivo volumio[872]: info: Executing endpoint tc_connect Dec 25 11:03:57 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Dec 25 11:03:57 motivo volumio[872]: info: Connecting to TidalConnect Dec 25 11:03:57 motivo volumio[872]: info: CoreCommandRouter::servicePushState Dec 25 11:03:57 motivo volumio[872]: info: CoreStateMachine::pushState Dec 25 11:03:57 motivo volumio[872]: info: CorePlayQueue::getTrack 0 Dec 25 11:03:57 motivo volumio[872]: info: CoreCommandRouter::volumioPushState Dec 25 11:03:57 motivo volumio[872]: info: CoreCommandRouter::volumioGetState Dec 25 11:03:57 motivo volumio[872]: info: CorePlayQueue::getTrack 0 Dec 25 11:03:57 motivo volumio[872]: info: MRS: Pushing multiroomSync output update for this device Dec 25 11:03:57 motivo volumio[872]: info: MRS: Pushing multiroomSync output Dec 25 11:03:57 motivo volumio[872]: info: CorePlayQueue::getTrack 0 Dec 25 11:03:57 motivo volumio[872]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current qobuz Received tidalconnect Dec 25 11:03:57 motivo volumio[872]: info: CoreCommandRouter::servicePushState Dec 25 11:03:57 motivo volumio[872]: info: CoreStateMachine::pushState Dec 25 11:03:57 motivo volumio[872]: info: CorePlayQueue::getTrack 0 Dec 25 11:03:57 motivo volumio[872]: info: CoreCommandRouter::volumioPushState Dec 25 11:03:57 motivo volumio[872]: info: CoreCommandRouter::volumioGetState Dec 25 11:03:57 motivo volumio[872]: info: CorePlayQueue::getTrack 0 Dec 25 11:03:57 motivo volumio[872]: info: MRS: Pushing multiroomSync output update for this device Dec 25 11:03:57 motivo volumio[872]: info: MRS: Pushing multiroomSync output Dec 25 11:03:57 motivo volumio[872]: info: CorePlayQueue::getTrack 0 Dec 25 11:03:57 motivo volumio[872]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current qobuz Received tidalconnect Dec 25 11:03:57 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 25 11:03:57 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 25 11:03:57 motivo volumio[872]: info: Discovery: Getting this device information Dec 25 11:03:57 motivo volumio[872]: info: CoreCommandRouter::volumioGetState Dec 25 11:03:57 motivo volumio[872]: info: CorePlayQueue::getTrack 0 Dec 25 11:03:57 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 25 11:03:57 motivo volumio[872]: verbose: New Socket.io Connection to 192.168.0.108:3000 from 192.168.0.113 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 5 Dec 25 11:03:57 motivo volumio[872]: info: CoreCommandRouter::volumioGetState Dec 25 11:03:57 motivo volumio[872]: info: CorePlayQueue::getTrack 0 Dec 25 11:03:57 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 25 11:03:57 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 25 11:03:57 motivo volumio[872]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: volumiokiosk-touch Engine version: 3 Transport: polling Total Clients: 6 Dec 25 11:03:57 motivo systemd[1]: systemd-fsckd.service: Succeeded. Dec 25 11:03:58 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 25 11:03:58 motivo volumio[872]: info: Successfully initialized Motivo I2S Bus Dec 25 11:03:58 motivo volumio[872]: info: CoreCommandRouter::volumioGetVisibleSources Dec 25 11:03:58 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 25 11:03:58 motivo volumio[872]: info: CoreCommandRouter::volumioGetState Dec 25 11:03:58 motivo volumio[872]: info: CorePlayQueue::getTrack 0 Dec 25 11:03:58 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Dec 25 11:03:58 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 25 11:03:58 motivo volumio[872]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Dec 25 11:03:58 motivo volumio[872]: info: Received Get System Info Dec 25 11:03:58 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 25 11:03:58 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 25 11:03:58 motivo volumio[872]: info: Discovery: Getting this device information Dec 25 11:03:58 motivo volumio[872]: info: CoreCommandRouter::volumioGetState Dec 25 11:03:58 motivo volumio[872]: info: CorePlayQueue::getTrack 0 Dec 25 11:03:58 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 25 11:03:58 motivo volumio[872]: info: CoreCommandRouter::volumioGetState Dec 25 11:03:58 motivo volumio[872]: info: CorePlayQueue::getTrack 0 Dec 25 11:03:58 motivo volumio[872]: info: Listing playlists Dec 25 11:03:58 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 25 11:03:58 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 25 11:03:59 motivo volumio[872]: info: MRS: Getting audio outputs on start Dec 25 11:03:59 motivo volumio[872]: info: MRS: Requesting all other devices output Dec 25 11:03:59 motivo volumio[872]: info: CoreCommandRouter::volumioGetState Dec 25 11:03:59 motivo volumio[872]: info: CorePlayQueue::getTrack 0 Dec 25 11:03:59 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 25 11:03:59 motivo volumio[872]: info: Received Get System Info Dec 25 11:03:59 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 25 11:03:59 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 25 11:03:59 motivo volumio[872]: info: Discovery: Getting this device information Dec 25 11:03:59 motivo volumio[872]: info: CoreCommandRouter::volumioGetState Dec 25 11:03:59 motivo volumio[872]: info: CorePlayQueue::getTrack 0 Dec 25 11:03:59 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 25 11:03:59 motivo volumio[872]: info: Reporting MCU Network Status: 1 Dec 25 11:03:59 motivo volumio[872]: info: Volumio Network Manager: Network status updated: 1 Dec 25 11:04:00 motivo volumio[872]: info: TidalConnect service started! Dec 25 11:04:00 motivo volumio[872]: info: Completed starting Core Plugins Dec 25 11:04:00 motivo volumio[872]: info: ------------------------------------------- Dec 25 11:04:00 motivo volumio[872]: info: ----- MyVolumio plugins startup ---- Dec 25 11:04:00 motivo volumio[872]: info: ------------------------------------------- Dec 25 11:04:00 motivo volumio[872]: info: [MyVolumio PluginManager] Fetching plans data.... Dec 25 11:04:00 motivo volumio[872]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Dec 25 11:04:00 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Dec 25 11:04:01 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 25 11:04:01 motivo volumio[872]: info: Received Get System Info Dec 25 11:04:01 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 25 11:04:01 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 25 11:04:01 motivo volumio[872]: info: Discovery: Getting this device information Dec 25 11:04:01 motivo volumio[872]: info: CoreCommandRouter::volumioGetState Dec 25 11:04:01 motivo volumio[872]: info: CorePlayQueue::getTrack 0 Dec 25 11:04:01 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 25 11:04:01 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Dec 25 11:04:01 motivo volumio[1388]: ................................................................++++ Dec 25 11:04:02 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 25 11:04:02 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 25 11:04:02 motivo volumio[872]: info: Discovery: Getting this device information Dec 25 11:04:02 motivo volumio[872]: info: CoreCommandRouter::volumioGetState Dec 25 11:04:02 motivo volumio[872]: info: CorePlayQueue::getTrack 0 Dec 25 11:04:02 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 25 11:04:02 motivo volumio[872]: info: CoreCommandRouter::volumioGetState Dec 25 11:04:02 motivo volumio[872]: info: CorePlayQueue::getTrack 0 Dec 25 11:04:02 motivo volumio[872]: verbose: New Socket.io Connection to 192.168.0.108:3000 from 192.168.0.113 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 7 Dec 25 11:04:03 motivo volumio[872]: info: CoreCommandRouter::volumioGetState Dec 25 11:04:03 motivo volumio[872]: info: CorePlayQueue::getTrack 0 Dec 25 11:04:03 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 25 11:04:03 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 25 11:04:03 motivo volumio[872]: info: CoreCommandRouter::volumioGetState Dec 25 11:04:03 motivo volumio[872]: info: CorePlayQueue::getTrack 0 Dec 25 11:04:03 motivo sudo[1688]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 25 11:04:03 motivo sudo[1688]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 25 11:04:03 motivo sudo[1688]: pam_unix(sudo:session): session closed for user root Dec 25 11:04:03 motivo sudo[1691]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 25 11:04:03 motivo sudo[1691]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 25 11:04:03 motivo sudo[1691]: pam_unix(sudo:session): session closed for user root Dec 25 11:04:03 motivo volumio[872]: verbose: New Socket.io Connection to 192.168.0.108 from 192.168.0.113 UA: Mozilla/5.0 (Linux; Android 16; SM-S918B Build/BP2A.250605.031.A3; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/143.0.7499.35 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Dec 25 11:04:03 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 25 11:04:03 motivo sudo[1694]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 25 11:04:03 motivo sudo[1694]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 25 11:04:03 motivo sudo[1694]: pam_unix(sudo:session): session closed for user root Dec 25 11:04:03 motivo sudo[1696]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 25 11:04:03 motivo sudo[1696]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 25 11:04:03 motivo sudo[1696]: pam_unix(sudo:session): session closed for user root Dec 25 11:04:03 motivo volumio[872]: verbose: New Socket.io Connection to 192.168.0.108 from 192.168.0.113 UA: Mozilla/5.0 (Linux; Android 16; SM-S918B Build/BP2A.250605.031.A3; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/143.0.7499.35 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Dec 25 11:04:04 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 25 11:04:04 motivo volumio[872]: info: CoreCommandRouter::volumioGetVisibleSources Dec 25 11:04:04 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 25 11:04:04 motivo volumio[872]: info: CoreCommandRouter::volumioGetState Dec 25 11:04:04 motivo volumio[872]: info: CorePlayQueue::getTrack 0 Dec 25 11:04:04 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Dec 25 11:04:04 motivo volumio[872]: info: CoreCommandRouter::volumioGetQueue Dec 25 11:04:04 motivo volumio[872]: info: CoreStateMachine::getQueue Dec 25 11:04:04 motivo volumio[872]: info: CorePlayQueue::getQueue Dec 25 11:04:04 motivo volumio[872]: info: Listing playlists Dec 25 11:04:04 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 25 11:04:04 motivo volumio[872]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Dec 25 11:04:04 motivo volumio[872]: info: Received Get System Info Dec 25 11:04:04 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 25 11:04:04 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 25 11:04:04 motivo volumio[872]: info: Discovery: Getting this device information Dec 25 11:04:04 motivo volumio[872]: info: CoreCommandRouter::volumioGetState Dec 25 11:04:04 motivo volumio[872]: info: CorePlayQueue::getTrack 0 Dec 25 11:04:04 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 25 11:04:04 motivo volumio[872]: info: CoreCommandRouter::volumioGetState Dec 25 11:04:04 motivo volumio[872]: info: CorePlayQueue::getTrack 0 Dec 25 11:04:04 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 25 11:04:04 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 25 11:04:04 motivo systemd[1]: systemd-hostnamed.service: Succeeded. Dec 25 11:04:04 motivo volumio[872]: info: Checking for updated MCU Firmware Dec 25 11:04:04 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 25 11:04:04 motivo volumio[872]: info: Firware on device is on latest version, no need to update Dec 25 11:04:05 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Dec 25 11:04:05 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 25 11:04:05 motivo volumio[872]: info: Received Get System Info Dec 25 11:04:05 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 25 11:04:05 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 25 11:04:05 motivo volumio[872]: info: Discovery: Getting this device information Dec 25 11:04:05 motivo volumio[872]: info: CoreCommandRouter::volumioGetState Dec 25 11:04:05 motivo volumio[872]: info: CorePlayQueue::getTrack 0 Dec 25 11:04:05 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 25 11:04:06 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Dec 25 11:04:06 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 25 11:04:06 motivo volumio[872]: info: Received Get System Info Dec 25 11:04:06 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 25 11:04:06 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 25 11:04:06 motivo volumio[872]: info: Discovery: Getting this device information Dec 25 11:04:06 motivo volumio[872]: info: CoreCommandRouter::volumioGetState Dec 25 11:04:06 motivo volumio[872]: info: CorePlayQueue::getTrack 0 Dec 25 11:04:06 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 25 11:04:07 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Dec 25 11:04:07 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Dec 25 11:04:08 motivo volumio[872]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Dec 25 11:04:08 motivo volumio[872]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Dec 25 11:04:08 motivo volumio[872]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Dec 25 11:04:08 motivo volumio[872]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Dec 25 11:04:08 motivo volumio[872]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Dec 25 11:04:08 motivo volumio[872]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Dec 25 11:04:08 motivo volumio[872]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Dec 25 11:04:08 motivo volumio[872]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Dec 25 11:04:08 motivo volumio[872]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Dec 25 11:04:08 motivo volumio[872]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Dec 25 11:04:08 motivo volumio[872]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Dec 25 11:04:08 motivo volumio[872]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Dec 25 11:04:08 motivo volumio[872]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Dec 25 11:04:08 motivo volumio[872]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Dec 25 11:04:08 motivo volumio[872]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Dec 25 11:04:08 motivo volumio[872]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Dec 25 11:04:08 motivo volumio[872]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Dec 25 11:04:08 motivo volumio[872]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Dec 25 11:04:08 motivo volumio[872]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Dec 25 11:04:08 motivo volumio[872]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Dec 25 11:04:08 motivo volumio[872]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Dec 25 11:04:08 motivo volumio[872]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Dec 25 11:04:08 motivo volumio[872]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Dec 25 11:04:08 motivo volumio[872]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Dec 25 11:04:08 motivo volumio[872]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Dec 25 11:04:08 motivo volumio[872]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Dec 25 11:04:08 motivo volumio[872]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Dec 25 11:04:08 motivo volumio[872]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Dec 25 11:04:08 motivo volumio[872]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Dec 25 11:04:09 motivo volumio[872]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Dec 25 11:04:09 motivo volumio[872]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Dec 25 11:04:09 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 25 11:04:09 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 25 11:04:09 motivo volumio[872]: info: Starting MyVolumio Remote Streaming Endpoints Dec 25 11:04:09 motivo volumio[872]: info: MyVolumio login type: Token Dec 25 11:04:09 motivo volumio[872]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Dec 25 11:04:09 motivo volumio[872]: 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' Dec 25 11:04:10 motivo volumio[872]: error: MyVolumio Custom Token format not valid, refreshing it Dec 25 11:04:10 motivo volumio[872]: info: MyVolumio login type: Token Dec 25 11:04:11 motivo volumio[872]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Dec 25 11:04:11 motivo volumio[872]: info: MyVolumio token set successfully Dec 25 11:04:11 motivo volumio[872]: info: MYVOLUMIO: Adding device Dec 25 11:04:11 motivo volumio[872]: info: MYVOLUMIO: Evaluating Server Dec 25 11:04:12 motivo volumio[872]: info: MyVolumio status changed Dec 25 11:04:12 motivo volumio[872]: info: Streaming services startup Dec 25 11:04:12 motivo volumio[872]: info: Starting Streaming Daemon Dec 25 11:04:12 motivo volumio[872]: info: Removing browser output: myVolumio user plan is not superstar Dec 25 11:04:12 motivo volumio[872]: info: Removing audio output: Dec 25 11:04:12 motivo volumio[872]: info: Stoppping Tunnel 1 Dec 25 11:04:12 motivo sudo[1737]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Dec 25 11:04:12 motivo sudo[1737]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 25 11:04:12 motivo sudo[1739]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Dec 25 11:04:12 motivo sudo[1739]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 25 11:04:12 motivo sudo[1737]: pam_unix(sudo:session): session closed for user root Dec 25 11:04:12 motivo volumio[872]: error: Cannot start Volumio Streaming Daemon Dec 25 11:04:12 motivo volumio[872]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Dec 25 11:04:12 motivo volumio[872]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Dec 25 11:04:12 motivo sudo[1739]: pam_unix(sudo:session): session closed for user root Dec 25 11:04:12 motivo volumio[872]: info: Remote SSH Stopped Dec 25 11:04:12 motivo volumio[872]: info: Setting Geolocation for MyVolumio to eu11 Dec 25 11:04:12 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 25 11:04:12 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 25 11:04:12 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 25 11:04:13 motivo volumio[872]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Dec 25 11:04:13 motivo volumio[872]: info: Updating MyVolumio device info Dec 25 11:04:13 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 25 11:04:13 motivo volumio[872]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Dec 25 11:04:14 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Dec 25 11:04:15 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 25 11:04:15 motivo volumio[872]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Dec 25 11:04:15 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Dec 25 11:04:15 motivo volumio[872]: info: Received Get System Version Dec 25 11:04:15 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 25 11:04:15 motivo volumio[872]: info: Received Get System Info Dec 25 11:04:15 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 25 11:04:15 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 25 11:04:15 motivo volumio[872]: info: Discovery: Getting this device information Dec 25 11:04:15 motivo volumio[872]: info: CoreCommandRouter::volumioGetState Dec 25 11:04:15 motivo volumio[872]: info: CorePlayQueue::getTrack 0 Dec 25 11:04:15 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 25 11:04:17 motivo volumio[872]: info: MYVOLUMIO: Adding device Dec 25 11:04:17 motivo volumio[872]: info: MYVOLUMIO: Evaluating Server Dec 25 11:04:17 motivo volumio[872]: info: Setting Geolocation for MyVolumio to eu11 Dec 25 11:04:17 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 25 11:04:17 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 25 11:04:17 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 25 11:04:18 motivo volumio[872]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Dec 25 11:04:18 motivo volumio[872]: info: Updating MyVolumio device info Dec 25 11:04:18 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 25 11:04:18 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 25 11:04:18 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 25 11:04:19 motivo volumio[872]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Dec 25 11:04:20 motivo volumio[872]: error: MyVolumio Plugin failed to start in a timely fashion Dec 25 11:04:20 motivo volumio[872]: [Metrics] CommandRouter: 42s 651.11ms Dec 25 11:04:20 motivo volumio[872]: info: CoreCommandRouter::volumiosetStartupVolume Dec 25 11:04:20 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 25 11:04:20 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 25 11:04:20 motivo volumio[872]: info: CoreCommandRouter::Close All Modals sent Dec 25 11:04:21 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Dec 25 11:04:21 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 25 11:04:21 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Dec 25 11:04:22 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 25 11:04:22 motivo volumio[872]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Dec 25 11:04:22 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Dec 25 11:04:22 motivo volumio[872]: info: Received Get System Version Dec 25 11:04:22 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 25 11:04:22 motivo volumio[872]: info: Received Get System Info Dec 25 11:04:22 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 25 11:04:22 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 25 11:04:22 motivo volumio[872]: info: Discovery: Getting this device information Dec 25 11:04:22 motivo volumio[872]: info: CoreCommandRouter::volumioGetState Dec 25 11:04:22 motivo volumio[872]: info: CorePlayQueue::getTrack 0 Dec 25 11:04:22 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 25 11:04:23 motivo systemd[1]: systemd-timedated.service: Succeeded. Dec 25 11:04:23 motivo volumio[872]: info: CoreCommandRouter::executeOnPlugin: metavolumio , superSearch Dec 25 11:04:23 motivo volumio[872]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 25 11:04:23 motivo volumio[872]: TypeError: Cannot read property 'then' of undefined Dec 25 11:04:23 motivo volumio[872]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:498:20) Dec 25 11:04:23 motivo volumio[872]: at Socket.emit (events.js:315:20) Dec 25 11:04:23 motivo volumio[872]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Dec 25 11:04:23 motivo volumio[872]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Dec 25 11:04:23 motivo volumio[872]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 25 11:04:24 motivo sudo[1792]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-25 11:03 Dec 25 11:04:24 motivo sudo[1792]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="a142ed2648fb91920de0dde3a60cd39b5d0ba4f6" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="04c18c158cc4bac70764c3360b25fcce0c69266a" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="motivo" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 10 Jun 2025 07:55:53 PM CEST" VOLUMIO_VERSION="3.816" VOLUMIO_HARDWARE="cm4" VOLUMIO_DEVICENAME="CM4" VOLUMIO_VENDOR_MODEL="Volumio Motivo" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Motivo" VOLUMIO_HASH="47546d7431a0ac02b252b63cc0168466"