-- Logs begin at Sat 2024-08-17 22:11:53 WIB, end at Sat 2024-08-17 23:37:09 WIB. -- Aug 17 23:36:51 tube-rivo-audio ntpd[3383]: receive: Unexpected origin timestamp 0xea6b3c58.9e30c7ac does not match aorg 0000000000.00000000 from server@114.30.89.30 xmt 0xea6b5023.82b294cf Aug 17 23:36:51 tube-rivo-audio ntpd[3383]: receive: Unexpected origin timestamp 0xea6b3c58.9e43d64f does not match aorg 0000000000.00000000 from server@202.65.114.202 xmt 0xea6b5023.80bc1033 Aug 17 23:36:51 tube-rivo-audio ntpd[3383]: receive: Unexpected origin timestamp 0xea6b3c58.9e4856aa does not match aorg 0000000000.00000000 from server@203.89.31.13 xmt 0xea6b5023.818aeb7e Aug 17 23:36:51 tube-rivo-audio ntpd[3383]: receive: Unexpected origin timestamp 0xea6b3c58.9e4a95fa does not match aorg 0000000000.00000000 from server@103.169.192.230 xmt 0xea6b5023.7f93417f Aug 17 23:36:51 tube-rivo-audio ntpd[3383]: receive: Unexpected origin timestamp 0xea6b3c58.9e3cf2cb does not match aorg 0000000000.00000000 from server@27.54.117.72 xmt 0xea6b5023.83cb3bb0 Aug 17 23:36:51 tube-rivo-audio ntpd[3383]: receive: Unexpected origin timestamp 0xea6b3c58.9e3f4bca does not match aorg 0000000000.00000000 from server@103.134.77.146 xmt 0xea6b5023.8412f887 Aug 17 23:36:51 tube-rivo-audio kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04e6c2000 drv_status 0x0 e_type 69 e_states 8 Aug 17 23:36:51 tube-rivo-audio volumio[3395]: info: [1723912611596] Starting BluetoothController Aug 17 23:36:51 tube-rivo-audio volumio[3395]: info: Loading plugin "alarm-clock"... Aug 17 23:36:51 tube-rivo-audio kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04e6c2000 drv_status 0x0 e_type 69 e_states 8 Aug 17 23:36:51 tube-rivo-audio kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04e6c2000 drv_status 0x0 e_type 69 e_states 8 Aug 17 23:36:52 tube-rivo-audio volumio[3395]: info: Loading plugin "manifestui"... Aug 17 23:36:52 tube-rivo-audio kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04e6c2000 drv_status 0x0 e_type 69 e_states 8 Aug 17 23:36:52 tube-rivo-audio volumio[3395]: info: Loading plugin "metavolumio"... Aug 17 23:36:52 tube-rivo-audio systemd[1]: systemd-fsckd.service: Succeeded. Aug 17 23:36:52 tube-rivo-audio kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04e6c2000 drv_status 0x0 e_type 69 e_states 8 Aug 17 23:36:53 tube-rivo-audio kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04e6c2000 drv_status 0x0 e_type 69 e_states 8 Aug 17 23:36:53 tube-rivo-audio kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04e6c2000 drv_status 0x0 e_type 69 e_states 8 Aug 17 23:36:53 tube-rivo-audio volumio[3395]: info: Plugin airplay_emulation is not enabled Aug 17 23:36:53 tube-rivo-audio volumio[3395]: info: Plugin cd_controller is not enabled Aug 17 23:36:53 tube-rivo-audio volumio[3395]: info: Loading plugin "last_100"... Aug 17 23:36:53 tube-rivo-audio volumio[3395]: info: Plugin raat is not enabled Aug 17 23:36:53 tube-rivo-audio volumio[3395]: info: Loading plugin "streaming_services"... Aug 17 23:36:54 tube-rivo-audio kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04e6c2000 drv_status 0x0 e_type 69 e_states 8 Aug 17 23:36:54 tube-rivo-audio kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04e6c2000 drv_status 0x0 e_type 69 e_states 8 Aug 17 23:36:54 tube-rivo-audio kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04e6c2000 drv_status 0x0 e_type 69 e_states 0 Aug 17 23:36:55 tube-rivo-audio sudo[3433]: pam_unix(sudo:session): session closed for user root Aug 17 23:36:55 tube-rivo-audio volumio[3395]: info: Starting Streaming Service Transparent Proxy Aug 17 23:36:55 tube-rivo-audio volumio[3395]: info: Loading plugin "tidalconnect"... Aug 17 23:36:55 tube-rivo-audio volumio[3395]: info: Loading plugin "webradio"... Aug 17 23:36:56 tube-rivo-audio volumio[3395]: info: Loading plugin "i2s_dacs"... Aug 17 23:36:56 tube-rivo-audio volumio[3395]: info: I2S DAC not set, start Auto-detection Aug 17 23:36:56 tube-rivo-audio volumio[3395]: info: Loading plugin "volumiodiscovery"... Aug 17 23:36:56 tube-rivo-audio volumio[3395]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Aug 17 23:36:56 tube-rivo-audio volumio[3395]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 17 23:36:56 tube-rivo-audio volumio[3395]: *** WARNING *** For more information see Aug 17 23:36:56 tube-rivo-audio node[3395]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Aug 17 23:36:56 tube-rivo-audio volumio[3395]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Aug 17 23:36:56 tube-rivo-audio volumio[3395]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 17 23:36:56 tube-rivo-audio volumio[3395]: *** WARNING *** For more information see Aug 17 23:36:56 tube-rivo-audio node[3395]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 17 23:36:56 tube-rivo-audio volumio[3395]: info: Applying required configuration parameters for plugin volumiodiscovery Aug 17 23:36:56 tube-rivo-audio node[3395]: *** WARNING *** For more information see Aug 17 23:36:56 tube-rivo-audio node[3395]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Aug 17 23:36:56 tube-rivo-audio node[3395]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 17 23:36:56 tube-rivo-audio node[3395]: *** WARNING *** For more information see Aug 17 23:36:56 tube-rivo-audio volumio[3395]: info: Discovery: Started advertising with name: Tube Rivo Audio Aug 17 23:36:56 tube-rivo-audio volumio[3395]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 17 23:36:56 tube-rivo-audio volumio[3395]: info: Plugin multiroom is not enabled Aug 17 23:36:56 tube-rivo-audio volumio[3395]: info: Loading plugin "outputs"... Aug 17 23:36:56 tube-rivo-audio volumio[3395]: info: Loading plugin "albumart"... Aug 17 23:36:56 tube-rivo-audio volumio[3395]: info: Plugin example_plugin is not enabled Aug 17 23:36:56 tube-rivo-audio volumio[3395]: info: Loading plugin "hi_res_audio"... Aug 17 23:36:56 tube-rivo-audio volumio[3395]: Forking 3 albumart workers Aug 17 23:36:57 tube-rivo-audio volumio[3395]: STREAMING PROXY: Starting server on port 3245 Aug 17 23:36:57 tube-rivo-audio volumio[3395]: Node JS runtime: 14 Aug 17 23:36:57 tube-rivo-audio volumio[3395]: Starting albumart workers Aug 17 23:36:57 tube-rivo-audio volumio[3395]: Starting albumart workers Aug 17 23:36:57 tube-rivo-audio volumio[3395]: Starting albumart workers Aug 17 23:36:58 tube-rivo-audio volumio[3395]: info: Applying required configuration parameters for plugin hi_res_audio Aug 17 23:36:58 tube-rivo-audio volumio[3395]: info: Loading plugin "inputs"... Aug 17 23:36:59 tube-rivo-audio volumio[3395]: info: Loading plugin "qobuz"... Aug 17 23:37:01 tube-rivo-audio volumio[3395]: info: Plugin smart_inputs is not enabled Aug 17 23:37:01 tube-rivo-audio volumio[3395]: info: Loading plugin "tidal"... Aug 17 23:37:02 tube-rivo-audio volumio-remote-updater[2839]: [2024-08-17 23:37:02] [connect] Successful connection Aug 17 23:37:02 tube-rivo-audio volumio[3395]: info: Loading plugin "rivocontrol"... Aug 17 23:37:03 tube-rivo-audio volumio[3395]: info: Adding this device properties Aug 17 23:37:03 tube-rivo-audio volumio[3395]: info: CoreCommandRouter::executeOnPlugin: system , setThisDeviceVolumioProperties Aug 17 23:37:03 tube-rivo-audio volumio[3395]: info: Setting Additional Device Volumio Properties: [object Object] Aug 17 23:37:03 tube-rivo-audio volumio[3395]: info: Loading plugin "updater_comm"... Aug 17 23:37:03 tube-rivo-audio volumio[3395]: info: Loading plugin "cec_controller"... Aug 17 23:37:03 tube-rivo-audio volumio[3395]: info: Applying required configuration parameters for plugin cec_controller Aug 17 23:37:03 tube-rivo-audio volumio[3395]: info: Plugin mpdemulation is not enabled Aug 17 23:37:03 tube-rivo-audio volumio[3395]: info: Loading plugin "rest_api"... Aug 17 23:37:03 tube-rivo-audio volumio[3395]: info: Loading plugin "websocket"... Aug 17 23:37:03 tube-rivo-audio volumio[3395]: info: Starting Socket.io Server version 2.3.0 Aug 17 23:37:03 tube-rivo-audio volumio[3395]: info: Loading plugin "fusiondsp"... Aug 17 23:37:04 tube-rivo-audio volumio[3395]: info: Applying required configuration parameters for plugin fusiondsp Aug 17 23:37:04 tube-rivo-audio volumio[3395]: info: Loading i18n strings for locale en Aug 17 23:37:04 tube-rivo-audio volumio[3395]: Updating browse sources language Aug 17 23:37:04 tube-rivo-audio volumio[3395]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 17 23:37:04 tube-rivo-audio systemd[1]: systemd-hostnamed.service: Succeeded. Aug 17 23:37:04 tube-rivo-audio volumio[3395]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 17 23:37:04 tube-rivo-audio volumio[3395]: info: CoreCommandRouter::initPlayerControls Aug 17 23:37:04 tube-rivo-audio volumio[3395]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 23:37:04 tube-rivo-audio volumio[3395]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 23:37:04 tube-rivo-audio volumio[3395]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 23:37:04 tube-rivo-audio volumio[3395]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 17 23:37:04 tube-rivo-audio volumio[3395]: Express server listening on port 3000 Aug 17 23:37:04 tube-rivo-audio volumio[3395]: [Metrics] WebUI: 18s 702.73ms Aug 17 23:37:04 tube-rivo-audio volumio[3395]: info: CoreStateMachine::resetVolumioState Aug 17 23:37:04 tube-rivo-audio volumio[3395]: info: CoreStateMachine::getcurrentVolume Aug 17 23:37:04 tube-rivo-audio volumio[3395]: info: CoreCommandRouter::volumioRetrievevolume Aug 17 23:37:04 tube-rivo-audio volumio[3395]: info: CoreStateMachine::pushState Aug 17 23:37:04 tube-rivo-audio volumio[3395]: info: CorePlayQueue::getTrack 0 Aug 17 23:37:04 tube-rivo-audio volumio[3395]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 17 23:37:04 tube-rivo-audio volumio[3395]: info: CoreCommandRouter::volumioPushState Aug 17 23:37:05 tube-rivo-audio volumio[3395]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 17 23:37:05 tube-rivo-audio volumio[3395]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Aug 17 23:37:05 tube-rivo-audio volumio[3395]: info: Completed loading Core Plugins Aug 17 23:37:05 tube-rivo-audio volumio[3395]: info: Preparing to generate the ALSA configuration file Aug 17 23:37:05 tube-rivo-audio volumio[3395]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Aug 17 23:37:05 tube-rivo-audio volumio[3395]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Aug 17 23:37:05 tube-rivo-audio volumio[3395]: info: Reading ALSA contributions from plugins. Aug 17 23:37:05 tube-rivo-audio volumio-remote-updater[2839]: [2024-08-17 23:37:05] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1723912622 101 Aug 17 23:37:05 tube-rivo-audio volumio[3395]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 1 Aug 17 23:37:05 tube-rivo-audio volumio[3395]: info: Reloading queue from file Aug 17 23:37:05 tube-rivo-audio volumio[3395]: info: CoreStateMachine::setRepeat false single undefined Aug 17 23:37:05 tube-rivo-audio volumio[3395]: info: CoreStateMachine::pushState Aug 17 23:37:05 tube-rivo-audio volumio[3395]: info: CorePlayQueue::getTrack 0 Aug 17 23:37:05 tube-rivo-audio volumio[3395]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 17 23:37:05 tube-rivo-audio volumio[3395]: info: CoreCommandRouter::volumioPushState Aug 17 23:37:05 tube-rivo-audio volumio[3395]: info: CoreStateMachine::setRandom false Aug 17 23:37:05 tube-rivo-audio volumio[3395]: info: CoreStateMachine::pushState Aug 17 23:37:05 tube-rivo-audio volumio[3395]: info: CorePlayQueue::getTrack 0 Aug 17 23:37:05 tube-rivo-audio volumio[3395]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 17 23:37:05 tube-rivo-audio volumio[3395]: info: CoreCommandRouter::volumioPushState Aug 17 23:37:05 tube-rivo-audio volumio[3395]: info: Asound.conf file unchanged, so no further update is needed Aug 17 23:37:05 tube-rivo-audio volumio[3395]: info: Output device has changed, restarting MPD Aug 17 23:37:05 tube-rivo-audio sudo[3521]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 17 23:37:05 tube-rivo-audio sudo[3521]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 23:37:05 tube-rivo-audio volumio[3395]: info: ___________ START PLUGINS ___________ Aug 17 23:37:05 tube-rivo-audio sudo[3521]: pam_unix(sudo:session): session closed for user root Aug 17 23:37:05 tube-rivo-audio volumio[3395]: info: ControllerMpd::onStart: Initializing MPD Aug 17 23:37:05 tube-rivo-audio volumio[3395]: info: Creating MPD Configuration file Aug 17 23:37:05 tube-rivo-audio sudo[3523]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 17 23:37:05 tube-rivo-audio sudo[3523]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 23:37:05 tube-rivo-audio sudo[3527]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 17 23:37:05 tube-rivo-audio sudo[3527]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 23:37:05 tube-rivo-audio volumio[3395]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 17 23:37:05 tube-rivo-audio systemd[1]: Listening on mpd.socket. Aug 17 23:37:05 tube-rivo-audio sudo[3527]: pam_unix(sudo:session): session closed for user root Aug 17 23:37:05 tube-rivo-audio systemd[1]: Starting Music Player Daemon... Aug 17 23:37:05 tube-rivo-audio sudo[3529]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 17 23:37:05 tube-rivo-audio sudo[3529]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 23:37:05 tube-rivo-audio volumio[3395]: info: Adding METAVOLUMIO REST API Endpoints Aug 17 23:37:05 tube-rivo-audio volumio[3395]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Aug 17 23:37:05 tube-rivo-audio volumio[3395]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio Aug 17 23:37:05 tube-rivo-audio volumio[3395]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio Aug 17 23:37:05 tube-rivo-audio volumio[3395]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio Aug 17 23:37:05 tube-rivo-audio volumio[3395]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 17 23:37:05 tube-rivo-audio volumio[3395]: info: [1723912625502] CoreMusicLibrary::Adding element Last_100 Aug 17 23:37:05 tube-rivo-audio volumio[3395]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 17 23:37:05 tube-rivo-audio volumio[3395]: info: Streaming services startup Aug 17 23:37:05 tube-rivo-audio volumio[3395]: info: Starting Streaming Daemon Aug 17 23:37:05 tube-rivo-audio sudo[3541]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/hciconfig hci0 name Tube Rivo Audio Aug 17 23:37:05 tube-rivo-audio sudo[3541]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 23:37:05 tube-rivo-audio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Aug 17 23:37:05 tube-rivo-audio systemd[1]: mpd.service: Succeeded. Aug 17 23:37:05 tube-rivo-audio systemd[1]: Stopped Music Player Daemon. Aug 17 23:37:05 tube-rivo-audio sudo[3541]: pam_unix(sudo:session): session closed for user root Aug 17 23:37:05 tube-rivo-audio systemd[1]: Starting Music Player Daemon... Aug 17 23:37:05 tube-rivo-audio sudo[3544]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Aug 17 23:37:05 tube-rivo-audio sudo[3544]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 23:37:05 tube-rivo-audio sudo[3544]: pam_unix(sudo:session): session closed for user root Aug 17 23:37:05 tube-rivo-audio volumio[3395]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 17 23:37:05 tube-rivo-audio volumio[3395]: info: [1723912625655] CoreMusicLibrary::Adding element Webradio Aug 17 23:37:05 tube-rivo-audio volumio[3395]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 17 23:37:05 tube-rivo-audio volumio[3395]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 17 23:37:05 tube-rivo-audio volumio[3395]: info: Initializing BBC Radios Aug 17 23:37:05 tube-rivo-audio sudo[3555]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Aug 17 23:37:05 tube-rivo-audio sudo[3555]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 23:37:05 tube-rivo-audio sudo[3545]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 17 23:37:05 tube-rivo-audio sudo[3545]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 23:37:05 tube-rivo-audio sudo[3545]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Aug 17 23:37:05 tube-rivo-audio sudo[3545]: pam_unix(sudo:session): session closed for user root Aug 17 23:37:05 tube-rivo-audio sudo[3555]: pam_unix(sudo:session): session closed for user root Aug 17 23:37:05 tube-rivo-audio volumio[3395]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 17 23:37:05 tube-rivo-audio volumio[3395]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 17 23:37:05 tube-rivo-audio volumio[3395]: error: Hi Res Audio Failed Login: Missing Login Data Aug 17 23:37:05 tube-rivo-audio volumio[3395]: info: Adding HIGHRESAUDIO REST API Endpoints Aug 17 23:37:05 tube-rivo-audio volumio[3395]: info: Adding getStreamUrlhi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Aug 17 23:37:05 tube-rivo-audio volumio[3395]: info: Initializing Serial Communication on port /dev/ttyS3 Aug 17 23:37:05 tube-rivo-audio kernel: meson_uart ffd22000.serial: ttyS3 use xtal(24M) 24000000 change 0 to 9600 Aug 17 23:37:05 tube-rivo-audio kernel: meson_uart ffd22000.serial: ttyS3 use xtal(24M) 24000000 change 9600 to 9600 Aug 17 23:37:05 tube-rivo-audio kernel: meson_uart ffd22000.serial: ttyS3 use xtal(24M) 24000000 change 9600 to 115200 Aug 17 23:37:05 tube-rivo-audio volumio[3395]: info: Touch Event Listener Process Starting Aug 17 23:37:05 tube-rivo-audio volumio[3395]: info: Refreshing TIDAL token Aug 17 23:37:05 tube-rivo-audio sudo[3572]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/xinput --test-xi2 --root Aug 17 23:37:05 tube-rivo-audio sudo[3572]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 23:37:05 tube-rivo-audio sudo[3572]: pam_unix(sudo:session): session closed for user root Aug 17 23:37:05 tube-rivo-audio sudo[3581]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x25 0x0 Aug 17 23:37:05 tube-rivo-audio sudo[3581]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 23:37:05 tube-rivo-audio sudo[3581]: pam_unix(sudo:session): session closed for user root Aug 17 23:37:05 tube-rivo-audio sudo[3584]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x28 0x0 Aug 17 23:37:05 tube-rivo-audio sudo[3584]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 23:37:05 tube-rivo-audio sudo[3584]: pam_unix(sudo:session): session closed for user root Aug 17 23:37:06 tube-rivo-audio sudo[3587]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x29 0x1 Aug 17 23:37:06 tube-rivo-audio sudo[3587]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 23:37:06 tube-rivo-audio sudo[3587]: pam_unix(sudo:session): session closed for user root Aug 17 23:37:06 tube-rivo-audio sudo[3590]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x33 0x1 Aug 17 23:37:06 tube-rivo-audio sudo[3590]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 23:37:06 tube-rivo-audio sudo[3590]: pam_unix(sudo:session): session closed for user root Aug 17 23:37:06 tube-rivo-audio volumio[3395]: info: Apply VIM3L Onboard LEDs Settings Aug 17 23:37:06 tube-rivo-audio volumio[3395]: info: Turning On Onboard LEDs Aug 17 23:37:06 tube-rivo-audio sudo[3594]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/tee /sys/class/leds/sys_led/trigger Aug 17 23:37:06 tube-rivo-audio sudo[3594]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 23:37:06 tube-rivo-audio volumio[3395]: info: Starting CEC Event listener Aug 17 23:37:06 tube-rivo-audio volumio[3395]: info: Loading i18n strings for locale en Aug 17 23:37:06 tube-rivo-audio sudo[3594]: pam_unix(sudo:session): session closed for user root Aug 17 23:37:06 tube-rivo-audio volumio[3395]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Aug 17 23:37:06 tube-rivo-audio volumio[3395]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 23:37:06 tube-rivo-audio volumio[3395]: info: FusionDsp - mixtype--------------------- None Aug 17 23:37:06 tube-rivo-audio volumio[3395]: info: Volumio Calling Home Aug 17 23:37:06 tube-rivo-audio sudo[3598]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/tee /sys/class/leds/red_red/trigger Aug 17 23:37:06 tube-rivo-audio sudo[3598]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 23:37:06 tube-rivo-audio sudo[3598]: pam_unix(sudo:session): session closed for user root Aug 17 23:37:06 tube-rivo-audio volumio[3395]: info: Preparing to generate the ALSA configuration file Aug 17 23:37:06 tube-rivo-audio volumio[3395]: info: Stopping AccessToken refresher cron for QOBUZ Aug 17 23:37:06 tube-rivo-audio volumio[3395]: info: AccessToken refresher cron started for QOBUZ Aug 17 23:37:06 tube-rivo-audio volumio[3395]: info: Adding QOBUZ REST API Endpoints Aug 17 23:37:06 tube-rivo-audio volumio[3395]: info: Adding getStreamUrlqobuz REST Endpoint for plugin: music_service/qobuz Aug 17 23:37:06 tube-rivo-audio volumio[3395]: info: Discovery: adding 1dc99a61-aea2-484f-a46a-3e4958b3c4a9 Aug 17 23:37:06 tube-rivo-audio volumio[3395]: info: Discovery: Found device Tube Rivo Audio Aug 17 23:37:06 tube-rivo-audio volumio[3395]: info: CoreCommandRouter::volumioGetState Aug 17 23:37:06 tube-rivo-audio volumio[3395]: info: CorePlayQueue::getTrack 0 Aug 17 23:37:06 tube-rivo-audio volumio[3395]: info: Discovery: this is already registered, 1dc99a61-aea2-484f-a46a-3e4958b3c4a9 Aug 17 23:37:06 tube-rivo-audio volumio[3395]: info: Discovery: Found device Tube Rivo Audio Aug 17 23:37:06 tube-rivo-audio volumio[3395]: info: CoreCommandRouter::volumioGetState Aug 17 23:37:06 tube-rivo-audio volumio[3395]: info: CorePlayQueue::getTrack 0 Aug 17 23:37:06 tube-rivo-audio volumio[3395]: info: Serial port opened successfully Aug 17 23:37:06 tube-rivo-audio volumio[3395]: info: Sending serial start messages Aug 17 23:37:06 tube-rivo-audio volumio[3395]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 23:37:06 tube-rivo-audio volumio[3395]: info: MP1 GPIO: Signalled system ready via GPIO Aug 17 23:37:06 tube-rivo-audio volumio[3395]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Aug 17 23:37:06 tube-rivo-audio volumio[3395]: info: Reading ALSA contributions from plugins. Aug 17 23:37:06 tube-rivo-audio volumio[3395]: info: Touch Event Listener Process Closed Aug 17 23:37:06 tube-rivo-audio volumio[3395]: error: Cannot start Volumio Streaming Daemon Aug 17 23:37:06 tube-rivo-audio volumio[3395]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Aug 17 23:37:06 tube-rivo-audio volumio[3395]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Aug 17 23:37:06 tube-rivo-audio volumio[3395]: info: Bluetooth name changed to Tube Rivo Audio Aug 17 23:37:06 tube-rivo-audio volumio[3395]: info: MPD Permissions set Aug 17 23:37:06 tube-rivo-audio volumio[3395]: info: MPD Permissions set Aug 17 23:37:06 tube-rivo-audio volumio[3395]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Aug 17 23:37:06 tube-rivo-audio volumio[3395]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 23:37:06 tube-rivo-audio volumio[3395]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 23:37:06 tube-rivo-audio volumio[3395]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 23:37:06 tube-rivo-audio volumio[3395]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 23:37:06 tube-rivo-audio volumio[3395]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 23:37:06 tube-rivo-audio volumio[3395]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 23:37:06 tube-rivo-audio volumio[3395]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 23:37:06 tube-rivo-audio volumio[3395]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 23:37:06 tube-rivo-audio volumio[3395]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 17 23:37:06 tube-rivo-audio volumio[3395]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Aug 17 23:37:06 tube-rivo-audio volumio[3395]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 23:37:06 tube-rivo-audio volumio[3395]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 23:37:06 tube-rivo-audio volumio[3395]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 23:37:06 tube-rivo-audio volumio[3395]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 23:37:06 tube-rivo-audio volumio[3395]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 23:37:06 tube-rivo-audio volumio[3395]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 23:37:06 tube-rivo-audio volumio[3395]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 23:37:06 tube-rivo-audio volumio[3395]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 23:37:06 tube-rivo-audio volumio[3395]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 23:37:07 tube-rivo-audio volumio[3395]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 17 23:37:07 tube-rivo-audio volumio[3395]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Aug 17 23:37:07 tube-rivo-audio volumio[3395]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 23:37:07 tube-rivo-audio volumio[3395]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Aug 17 23:37:07 tube-rivo-audio volumio[3395]: info: Volumio called home Aug 17 23:37:07 tube-rivo-audio volumio[3395]: info: CoreCommandRouter::volumioGetState Aug 17 23:37:07 tube-rivo-audio volumio[3395]: info: CorePlayQueue::getTrack 0 Aug 17 23:37:07 tube-rivo-audio volumio[3395]: info: CoreCommandRouter::volumioGetState Aug 17 23:37:07 tube-rivo-audio volumio[3395]: info: CorePlayQueue::getTrack 0 Aug 17 23:37:07 tube-rivo-audio volumio[3395]: info: Asound.conf file unchanged, so no further update is needed Aug 17 23:37:07 tube-rivo-audio volumio[3395]: info: Output device has changed, restarting MPD Aug 17 23:37:07 tube-rivo-audio volumio[3395]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 23:37:07 tube-rivo-audio sudo[3620]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 17 23:37:07 tube-rivo-audio sudo[3620]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 23:37:07 tube-rivo-audio sudo[3620]: pam_unix(sudo:session): session closed for user root Aug 17 23:37:07 tube-rivo-audio sudo[3622]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 17 23:37:07 tube-rivo-audio sudo[3622]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 23:37:07 tube-rivo-audio volumio[3395]: info: MPD Permissions set Aug 17 23:37:07 tube-rivo-audio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Aug 17 23:37:07 tube-rivo-audio systemd[1]: mpd.service: Succeeded. Aug 17 23:37:07 tube-rivo-audio systemd[1]: Stopped Music Player Daemon. Aug 17 23:37:07 tube-rivo-audio volumio[3395]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 23:37:07 tube-rivo-audio volumio[3395]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 23:37:07 tube-rivo-audio volumio[3395]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 23:37:07 tube-rivo-audio volumio[3395]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 23:37:07 tube-rivo-audio volumio[3395]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 23:37:07 tube-rivo-audio volumio[3395]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 23:37:07 tube-rivo-audio systemd[1]: Starting Music Player Daemon... Aug 17 23:37:07 tube-rivo-audio volumio[3395]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 23:37:07 tube-rivo-audio volumio[3395]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 17 23:37:07 tube-rivo-audio volumio[3395]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Aug 17 23:37:07 tube-rivo-audio volumio[3395]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 23:37:07 tube-rivo-audio sudo[3625]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 17 23:37:07 tube-rivo-audio sudo[3625]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 23:37:07 tube-rivo-audio sudo[3625]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Aug 17 23:37:07 tube-rivo-audio sudo[3625]: pam_unix(sudo:session): session closed for user root Aug 17 23:37:07 tube-rivo-audio volumio[3395]: info: Access Token successfully retrieved Aug 17 23:37:08 tube-rivo-audio volumio[3395]: info: camilladsp spawned new process with pid undefined, instance 1, run: true Aug 17 23:37:08 tube-rivo-audio volumio[3395]: info: camilladsp service started and running in background, instance 1 Aug 17 23:37:08 tube-rivo-audio volumio[3395]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 23:37:08 tube-rivo-audio volumio[3395]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Aug 17 23:37:08 tube-rivo-audio volumio[3395]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Aug 17 23:37:08 tube-rivo-audio volumio[3395]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Aug 17 23:37:08 tube-rivo-audio volumio[3395]: info: FusionDsp loaded Aug 17 23:37:08 tube-rivo-audio volumio[3395]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 17 23:37:08 tube-rivo-audio sudo[3645]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Aug 17 23:37:08 tube-rivo-audio sudo[3645]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 23:37:08 tube-rivo-audio volumio[3395]: info: FusionDsp - Reporting Fusion DSP Enabled Aug 17 23:37:08 tube-rivo-audio volumio[3395]: info: Adding Signal Path Element [object Object] Aug 17 23:37:08 tube-rivo-audio volumio[3395]: info: Adding fusiondspeq DSP Signal Path Element Aug 17 23:37:08 tube-rivo-audio volumio[3395]: info: FusionDsp - ---- installed callbackRead Aug 17 23:37:08 tube-rivo-audio volumio[3395]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 17 23:37:08 tube-rivo-audio sudo[3645]: pam_unix(sudo:session): session closed for user root Aug 17 23:37:08 tube-rivo-audio volumio[3395]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Aug 17 23:37:08 tube-rivo-audio volumio[3395]: at Process.ChildProcess._handle.onexit (internal/child_process.js:277:19) Aug 17 23:37:08 tube-rivo-audio volumio[3395]: at onErrorNT (internal/child_process.js:472:16) Aug 17 23:37:08 tube-rivo-audio volumio[3395]: at processTicksAndRejections (internal/process/task_queues.js:82:21) { Aug 17 23:37:08 tube-rivo-audio volumio[3395]: errno: -2, Aug 17 23:37:08 tube-rivo-audio volumio[3395]: code: 'ENOENT', Aug 17 23:37:08 tube-rivo-audio volumio[3395]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Aug 17 23:37:08 tube-rivo-audio volumio[3395]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Aug 17 23:37:08 tube-rivo-audio volumio[3395]: spawnargs: [ Aug 17 23:37:08 tube-rivo-audio volumio[3395]: '-p', Aug 17 23:37:08 tube-rivo-audio volumio[3395]: 9876, Aug 17 23:37:08 tube-rivo-audio volumio[3395]: '-o', Aug 17 23:37:08 tube-rivo-audio volumio[3395]: '/tmp/camilladsp.log', Aug 17 23:37:08 tube-rivo-audio volumio[3395]: '-l', Aug 17 23:37:08 tube-rivo-audio volumio[3395]: 'warn', Aug 17 23:37:08 tube-rivo-audio volumio[3395]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Aug 17 23:37:08 tube-rivo-audio volumio[3395]: ] Aug 17 23:37:08 tube-rivo-audio volumio[3395]: } Aug 17 23:37:08 tube-rivo-audio volumio[3395]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 17 23:37:08 tube-rivo-audio kernel: fb: mem_free_work, free memory: addr:800000 Aug 17 23:37:09 tube-rivo-audio sudo[3656]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-08-17 23:36 Aug 17 23:37:09 tube-rivo-audio sudo[3656]: 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="5fd3886148e72a9cecd88a772d1f6079fb64d11a" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8bb23b009e91ae4c7ecd678f193e7d3b281fca0c" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="rivo" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 22 Jul 2024 05:06:46 PM CEST" VOLUMIO_VERSION="3.742" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Rivo" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Rivo" VOLUMIO_HASH="420eec03f218d056e8306370042003fc"