-- Logs begin at Thu 2024-04-25 19:07:42 CEST, end at Thu 2024-04-25 19:10:55 CEST. --
Apr 25 19:09:01 rivo volumio[4995]: info: Starting UPNP Playback
Apr 25 19:09:01 rivo volumio[4995]: info: Preparing playback through UPNP
Apr 25 19:09:01 rivo volumio[4995]: info: Consume mode
Apr 25 19:09:01 rivo volumio[4995]: info: CoreCommandRouter::volumioGetState
Apr 25 19:09:01 rivo volumio[4995]: info: CoreStateMachine::setConsumeUpdateService mpd
Apr 25 19:09:01 rivo volumio[4995]: error: updateQueue error: null
Apr 25 19:09:02 rivo volumio[4995]: info: Starting UPNP Playback
Apr 25 19:09:02 rivo volumio[4995]: info: Preparing playback through UPNP
Apr 25 19:09:02 rivo volumio[4995]: info: Consume mode
Apr 25 19:09:02 rivo volumio[4995]: info: CoreCommandRouter::volumioGetState
Apr 25 19:09:02 rivo volumio[4995]: info: CoreStateMachine::setConsumeUpdateService mpd
Apr 25 19:09:20 rivo kernel: usb 1-1.4.2: USB disconnect, device number 5
Apr 25 19:09:20 rivo thd[4535]: Error reading device '/dev/input/event5'
Apr 25 19:09:20 rivo volumio[4995]: info:
Apr 25 19:09:20 rivo volumio[4995]: ---------------------------- USB Audio Device Detached
Apr 25 19:09:20 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach
Apr 25 19:09:20 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Apr 25 19:09:20 rivo volumio[4995]: No protocol specified
Apr 25 19:09:20 rivo volumio[4995]: xcb_connection_has_error() returned true
Apr 25 19:09:20 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: raat , onStop
Apr 25 19:09:20 rivo volumio[4995]: info: Stopping RAAT Plugin
Apr 25 19:09:20 rivo sudo[7256]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop raat-daemon.service
Apr 25 19:09:20 rivo sudo[7256]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 25 19:09:20 rivo systemd[1]: Stopping RAAT DAEMON...
Apr 25 19:09:20 rivo systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM
Apr 25 19:09:20 rivo systemd[1]: raat-daemon.service: Succeeded.
Apr 25 19:09:20 rivo systemd[1]: Stopped RAAT DAEMON.
Apr 25 19:09:20 rivo volumio[4995]: ------------------------------------ BT MESSAGE: BT STATUS: running
Apr 25 19:09:20 rivo sudo[7256]: pam_unix(sudo:session): session closed for user root
Apr 25 19:09:20 rivo volumio[4995]: info: Raat Daemon stopped successfully
Apr 25 19:09:23 rivo kernel: usb 1-1.4.2: new high-speed USB device number 6 using xhci-hcd
Apr 25 19:09:28 rivo kernel: usb 1-1.4.2: new high-speed USB device number 7 using xhci-hcd
Apr 25 19:09:28 rivo kernel: usb 1-1.4.2: New USB device found, idVendor=2d87, idProduct=000a
Apr 25 19:09:28 rivo kernel: usb 1-1.4.2: New USB device strings: Mfr=1, Product=3, SerialNumber=0
Apr 25 19:09:28 rivo kernel: usb 1-1.4.2: Product: Cayin iDAC-6
Apr 25 19:09:28 rivo kernel: usb 1-1.4.2: Manufacturer: Cayin
Apr 25 19:09:28 rivo kernel: usb 1-1.4.2: Unsupported device
Apr 25 19:09:28 rivo kernel: input: Cayin Cayin iDAC-6 as /devices/platform/ff500000.dwc3/xhci-hcd.0.auto/usb1/1-1/1-1.4/1-1.4.2/1-1.4.2:1.3/0003:2D87:000A.0002/input/input7
Apr 25 19:09:28 rivo kernel: hid-generic 0003:2D87:000A.0002: input,hidraw0: USB HID v1.10 Device [Cayin Cayin iDAC-6] on usb-xhci-hcd.0.auto-1.4.2/input3
Apr 25 19:09:28 rivo volumio[4995]: info:
Apr 25 19:09:28 rivo volumio[4995]: ---------------------------- USB Audio Device Attached
Apr 25 19:09:28 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach
Apr 25 19:09:28 rivo volumio[4995]: No protocol specified
Apr 25 19:09:28 rivo volumio[4995]: xcb_connection_has_error() returned true
Apr 25 19:09:28 rivo volumio[4995]: info: CoreCommandRouter::Close All Modals sent
Apr 25 19:09:28 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Apr 25 19:09:28 rivo systemd-udevd[7286]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1.
Apr 25 19:09:28 rivo volumio[4995]: No protocol specified
Apr 25 19:09:28 rivo volumio[4995]: xcb_connection_has_error() returned true
Apr 25 19:09:28 rivo volumio[4995]: No protocol specified
Apr 25 19:09:28 rivo volumio[4995]: xcb_connection_has_error() returned true
Apr 25 19:09:28 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Apr 25 19:09:28 rivo volumio[4995]: No protocol specified
Apr 25 19:09:28 rivo volumio[4995]: xcb_connection_has_error() returned true
Apr 25 19:09:28 rivo volumio[4995]: info: Setting mixer Cayin iDAC-6 for card Cayin iDAC-6
Apr 25 19:09:28 rivo volumio[4995]: info: Reconfiguring and Restarting RAAT Plugin due to audio path changes
Apr 25 19:09:28 rivo vtcs[6941]: [2024-04-25 19:09:28.965] [tisoc] [warning] [SessionManagerImpl.cpp:243] Illegal State: IDLE
Apr 25 19:09:28 rivo vtcs[6941]: [2024-04-25 19:09:28.966] [tisoc] [error] [SpkconServer.cpp:382] recv error. client fd=7 errorno=104 error=Connection reset by peer
Apr 25 19:09:28 rivo vtcs[6941]: [2024-04-25 19:09:28.966] [tisoc] [error] [SpkconServer.cpp:377] recv error. socket disconnected
Apr 25 19:09:29 rivo sudo[7305]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Apr 25 19:09:29 rivo sudo[7305]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 25 19:09:29 rivo systemd[1]: Stopping Volumio Tidal Connect Service...
Apr 25 19:09:29 rivo systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM
Apr 25 19:09:29 rivo systemd[1]: vtcs.service: Succeeded.
Apr 25 19:09:29 rivo systemd[1]: Stopped Volumio Tidal Connect Service.
Apr 25 19:09:29 rivo sudo[7305]: pam_unix(sudo:session): session closed for user root
Apr 25 19:09:29 rivo volumio[4995]: No protocol specified
Apr 25 19:09:29 rivo volumio[4995]: xcb_connection_has_error() returned true
Apr 25 19:09:29 rivo volumio[4995]: info: CoreCommandRouter::volumioUpdateVolumeSettings
Apr 25 19:09:29 rivo volumio[4995]: info: Updating Volume Controller Parameters: Device: 5 Name: Cayin iDAC-6 Mixer: Cayin iDAC-6 Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1
Apr 25 19:09:29 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume
Apr 25 19:09:29 rivo volumio[4995]: info: Disabling external Volume Control
Apr 25 19:09:29 rivo volumio[4995]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 25 19:09:29 rivo volumio[4995]: info: Preparing to generate the ALSA configuration file
Apr 25 19:09:29 rivo volumio[4995]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf
Apr 25 19:09:29 rivo volumio[4995]: info: Reading ALSA contributions from plugins.
Apr 25 19:09:29 rivo sudo[7312]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Apr 25 19:09:29 rivo sudo[7312]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 25 19:09:29 rivo volumio[4995]: ------------------------------------ BT MESSAGE: BT STATUS: running
Apr 25 19:09:29 rivo volumio[4995]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: No protocol specified
Apr 25 19:09:29 rivo volumio[4995]: xcb_connection_has_error() returned true
Apr 25 19:09:29 rivo sudo[7312]: pam_unix(sudo:session): session closed for user root
Apr 25 19:09:29 rivo volumio[4995]: No protocol specified
Apr 25 19:09:29 rivo volumio[4995]: xcb_connection_has_error() returned true
Apr 25 19:09:29 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Apr 25 19:09:29 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 25 19:09:29 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Apr 25 19:09:29 rivo volumio[4995]: No protocol specified
Apr 25 19:09:29 rivo volumio[4995]: xcb_connection_has_error() returned true
Apr 25 19:09:29 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 25 19:09:29 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 25 19:09:29 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 25 19:09:29 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode
Apr 25 19:09:29 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Apr 25 19:09:29 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: raat , getAdditionalUiSection
Apr 25 19:09:29 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 25 19:09:29 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 25 19:09:29 rivo volumio[4995]: info: Not Reporting Auto name since its the default one
Apr 25 19:09:29 rivo volumio[4995]: info: VolumeController:: Volume=undefined Mute =false
Apr 25 19:09:29 rivo volumio[4995]: info: CoreCommandRouter::volumioGetState
Apr 25 19:09:29 rivo volumio[4995]: info: CoreStateMachine::pushState
Apr 25 19:09:29 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 25 19:09:29 rivo volumio[4995]: info: CoreCommandRouter::volumioPushState
Apr 25 19:09:29 rivo volumio[4995]: info: MRS: Pushing multiroomSync output update for this device
Apr 25 19:09:29 rivo volumio[4995]: info: MRS: Pushing multiroomSync output
Apr 25 19:09:29 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat
Apr 25 19:09:29 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 25 19:09:29 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 25 19:09:29 rivo volumio[4995]: info: Not Reporting Auto name since its the default one
Apr 25 19:09:29 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 25 19:09:29 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 25 19:09:29 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable
Apr 25 19:09:29 rivo volumio[4995]: No protocol specified
Apr 25 19:09:29 rivo volumio[4995]: xcb_connection_has_error() returned true
Apr 25 19:09:29 rivo volumio[4995]: info: Asound.conf file unchanged, so no further update is needed
Apr 25 19:09:29 rivo volumio[4995]: info: Output device has changed, restarting MPD
Apr 25 19:09:29 rivo sudo[7332]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service
Apr 25 19:09:29 rivo sudo[7332]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 25 19:09:29 rivo sudo[7335]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Apr 25 19:09:29 rivo volumio[4995]: info: Output device has changed, restarting Shairport Sync
Apr 25 19:09:29 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 25 19:09:29 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 25 19:09:29 rivo sudo[7335]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 25 19:09:29 rivo sudo[7335]: pam_unix(sudo:session): session closed for user root
Apr 25 19:09:29 rivo sudo[7332]: pam_unix(sudo:session): session closed for user root
Apr 25 19:09:30 rivo sudo[7337]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Apr 25 19:09:30 rivo sudo[7337]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 25 19:09:30 rivo sudo[7340]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service
Apr 25 19:09:30 rivo sudo[7340]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 25 19:09:30 rivo systemd[1]: Stopping Music Player Daemon...
Apr 25 19:09:30 rivo volumio[4995]: No protocol specified
Apr 25 19:09:30 rivo volumio[4995]: xcb_connection_has_error() returned true
Apr 25 19:09:30 rivo volumio[4995]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Apr 25 19:09:30 rivo volumio[4995]: No protocol specified
Apr 25 19:09:30 rivo volumio[4995]: xcb_connection_has_error() returned true
Apr 25 19:09:30 rivo volumio[4995]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
Apr 25 19:09:30 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 25 19:09:30 rivo systemd[1]: Started RAAT DAEMON.
Apr 25 19:09:30 rivo sudo[7340]: pam_unix(sudo:session): session closed for user root
Apr 25 19:09:30 rivo systemd[1]: mpd.service: Succeeded.
Apr 25 19:09:30 rivo systemd[1]: Stopped Music Player Daemon.
Apr 25 19:09:30 rivo volumio[4995]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes
Apr 25 19:09:30 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 25 19:09:30 rivo systemd[1]: Starting Music Player Daemon...
Apr 25 19:09:30 rivo sudo[7380]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Apr 25 19:09:30 rivo sudo[7380]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 25 19:09:30 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable
Apr 25 19:09:30 rivo sudo[7388]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Apr 25 19:09:30 rivo sudo[7388]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 25 19:09:30 rivo sudo[7380]: pam_unix(sudo:session): session closed for user root
Apr 25 19:09:30 rivo sudo[7388]: pam_unix(sudo:session): session closed for user root
Apr 25 19:09:30 rivo volumio[4995]: No protocol specified
Apr 25 19:09:30 rivo volumio[4995]: xcb_connection_has_error() returned true
Apr 25 19:09:30 rivo volumio[4995]: ------------------------------------ BT MESSAGE: BT STATUS: running
Apr 25 19:09:30 rivo sudo[7439]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service
Apr 25 19:09:30 rivo sudo[7439]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 25 19:09:30 rivo volumio[4995]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Apr 25 19:09:30 rivo volumio[4995]: ------------------------------------ BT MESSAGE: BT STATUS: running
Apr 25 19:09:30 rivo sudo[7439]: pam_unix(sudo:session): session closed for user root
Apr 25 19:09:30 rivo volumio[4995]: info: MPD Permissions set
Apr 25 19:09:30 rivo volumio[4995]: info: CoreCommandRouter::volumioGetState
Apr 25 19:09:30 rivo volumio[4995]: info: Raat Daemon started successfully
Apr 25 19:09:30 rivo volumio[4995]: info: Executing endpoint restartRAATSocket
Apr 25 19:09:30 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection
Apr 25 19:09:30 rivo sudo[7441]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service
Apr 25 19:09:30 rivo sudo[7441]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 25 19:09:30 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 25 19:09:30 rivo systemd[1]: Stopping RAAT DAEMON...
Apr 25 19:09:30 rivo systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM
Apr 25 19:09:30 rivo systemd[1]: raat-daemon.service: Succeeded.
Apr 25 19:09:30 rivo systemd[1]: Stopped RAAT DAEMON.
Apr 25 19:09:30 rivo systemd[1]: Started RAAT DAEMON.
Apr 25 19:09:30 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 25 19:09:30 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Apr 25 19:09:30 rivo sudo[7441]: pam_unix(sudo:session): session closed for user root
Apr 25 19:09:30 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 25 19:09:30 rivo volumio[4995]: ------------------------------------ BT MESSAGE: BT STATUS: running
Apr 25 19:09:30 rivo volumio[4995]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Apr 25 19:09:30 rivo volumio[4995]: info: Raat Daemon started successfully
Apr 25 19:09:30 rivo volumio[4995]: info: Starting Shairport Sync
Apr 25 19:09:30 rivo volumio[4995]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 15
Apr 25 19:09:30 rivo volumio[4995]: info: Executing endpoint restartRAATSocket
Apr 25 19:09:30 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection
Apr 25 19:09:30 rivo sudo[7483]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Apr 25 19:09:30 rivo sudo[7483]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 25 19:09:30 rivo systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Apr 25 19:09:30 rivo systemd[1]: shairport-sync.service: Succeeded.
Apr 25 19:09:30 rivo systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Apr 25 19:09:30 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 25 19:09:30 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 25 19:09:30 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 25 19:09:30 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 25 19:09:30 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 25 19:09:30 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 25 19:09:30 rivo systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Apr 25 19:09:30 rivo volumio[4995]: info: Not Reporting Auto name since its the default one
Apr 25 19:09:30 rivo volumio[4995]: info: Preparing to generate the ALSA configuration file
Apr 25 19:09:30 rivo sudo[7483]: pam_unix(sudo:session): session closed for user root
Apr 25 19:09:30 rivo volumio[4995]: ------------------------------------ BT MESSAGE: BT STATUS: running
Apr 25 19:09:30 rivo volumio[4995]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Apr 25 19:09:30 rivo volumio[4995]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf
Apr 25 19:09:30 rivo volumio[4995]: info: Reading ALSA contributions from plugins.
Apr 25 19:09:30 rivo volumio[4995]: info: Shairport-Sync Started
Apr 25 19:09:30 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable
Apr 25 19:09:30 rivo volumio[4995]: No protocol specified
Apr 25 19:09:30 rivo volumio[4995]: xcb_connection_has_error() returned true
Apr 25 19:09:30 rivo volumio[4995]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 14
Apr 25 19:09:30 rivo sudo[7547]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service
Apr 25 19:09:30 rivo sudo[7547]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 25 19:09:30 rivo sudo[7547]: pam_unix(sudo:session): session closed for user root
Apr 25 19:09:30 rivo volumio[4995]: info: Asound.conf file written
Apr 25 19:09:31 rivo sudo[7549]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service
Apr 25 19:09:31 rivo sudo[7549]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 25 19:09:31 rivo systemd[1]: Stopping RAAT DAEMON...
Apr 25 19:09:31 rivo systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM
Apr 25 19:09:31 rivo systemd[1]: raat-daemon.service: Succeeded.
Apr 25 19:09:31 rivo systemd[1]: Stopped RAAT DAEMON.
Apr 25 19:09:31 rivo sudo[7552]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf
Apr 25 19:09:31 rivo sudo[7552]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 25 19:09:31 rivo systemd[1]: Started RAAT DAEMON.
Apr 25 19:09:31 rivo sudo[7552]: pam_unix(sudo:session): session closed for user root
Apr 25 19:09:31 rivo sudo[7549]: pam_unix(sudo:session): session closed for user root
Apr 25 19:09:31 rivo kernel: Fine tdm clk setting range (0~2000000), 12287994
Apr 25 19:09:31 rivo kernel: Err: can not set rate to 4274967296!
Apr 25 19:09:31 rivo kernel: Range[3920000 - 500000000]
Apr 25 19:09:31 rivo kernel: out of value, fixed it
Apr 25 19:09:31 rivo kernel: id=0 set inskew=0
Apr 25 19:09:31 rivo volumio[4995]: No protocol specified
Apr 25 19:09:31 rivo volumio[4995]: xcb_connection_has_error() returned true
Apr 25 19:09:31 rivo volumio[4995]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:eARC_TX CDS:0' : Operation not permitted
Apr 25 19:09:31 rivo volumio[4995]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:I2SIn CLK:0' : Operation not permitted
Apr 25 19:09:31 rivo volumio[4995]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:SPDIFIN audio samplerate:0' : Operation not permitted
Apr 25 19:09:31 rivo volumio[4995]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:SPDIFIN Audio Type:0' : Operation not permitted
Apr 25 19:09:31 rivo volumio[4995]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:Cayin Internal Clock Validity:0' : Operation not permitted
Apr 25 19:09:31 rivo volumio[4995]: info: Output device has changed, restarting MPD
Apr 25 19:09:31 rivo sudo[7610]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Apr 25 19:09:31 rivo sudo[7610]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 25 19:09:31 rivo volumio[4995]: info: Output device has changed, restarting Shairport Sync
Apr 25 19:09:31 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 25 19:09:31 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 25 19:09:31 rivo sudo[7610]: pam_unix(sudo:session): session closed for user root
Apr 25 19:09:31 rivo sudo[7612]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Apr 25 19:09:31 rivo sudo[7612]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 25 19:09:31 rivo volumio[4995]: No protocol specified
Apr 25 19:09:31 rivo volumio[4995]: xcb_connection_has_error() returned true
Apr 25 19:09:31 rivo volumio[4995]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Apr 25 19:09:31 rivo volumio[4995]: No protocol specified
Apr 25 19:09:31 rivo volumio[4995]: xcb_connection_has_error() returned true
Apr 25 19:09:31 rivo volumio[4995]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
Apr 25 19:09:31 rivo systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM
Apr 25 19:09:31 rivo systemd[1]: mpd.service: Succeeded.
Apr 25 19:09:31 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 25 19:09:31 rivo systemd[1]: Stopped Music Player Daemon.
Apr 25 19:09:31 rivo systemd[1]: Starting Music Player Daemon...
Apr 25 19:09:31 rivo volumio[4995]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes
Apr 25 19:09:31 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 25 19:09:31 rivo sudo[7630]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Apr 25 19:09:31 rivo sudo[7630]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 25 19:09:31 rivo sudo[7630]: pam_unix(sudo:session): session closed for user root
Apr 25 19:09:31 rivo volumio[4995]: ------------------------------------ BT MESSAGE: BT STATUS: running
Apr 25 19:09:31 rivo volumio[4995]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Apr 25 19:09:31 rivo volumio[4995]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Apr 25 19:09:31 rivo sudo[7634]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Apr 25 19:09:31 rivo volumio[4995]: ------------------------------------ BT MESSAGE: BT STATUS: running
Apr 25 19:09:31 rivo sudo[7634]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 25 19:09:31 rivo volumio[4995]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Apr 25 19:09:31 rivo volumio[4995]: ------------------------------------ BT MESSAGE: BT STATUS: running
Apr 25 19:09:31 rivo volumio[4995]: info: MPD Permissions set
Apr 25 19:09:31 rivo volumio[4995]: info: Raat Daemon started successfully
Apr 25 19:09:31 rivo volumio[4995]: info: Executing endpoint restartRAATSocket
Apr 25 19:09:31 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection
Apr 25 19:09:31 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 25 19:09:31 rivo sudo[7634]: pam_unix(sudo:session): session closed for user root
Apr 25 19:09:31 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 25 19:09:31 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Apr 25 19:09:31 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 25 19:09:31 rivo volumio[4995]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 15
Apr 25 19:09:31 rivo volumio[4995]: info: Starting Shairport Sync
Apr 25 19:09:31 rivo sudo[7662]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Apr 25 19:09:31 rivo sudo[7662]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 25 19:09:31 rivo systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Apr 25 19:09:31 rivo systemd[1]: shairport-sync.service: Succeeded.
Apr 25 19:09:31 rivo volumio[4995]: info: Executing endpoint metavolumio
Apr 25 19:09:31 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Apr 25 19:09:31 rivo systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Apr 25 19:09:31 rivo systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Apr 25 19:09:31 rivo sudo[7662]: pam_unix(sudo:session): session closed for user root
Apr 25 19:09:31 rivo volumio[4995]: ------------------------------------ BT MESSAGE: BT STATUS: running
Apr 25 19:09:31 rivo volumio[4995]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Apr 25 19:09:31 rivo volumio[4995]: info: Shairport-Sync Started
Apr 25 19:09:31 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 25 19:09:31 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 25 19:09:31 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 25 19:09:31 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 25 19:09:31 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 25 19:09:31 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 25 19:09:31 rivo volumio[4995]: info: Not Reporting Auto name since its the default one
Apr 25 19:09:31 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable
Apr 25 19:09:31 rivo volumio[4995]: No protocol specified
Apr 25 19:09:31 rivo volumio[4995]: xcb_connection_has_error() returned true
Apr 25 19:09:31 rivo sudo[7705]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service
Apr 25 19:09:31 rivo sudo[7705]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 25 19:09:32 rivo sudo[7705]: pam_unix(sudo:session): session closed for user root
Apr 25 19:09:32 rivo sudo[7707]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service
Apr 25 19:09:32 rivo sudo[7707]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 25 19:09:32 rivo systemd[1]: Stopping RAAT DAEMON...
Apr 25 19:09:32 rivo systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM
Apr 25 19:09:32 rivo systemd[1]: raat-daemon.service: Succeeded.
Apr 25 19:09:32 rivo systemd[1]: Stopped RAAT DAEMON.
Apr 25 19:09:32 rivo volumio[4995]: ------------------------------------ BT MESSAGE: BT STATUS: running
Apr 25 19:09:32 rivo volumio[4995]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Apr 25 19:09:32 rivo systemd[1]: Started RAAT DAEMON.
Apr 25 19:09:32 rivo sudo[7707]: pam_unix(sudo:session): session closed for user root
Apr 25 19:09:32 rivo volumio[4995]: info: TidalConnect service stoped!
Apr 25 19:09:32 rivo volumio[4995]: info: Raat Daemon started successfully
Apr 25 19:09:32 rivo volumio[4995]: info: Executing endpoint restartRAATSocket
Apr 25 19:09:32 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection
Apr 25 19:09:32 rivo volumio[4995]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 15
Apr 25 19:09:32 rivo volumio[4995]: info: TidalConnect service stoped!
Apr 25 19:09:32 rivo volumio[4995]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect
Apr 25 19:09:32 rivo volumio[4995]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect
Apr 25 19:09:32 rivo sudo[7749]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service
Apr 25 19:09:32 rivo sudo[7749]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 25 19:09:32 rivo systemd[1]: Started Volumio Tidal Connect Service.
Apr 25 19:09:32 rivo sudo[7749]: pam_unix(sudo:session): session closed for user root
Apr 25 19:09:32 rivo volumio[4995]: info: Executing endpoint tc_getconfig
Apr 25 19:09:32 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig
Apr 25 19:09:32 rivo vtcs[7751]: STARTING TidalConnect services, version: 1.3.0.19
Apr 25 19:09:32 rivo vtcs[7751]: STARTED TidalConnect services.
Apr 25 19:09:32 rivo volumio[4995]: info: Executing endpoint tc_connect
Apr 25 19:09:32 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect
Apr 25 19:09:32 rivo volumio[4995]: info: Connecting to TidalConnect
Apr 25 19:09:32 rivo volumio[4995]: info: CoreCommandRouter::servicePushState
Apr 25 19:09:32 rivo volumio[4995]: info: CoreStateMachine::pushState
Apr 25 19:09:32 rivo volumio[4995]: info: CoreCommandRouter::volumioPushState
Apr 25 19:09:32 rivo volumio[4995]: info: MRS: Pushing multiroomSync output update for this device
Apr 25 19:09:32 rivo volumio[4995]: info: MRS: Pushing multiroomSync output
Apr 25 19:09:32 rivo volumio[4995]: info: CorePlayQueue::getTrack 0
Apr 25 19:09:32 rivo volumio[4995]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current mpd Received tidalconnect
Apr 25 19:09:32 rivo volumio[4995]: info: CoreCommandRouter::servicePushState
Apr 25 19:09:32 rivo volumio[4995]: info: CoreStateMachine::pushState
Apr 25 19:09:32 rivo volumio[4995]: info: CoreCommandRouter::volumioPushState
Apr 25 19:09:32 rivo volumio[4995]: info: MRS: Pushing multiroomSync output update for this device
Apr 25 19:09:32 rivo volumio[4995]: info: MRS: Pushing multiroomSync output
Apr 25 19:09:32 rivo volumio[4995]: info: CorePlayQueue::getTrack 0
Apr 25 19:09:32 rivo volumio[4995]: info: CONSUME SERVICE: Received update from a service different from the one supposed to be playing music. Skipping notification. Current mpd Received tidalconnect
Apr 25 19:09:33 rivo volumio[4995]: info: CoreCommandRouter::volumioRetrieveVolumeLevels
Apr 25 19:09:33 rivo volumio[4995]: info: CoreStateMachine::getcurrentVolume
Apr 25 19:09:33 rivo volumio[4995]: info: CoreCommandRouter::volumioRetrievevolume
Apr 25 19:09:33 rivo volumio[4995]: info: VolumeController:: Volume=100 Mute =false
Apr 25 19:09:33 rivo volumio[4995]: info: CoreCommandRouter::volumioGetState
Apr 25 19:09:33 rivo volumio[4995]: info: CoreStateMachine::pushState
Apr 25 19:09:33 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 25 19:09:33 rivo volumio[4995]: info: CoreCommandRouter::volumioPushState
Apr 25 19:09:33 rivo volumio[4995]: info: MRS: Pushing multiroomSync output update for this device
Apr 25 19:09:33 rivo volumio[4995]: info: MRS: Pushing multiroomSync output
Apr 25 19:09:33 rivo volumio[4995]: info: CoreStateMachine::updateTrackBlock
Apr 25 19:09:33 rivo volumio[4995]: info: CorePlayQueue::getTrackBlock
Apr 25 19:09:33 rivo volumio[4995]: info: CoreCommandRouter::volumioRetrievevolume
Apr 25 19:09:33 rivo volumio[4995]: info: Updating RAAT Signal Path
Apr 25 19:09:33 rivo volumio[4995]: info: TidalConnect service stoped!
Apr 25 19:09:33 rivo volumio[4995]: info: TidalConnect service stoped!
Apr 25 19:09:33 rivo mpd[7618]: Apr 25 19:09 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Apr 25 19:09:33 rivo systemd[1]: Started Music Player Daemon.
Apr 25 19:09:33 rivo sudo[7612]: pam_unix(sudo:session): session closed for user root
Apr 25 19:09:33 rivo sudo[7337]: pam_unix(sudo:session): session closed for user root
Apr 25 19:09:33 rivo volumio[4995]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: No protocol specified
Apr 25 19:09:33 rivo volumio[4995]: xcb_connection_has_error() returned true
Apr 25 19:09:33 rivo volumio[4995]: error: MPD error: The expression evaluated to a falsy value:
Apr 25 19:09:33 rivo volumio[4995]: assert.ok(self.idling)
Apr 25 19:09:33 rivo volumio[4995]: error: The expression evaluated to a falsy value:
Apr 25 19:09:33 rivo volumio[4995]: assert.ok(self.idling)
Apr 25 19:09:33 rivo volumio[4995]: info: VolumeController:: Volume=undefined Mute =false
Apr 25 19:09:33 rivo volumio[4995]: info: CoreCommandRouter::volumioGetState
Apr 25 19:09:33 rivo volumio[4995]: info: CoreStateMachine::pushState
Apr 25 19:09:33 rivo volumio[4995]: info: CoreCommandRouter::volumioPushState
Apr 25 19:09:33 rivo volumio[4995]: info: MRS: Pushing multiroomSync output update for this device
Apr 25 19:09:33 rivo volumio[4995]: info: MRS: Pushing multiroomSync output
Apr 25 19:09:33 rivo volumio[4995]: error: updateQueue error: null
Apr 25 19:09:33 rivo volumio[4995]: info: Updating RAAT Signal Path
Apr 25 19:09:33 rivo volumio[4995]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect
Apr 25 19:09:33 rivo volumio[4995]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect
Apr 25 19:09:33 rivo sudo[7811]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service
Apr 25 19:09:33 rivo sudo[7811]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 25 19:09:33 rivo sudo[7811]: pam_unix(sudo:session): session closed for user root
Apr 25 19:09:34 rivo volumio[4995]: info: TidalConnect service stoped!
Apr 25 19:09:34 rivo volumio[4995]: info: TidalConnect service stoped!
Apr 25 19:09:34 rivo volumio[4995]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect
Apr 25 19:09:34 rivo volumio[4995]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect
Apr 25 19:09:34 rivo sudo[7824]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service
Apr 25 19:09:34 rivo sudo[7824]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 25 19:09:34 rivo sudo[7824]: pam_unix(sudo:session): session closed for user root
Apr 25 19:09:34 rivo volumio[4995]: error: Upnp client error: Error: This socket has been ended by the other party
Apr 25 19:09:35 rivo volumio[4995]: info: TidalConnect service started!
Apr 25 19:09:35 rivo volumio[4995]: info: Executing endpoint metavolumio
Apr 25 19:09:35 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Apr 25 19:09:36 rivo volumio[4995]: info: TidalConnect service started!
Apr 25 19:09:37 rivo volumio[4995]: info: TidalConnect service started!
Apr 25 19:09:38 rivo volumio[4995]: error: Failed request for metavolumio API
Apr 25 19:09:47 rivo volumio[4995]: info: Clearing queue after UPNP request
Apr 25 19:09:47 rivo volumio[4995]: info: CoreStateMachine::ClearQueue
Apr 25 19:09:47 rivo volumio[4995]: info: CoreStateMachine::stop
Apr 25 19:09:47 rivo volumio[4995]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 25 19:09:47 rivo volumio[4995]: info: CorePlayQueue::clearPlayQueue
Apr 25 19:09:47 rivo volumio[4995]: info: CorePlayQueue::saveQueue
Apr 25 19:09:47 rivo volumio[4995]: info: CoreCommandRouter::volumioPushState
Apr 25 19:09:47 rivo volumio[4995]: info: MRS: Pushing multiroomSync output update for this device
Apr 25 19:09:47 rivo volumio[4995]: info: MRS: Pushing multiroomSync output
Apr 25 19:09:47 rivo volumio[4995]: info: CoreCommandRouter::volumioPushQueue
Apr 25 19:09:47 rivo volumio[4995]: info: Updating RAAT Signal Path
Apr 25 19:09:47 rivo volumio[4995]: info:
Apr 25 19:09:47 rivo volumio[4995]: ---------------------------- MPD announces system playlist update
Apr 25 19:09:47 rivo volumio[4995]: info: Ignoring MPD Status Update
Apr 25 19:09:47 rivo volumio[4995]: info:
Apr 25 19:09:47 rivo volumio[4995]: ---------------------------- MPD announces system playlist update
Apr 25 19:09:47 rivo volumio[4995]: info: Ignoring MPD Status Update
Apr 25 19:09:47 rivo volumio[4995]: error: updateQueue error: null
Apr 25 19:09:47 rivo volumio[4995]: info: ------------------------------ 9ms
Apr 25 19:09:47 rivo volumio[4995]: info: ------------------------------ 6ms
Apr 25 19:09:47 rivo volumio[4995]: info: Starting UPNP Playback
Apr 25 19:09:47 rivo volumio[4995]: info: Preparing playback through UPNP
Apr 25 19:09:47 rivo volumio[4995]: info: CoreCommandRouter::volumioGetState
Apr 25 19:09:47 rivo volumio[4995]: info: CorePlayQueue::getTrack 0
Apr 25 19:09:47 rivo volumio[4995]: info: CoreStateMachine::setConsumeUpdateService mpd
Apr 25 19:09:55 rivo volumio[4995]: info: Starting UPNP Playback
Apr 25 19:09:55 rivo volumio[4995]: info: Preparing playback through UPNP
Apr 25 19:09:55 rivo volumio[4995]: info: Consume mode
Apr 25 19:09:55 rivo volumio[4995]: info: CoreCommandRouter::volumioGetState
Apr 25 19:09:55 rivo volumio[4995]: info: CoreStateMachine::setConsumeUpdateService mpd
Apr 25 19:09:55 rivo volumio[4995]: info: Clearing queue after UPNP request
Apr 25 19:09:56 rivo volumio[4995]: info: CoreStateMachine::ClearQueue
Apr 25 19:09:56 rivo volumio[4995]: info: CoreStateMachine::stop
Apr 25 19:09:56 rivo volumio[4995]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 25 19:09:56 rivo volumio[4995]: info: CorePlayQueue::clearPlayQueue
Apr 25 19:09:56 rivo volumio[4995]: info: CorePlayQueue::saveQueue
Apr 25 19:09:56 rivo volumio[4995]: info: CoreCommandRouter::volumioPushState
Apr 25 19:09:56 rivo volumio[4995]: info: MRS: Pushing multiroomSync output update for this device
Apr 25 19:09:56 rivo volumio[4995]: info: MRS: Pushing multiroomSync output
Apr 25 19:09:56 rivo volumio[4995]: info: CoreCommandRouter::volumioPushQueue
Apr 25 19:09:56 rivo volumio[4995]: info: Updating RAAT Signal Path
Apr 25 19:09:56 rivo volumio[4995]: info:
Apr 25 19:09:56 rivo volumio[4995]: ---------------------------- MPD announces system playlist update
Apr 25 19:09:56 rivo volumio[4995]: info: Ignoring MPD Status Update
Apr 25 19:09:56 rivo volumio[4995]: info:
Apr 25 19:09:56 rivo volumio[4995]: ---------------------------- MPD announces system playlist update
Apr 25 19:09:56 rivo volumio[4995]: info: Ignoring MPD Status Update
Apr 25 19:09:56 rivo volumio[4995]: error: updateQueue error: null
Apr 25 19:09:56 rivo volumio[4995]: error: updateQueue error: null
Apr 25 19:09:56 rivo volumio[4995]: info: ------------------------------ 6ms
Apr 25 19:09:56 rivo volumio[4995]: info: ------------------------------ 4ms
Apr 25 19:09:56 rivo volumio[4995]: info: Starting UPNP Playback
Apr 25 19:09:56 rivo volumio[4995]: info: Preparing playback through UPNP
Apr 25 19:09:56 rivo volumio[4995]: info: CoreCommandRouter::volumioGetState
Apr 25 19:09:56 rivo volumio[4995]: info: CorePlayQueue::getTrack 0
Apr 25 19:09:56 rivo volumio[4995]: info: CoreStateMachine::setConsumeUpdateService mpd
Apr 25 19:10:01 rivo volumio[4995]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 25 19:10:01 rivo volumio[4995]: No protocol specified
Apr 25 19:10:01 rivo volumio[4995]: xcb_connection_has_error() returned true
Apr 25 19:10:01 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Apr 25 19:10:01 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 25 19:10:01 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Apr 25 19:10:02 rivo volumio[4995]: No protocol specified
Apr 25 19:10:02 rivo volumio[4995]: xcb_connection_has_error() returned true
Apr 25 19:10:02 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 25 19:10:02 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 25 19:10:02 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 25 19:10:02 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 25 19:10:02 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 25 19:10:02 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 25 19:10:02 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 25 19:10:02 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode
Apr 25 19:10:02 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Apr 25 19:10:02 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: raat , getAdditionalUiSection
Apr 25 19:10:02 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 25 19:10:02 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 25 19:10:04 rivo volumio[4995]: info: Starting UPNP Playback
Apr 25 19:10:04 rivo volumio[4995]: info: Preparing playback through UPNP
Apr 25 19:10:04 rivo volumio[4995]: info: Consume mode
Apr 25 19:10:04 rivo volumio[4995]: info: CoreCommandRouter::volumioGetState
Apr 25 19:10:04 rivo volumio[4995]: info: CoreStateMachine::setConsumeUpdateService mpd
Apr 25 19:10:04 rivo volumio[4995]: info: Clearing queue after UPNP request
Apr 25 19:10:05 rivo volumio[4995]: info: CoreStateMachine::ClearQueue
Apr 25 19:10:05 rivo volumio[4995]: info: CoreStateMachine::stop
Apr 25 19:10:05 rivo volumio[4995]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 25 19:10:05 rivo volumio[4995]: info: CorePlayQueue::clearPlayQueue
Apr 25 19:10:05 rivo volumio[4995]: info: CorePlayQueue::saveQueue
Apr 25 19:10:05 rivo volumio[4995]: info: CoreCommandRouter::volumioPushState
Apr 25 19:10:05 rivo volumio[4995]: info: MRS: Pushing multiroomSync output update for this device
Apr 25 19:10:05 rivo volumio[4995]: info: MRS: Pushing multiroomSync output
Apr 25 19:10:05 rivo volumio[4995]: info: CoreCommandRouter::volumioPushQueue
Apr 25 19:10:05 rivo volumio[4995]: info: Updating RAAT Signal Path
Apr 25 19:10:05 rivo volumio[4995]: info:
Apr 25 19:10:05 rivo volumio[4995]: ---------------------------- MPD announces system playlist update
Apr 25 19:10:05 rivo volumio[4995]: info: Ignoring MPD Status Update
Apr 25 19:10:05 rivo volumio[4995]: info:
Apr 25 19:10:05 rivo volumio[4995]: ---------------------------- MPD announces system playlist update
Apr 25 19:10:05 rivo volumio[4995]: info: Ignoring MPD Status Update
Apr 25 19:10:05 rivo volumio[4995]: error: updateQueue error: null
Apr 25 19:10:05 rivo volumio[4995]: error: updateQueue error: null
Apr 25 19:10:05 rivo volumio[4995]: info: ------------------------------ 7ms
Apr 25 19:10:05 rivo volumio[4995]: info: ------------------------------ 5ms
Apr 25 19:10:05 rivo volumio[4995]: info: Starting UPNP Playback
Apr 25 19:10:05 rivo volumio[4995]: info: Preparing playback through UPNP
Apr 25 19:10:05 rivo volumio[4995]: info: CoreCommandRouter::volumioGetState
Apr 25 19:10:05 rivo volumio[4995]: info: CorePlayQueue::getTrack 0
Apr 25 19:10:05 rivo volumio[4995]: info: CoreStateMachine::setConsumeUpdateService mpd
Apr 25 19:10:05 rivo volumio[4995]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 25 19:10:05 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Apr 25 19:10:06 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork
Apr 25 19:10:06 rivo sudo[7961]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0
Apr 25 19:10:06 rivo sudo[7961]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 25 19:10:06 rivo sudo[7961]: pam_unix(sudo:session): session closed for user root
Apr 25 19:10:06 rivo sudo[7966]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0
Apr 25 19:10:06 rivo sudo[7966]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 25 19:10:06 rivo kernel: dhd_ioctl_entry: Interface is down
Apr 25 19:10:06 rivo kernel: dhd_ioctl_entry: Interface is down
Apr 25 19:10:06 rivo kernel: dhd_ioctl_entry: Interface is down
Apr 25 19:10:06 rivo kernel: dhd_ioctl_entry: Interface is down
Apr 25 19:10:06 rivo kernel: dhd_ioctl_entry: Interface is down
Apr 25 19:10:06 rivo kernel: Error getting the SSID
Apr 25 19:10:06 rivo kernel: dhd_ioctl_entry: Interface is down
Apr 25 19:10:06 rivo kernel: dhd_ioctl_entry: Interface is down
Apr 25 19:10:06 rivo kernel: dhd_ioctl_entry: Interface is down
Apr 25 19:10:06 rivo kernel: dhd_ioctl_entry: Interface is down
Apr 25 19:10:06 rivo kernel: dhd_ioctl_entry: Interface is down
Apr 25 19:10:06 rivo kernel: dhd_ioctl_entry: Interface is down
Apr 25 19:10:06 rivo kernel: dhd_ioctl_entry: Interface is down
Apr 25 19:10:06 rivo kernel: dhd_ioctl_entry: Interface is down
Apr 25 19:10:06 rivo sudo[7966]: pam_unix(sudo:session): session closed for user root
Apr 25 19:10:06 rivo sudo[7973]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0
Apr 25 19:10:06 rivo sudo[7973]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 25 19:10:06 rivo kernel: dhd_ioctl_entry: Interface is down
Apr 25 19:10:06 rivo kernel: dhd_ioctl_entry: Interface is down
Apr 25 19:10:06 rivo kernel: dhd_ioctl_entry: Interface is down
Apr 25 19:10:06 rivo kernel: dhd_ioctl_entry: Interface is down
Apr 25 19:10:06 rivo kernel: dhd_ioctl_entry: Interface is down
Apr 25 19:10:06 rivo kernel: Error getting the SSID
Apr 25 19:10:06 rivo kernel: dhd_ioctl_entry: Interface is down
Apr 25 19:10:06 rivo kernel: dhd_ioctl_entry: Interface is down
Apr 25 19:10:06 rivo kernel: dhd_ioctl_entry: Interface is down
Apr 25 19:10:06 rivo kernel: dhd_ioctl_entry: Interface is down
Apr 25 19:10:06 rivo kernel: dhd_ioctl_entry: Interface is down
Apr 25 19:10:06 rivo kernel: dhd_ioctl_entry: Interface is down
Apr 25 19:10:06 rivo kernel: dhd_ioctl_entry: Interface is down
Apr 25 19:10:06 rivo kernel: dhd_ioctl_entry: Interface is down
Apr 25 19:10:06 rivo sudo[7973]: pam_unix(sudo:session): session closed for user root
Apr 25 19:10:06 rivo sudo[7982]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0
Apr 25 19:10:06 rivo sudo[7982]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 25 19:10:06 rivo kernel: dhd_ioctl_entry: Interface is down
Apr 25 19:10:06 rivo kernel: dhd_ioctl_entry: Interface is down
Apr 25 19:10:06 rivo kernel: dhd_ioctl_entry: Interface is down
Apr 25 19:10:06 rivo kernel: dhd_ioctl_entry: Interface is down
Apr 25 19:10:06 rivo kernel: dhd_ioctl_entry: Interface is down
Apr 25 19:10:06 rivo kernel: Error getting the SSID
Apr 25 19:10:06 rivo kernel: dhd_ioctl_entry: Interface is down
Apr 25 19:10:06 rivo kernel: dhd_ioctl_entry: Interface is down
Apr 25 19:10:06 rivo kernel: dhd_ioctl_entry: Interface is down
Apr 25 19:10:06 rivo kernel: dhd_ioctl_entry: Interface is down
Apr 25 19:10:06 rivo kernel: dhd_ioctl_entry: Interface is down
Apr 25 19:10:06 rivo kernel: dhd_ioctl_entry: Interface is down
Apr 25 19:10:06 rivo kernel: dhd_ioctl_entry: Interface is down
Apr 25 19:10:06 rivo kernel: dhd_ioctl_entry: Interface is down
Apr 25 19:10:06 rivo sudo[7982]: pam_unix(sudo:session): session closed for user root
Apr 25 19:10:06 rivo sudo[7987]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Apr 25 19:10:06 rivo sudo[7987]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 25 19:10:06 rivo sudo[7987]: pam_unix(sudo:session): session closed for user root
Apr 25 19:10:06 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache
Apr 25 19:10:06 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks
Apr 25 19:10:06 rivo sudo[7993]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 25 19:10:06 rivo sudo[7993]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 25 19:10:06 rivo sudo[7993]: pam_unix(sudo:session): session closed for user root
Apr 25 19:10:12 rivo volumio[4995]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 25 19:10:12 rivo volumio[4995]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 25 19:10:12 rivo volumio[4995]: info: Retrieving Cloud Streaming UI
Apr 25 19:10:12 rivo volumio[4995]: info: Getting Tidal Cloud Configuration
Apr 25 19:10:12 rivo volumio[4995]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 25 19:10:12 rivo volumio[4995]: info: Getting Qobuz Cloud Configuration
Apr 25 19:10:12 rivo volumio[4995]: info: Asking plugin for UI Config
Apr 25 19:10:12 rivo volumio[4995]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 25 19:10:12 rivo volumio[4995]: info: Getting Spotify Cloud Configuration
Apr 25 19:10:12 rivo volumio[4995]: info: Asking plugin for UI Config
Apr 25 19:10:12 rivo volumio[4995]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 25 19:10:12 rivo volumio[4995]: info: Saving Spotify Acccount
Apr 25 19:10:12 rivo volumio[4995]: info: Got it
Apr 25 19:10:12 rivo volumio[4995]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
Apr 25 19:10:12 rivo volumio[4995]: info: Got Tidal Cloud Configuration
Apr 25 19:10:12 rivo volumio[4995]: info: Got it
Apr 25 19:10:12 rivo volumio[4995]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 25 19:10:12 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Apr 25 19:10:12 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Apr 25 19:10:12 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Apr 25 19:10:12 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Apr 25 19:10:12 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 25 19:10:12 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 25 19:10:12 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 25 19:10:12 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 25 19:10:12 rivo volumio[4995]: info: CoreCommandRouter::volumioGetBrowseSources
Apr 25 19:10:12 rivo volumio[4995]: info: CoreCommandRouter::volumioGetBrowseSources
Apr 25 19:10:12 rivo volumio[4995]: info: CoreCommandRouter::volumioGetBrowseSources
Apr 25 19:10:12 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 25 19:10:12 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
Apr 25 19:10:16 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 25 19:10:17 rivo volumio[4995]: info: Disabling MyMusic plugin upnp
Apr 25 19:10:17 rivo sudo[7998]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service
Apr 25 19:10:17 rivo sudo[7998]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 25 19:10:17 rivo systemd[1]: Stopping UPnP Renderer front-end to MPD...
Apr 25 19:10:17 rivo volumio[4995]: error: Upnp client error: Error: This socket has been ended by the other party
Apr 25 19:10:17 rivo volumio[4995]: ------------------------------------ BT MESSAGE: BT STATUS: running
Apr 25 19:10:20 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 25 19:10:26 rivo volumio[4995]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 25 19:10:26 rivo volumio[4995]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 25 19:10:26 rivo volumio[4995]: info: Retrieving Cloud Streaming UI
Apr 25 19:10:26 rivo volumio[4995]: info: Getting Tidal Cloud Configuration
Apr 25 19:10:26 rivo volumio[4995]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 25 19:10:26 rivo volumio[4995]: info: Getting Qobuz Cloud Configuration
Apr 25 19:10:26 rivo volumio[4995]: info: Asking plugin for UI Config
Apr 25 19:10:26 rivo volumio[4995]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 25 19:10:26 rivo volumio[4995]: info: Getting Spotify Cloud Configuration
Apr 25 19:10:26 rivo volumio[4995]: info: Asking plugin for UI Config
Apr 25 19:10:26 rivo volumio[4995]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 25 19:10:26 rivo volumio[4995]: info: Saving Spotify Acccount
Apr 25 19:10:26 rivo volumio[4995]: info: Got it
Apr 25 19:10:26 rivo volumio[4995]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
Apr 25 19:10:26 rivo volumio[4995]: info: Got Tidal Cloud Configuration
Apr 25 19:10:26 rivo volumio[4995]: info: Got it
Apr 25 19:10:26 rivo volumio[4995]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 25 19:10:26 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Apr 25 19:10:26 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Apr 25 19:10:26 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Apr 25 19:10:26 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Apr 25 19:10:26 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 25 19:10:26 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 25 19:10:26 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 25 19:10:26 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 25 19:10:26 rivo volumio[4995]: info: CoreCommandRouter::volumioGetBrowseSources
Apr 25 19:10:26 rivo volumio[4995]: info: CoreCommandRouter::volumioGetBrowseSources
Apr 25 19:10:26 rivo volumio[4995]: info: CoreCommandRouter::volumioGetBrowseSources
Apr 25 19:10:26 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 25 19:10:26 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
Apr 25 19:10:30 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 25 19:10:34 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 25 19:10:38 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 25 19:10:42 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 25 19:10:42 rivo volumio[4995]: info: Disabling MyMusic plugin upnp
Apr 25 19:10:42 rivo sudo[8002]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service
Apr 25 19:10:42 rivo sudo[8002]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 25 19:10:42 rivo volumio[4995]: ------------------------------------ BT MESSAGE: BT STATUS: running
Apr 25 19:10:46 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 25 19:10:50 rivo volumio[4995]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 25 19:10:50 rivo volumio[4995]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 25 19:10:50 rivo volumio[4995]: info: Retrieving Cloud Streaming UI
Apr 25 19:10:50 rivo volumio[4995]: info: Getting Tidal Cloud Configuration
Apr 25 19:10:50 rivo volumio[4995]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 25 19:10:50 rivo volumio[4995]: info: Getting Qobuz Cloud Configuration
Apr 25 19:10:50 rivo volumio[4995]: info: Asking plugin for UI Config
Apr 25 19:10:50 rivo volumio[4995]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 25 19:10:50 rivo volumio[4995]: info: Getting Spotify Cloud Configuration
Apr 25 19:10:50 rivo volumio[4995]: info: Asking plugin for UI Config
Apr 25 19:10:50 rivo volumio[4995]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 25 19:10:50 rivo volumio[4995]: info: Saving Spotify Acccount
Apr 25 19:10:50 rivo volumio[4995]: info: Got it
Apr 25 19:10:50 rivo volumio[4995]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
Apr 25 19:10:50 rivo volumio[4995]: info: Got Tidal Cloud Configuration
Apr 25 19:10:50 rivo volumio[4995]: info: Got it
Apr 25 19:10:50 rivo volumio[4995]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 25 19:10:50 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Apr 25 19:10:50 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Apr 25 19:10:50 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Apr 25 19:10:50 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Apr 25 19:10:50 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 25 19:10:50 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 25 19:10:50 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 25 19:10:50 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 25 19:10:50 rivo volumio[4995]: info: CoreCommandRouter::volumioGetBrowseSources
Apr 25 19:10:50 rivo volumio[4995]: info: CoreCommandRouter::volumioGetBrowseSources
Apr 25 19:10:50 rivo volumio[4995]: info: CoreCommandRouter::volumioGetBrowseSources
Apr 25 19:10:50 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 25 19:10:50 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
Apr 25 19:10:51 rivo volumio[4995]: info: Disabling MyMusic plugin cd_controller
Apr 25 19:10:51 rivo volumio[4995]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesAudio CD
Apr 25 19:10:51 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 25 19:10:51 rivo volumio[4995]: Cannot find translation for source TIDAL
Apr 25 19:10:51 rivo volumio[4995]: info: Stopping UDEV Watcher for CD
Apr 25 19:10:51 rivo volumio[4995]: info: Disabling plugin cd_controller
Apr 25 19:10:51 rivo volumio[4995]: info: Done.
Apr 25 19:10:54 rivo volumio[4995]: info: Disabling MyMusic plugin upnp
Apr 25 19:10:54 rivo sudo[8047]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service
Apr 25 19:10:54 rivo sudo[8047]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 25 19:10:54 rivo volumio[4995]: ------------------------------------ BT MESSAGE: BT STATUS: running
Apr 25 19:10:54 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 25 19:10:55 rivo volumio[4995]: info: Enabling MyMusic plugin upnp
Apr 25 19:10:55 rivo volumio[4995]: info: Enabling plugin upnp
Apr 25 19:10:55 rivo volumio[4995]: info: Loading plugin "upnp"...
Apr 25 19:10:55 rivo volumio[4995]: info: [1714065055008] Starting Upmpd Daemon
Apr 25 19:10:55 rivo volumio[4995]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Apr 25 19:10:55 rivo volumio[4995]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 25 19:10:55 rivo volumio[4995]: Error: listen EADDRINUSE: address already in use :::6599
Apr 25 19:10:55 rivo volumio[4995]: at Server.setupListenHandle [as _listen2] (net.js:1331:16)
Apr 25 19:10:55 rivo volumio[4995]: at listenInCluster (net.js:1379:12)
Apr 25 19:10:55 rivo volumio[4995]: at Server.listen (net.js:1465:7)
Apr 25 19:10:55 rivo volumio[4995]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17)
Apr 25 19:10:55 rivo volumio[4995]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38)
Apr 25 19:10:55 rivo volumio[4995]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19)
Apr 25 19:10:55 rivo volumio[4995]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28)
Apr 25 19:10:55 rivo volumio[4995]: at processTicksAndRejections (internal/process/task_queues.js:77:11) {
Apr 25 19:10:55 rivo volumio[4995]: code: 'EADDRINUSE',
Apr 25 19:10:55 rivo volumio[4995]: errno: -98,
Apr 25 19:10:55 rivo volumio[4995]: syscall: 'listen',
Apr 25 19:10:55 rivo volumio[4995]: address: '::',
Apr 25 19:10:55 rivo volumio[4995]: port: 6599
Apr 25 19:10:55 rivo volumio[4995]: }
Apr 25 19:10:55 rivo volumio[4995]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 25 19:10:55 rivo sudo[8058]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-25 19:09
Apr 25 19:10:55 rivo sudo[8058]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Debian GNU/Linux 10 (buster)"
NAME="Debian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=debian
HOME_URL="https://www.debian.org/"
SUPPORT_URL="https://www.debian.org/support"
BUG_REPORT_URL="https://bugs.debian.org/"
VOLUMIO_BUILD_VERSION="7f9f1bf001add7a8b19a4516e3c74ef598b2730d"
VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71"
VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1"
VOLUMIO_BE_VERSION="e831866afe2db61aee9333a8f5ba9d9fd36609c7"
VOLUMIO_ARCH="armv7"
VOLUMIO_VARIANT="rivo"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Sun 18 Feb 2024 11:41:55 AM CET"
VOLUMIO_VERSION="3.629"
VOLUMIO_HARDWARE="mp1"
VOLUMIO_DEVICENAME="Volumio MP1"
VOLUMIO_VENDOR_MODEL="Volumio Rivo"
VOLUMIO_VENDOR="Volumio"
VOLUMIO_MODEL="Rivo"
VOLUMIO_HASH="b0437c7088d6645a661a49f6d9fa596a"