-- Logs begin at Sat 2024-08-17 21:03:45 WIB, end at Sat 2024-08-17 21:38:33 WIB. -- Aug 17 21:38:17 tube-rivo-audio ntpd[3377]: receive: Unexpected origin timestamp 0xea6b2c5e.6e72e7e3 does not match aorg 0000000000.00000000 from server@14.102.153.110 xmt 0xea6b3459.89aad0f2 Aug 17 21:38:17 tube-rivo-audio ntpd[3377]: receive: Unexpected origin timestamp 0xea6b2c5e.6e6e7175 does not match aorg 0000000000.00000000 from server@202.65.114.202 xmt 0xea6b3459.8aced478 Aug 17 21:38:17 tube-rivo-audio ntpd[3377]: receive: Unexpected origin timestamp 0xea6b2c5e.6e67623b does not match aorg 0000000000.00000000 from server@114.30.89.30 xmt 0xea6b3459.90ada36f Aug 17 21:38:17 tube-rivo-audio volumio[3389]: info: Plugin airplay_emulation is not enabled Aug 17 21:38:17 tube-rivo-audio volumio[3389]: info: Plugin cd_controller is not enabled Aug 17 21:38:17 tube-rivo-audio volumio[3389]: info: Loading plugin "last_100"... Aug 17 21:38:17 tube-rivo-audio volumio[3389]: info: Plugin raat is not enabled Aug 17 21:38:17 tube-rivo-audio volumio[3389]: info: Loading plugin "streaming_services"... Aug 17 21:38:17 tube-rivo-audio kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc03cfb9000 drv_status 0x0 e_type 69 e_states 8 Aug 17 21:38:18 tube-rivo-audio kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc03cfb9000 drv_status 0x0 e_type 69 e_states 8 Aug 17 21:38:18 tube-rivo-audio kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc03cfb9000 drv_status 0x0 e_type 69 e_states 8 Aug 17 21:38:18 tube-rivo-audio kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc03cfb9000 drv_status 0x0 e_type 69 e_states 0 Aug 17 21:38:18 tube-rivo-audio sudo[3426]: pam_unix(sudo:session): session closed for user root Aug 17 21:38:19 tube-rivo-audio volumio[3389]: info: Starting Streaming Service Transparent Proxy Aug 17 21:38:19 tube-rivo-audio volumio[3389]: info: Loading plugin "tidalconnect"... Aug 17 21:38:19 tube-rivo-audio volumio[3389]: info: Loading plugin "webradio"... Aug 17 21:38:20 tube-rivo-audio volumio[3389]: info: Loading plugin "i2s_dacs"... Aug 17 21:38:20 tube-rivo-audio volumio[3389]: info: I2S DAC not set, start Auto-detection Aug 17 21:38:20 tube-rivo-audio volumio[3389]: info: Loading plugin "volumiodiscovery"... Aug 17 21:38:20 tube-rivo-audio volumio[3389]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Aug 17 21:38:20 tube-rivo-audio volumio[3389]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 17 21:38:20 tube-rivo-audio volumio[3389]: *** WARNING *** For more information see Aug 17 21:38:20 tube-rivo-audio node[3389]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Aug 17 21:38:20 tube-rivo-audio volumio[3389]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Aug 17 21:38:20 tube-rivo-audio volumio[3389]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 17 21:38:20 tube-rivo-audio volumio[3389]: *** WARNING *** For more information see Aug 17 21:38:20 tube-rivo-audio node[3389]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 17 21:38:20 tube-rivo-audio volumio[3389]: info: Applying required configuration parameters for plugin volumiodiscovery Aug 17 21:38:20 tube-rivo-audio volumio[3389]: info: Discovery: Started advertising with name: Tube Rivo Audio Aug 17 21:38:20 tube-rivo-audio node[3389]: *** WARNING *** For more information see Aug 17 21:38:20 tube-rivo-audio node[3389]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Aug 17 21:38:20 tube-rivo-audio node[3389]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 17 21:38:20 tube-rivo-audio node[3389]: *** WARNING *** For more information see Aug 17 21:38:20 tube-rivo-audio volumio[3389]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 17 21:38:20 tube-rivo-audio volumio[3389]: info: Plugin multiroom is not enabled Aug 17 21:38:20 tube-rivo-audio volumio[3389]: info: Loading plugin "outputs"... Aug 17 21:38:20 tube-rivo-audio volumio[3389]: info: Loading plugin "albumart"... Aug 17 21:38:20 tube-rivo-audio volumio[3389]: info: Plugin example_plugin is not enabled Aug 17 21:38:20 tube-rivo-audio volumio[3389]: info: Loading plugin "hi_res_audio"... Aug 17 21:38:20 tube-rivo-audio volumio[3389]: Forking 3 albumart workers Aug 17 21:38:21 tube-rivo-audio volumio[3389]: STREAMING PROXY: Starting server on port 3245 Aug 17 21:38:21 tube-rivo-audio volumio[3389]: Node JS runtime: 14 Aug 17 21:38:21 tube-rivo-audio systemd[1]: systemd-fsckd.service: Succeeded. Aug 17 21:38:21 tube-rivo-audio volumio[3389]: Starting albumart workers Aug 17 21:38:21 tube-rivo-audio volumio[3389]: Starting albumart workers Aug 17 21:38:21 tube-rivo-audio volumio[3389]: Starting albumart workers Aug 17 21:38:22 tube-rivo-audio volumio[3389]: info: Applying required configuration parameters for plugin hi_res_audio Aug 17 21:38:22 tube-rivo-audio volumio[3389]: info: Loading plugin "inputs"... Aug 17 21:38:23 tube-rivo-audio volumio[3389]: info: Loading plugin "qobuz"... Aug 17 21:38:25 tube-rivo-audio volumio[3389]: info: Plugin smart_inputs is not enabled Aug 17 21:38:25 tube-rivo-audio volumio[3389]: info: Loading plugin "tidal"... Aug 17 21:38:26 tube-rivo-audio volumio[3389]: info: Loading plugin "rivocontrol"... Aug 17 21:38:27 tube-rivo-audio volumio[3389]: info: Adding this device properties Aug 17 21:38:27 tube-rivo-audio volumio[3389]: info: CoreCommandRouter::executeOnPlugin: system , setThisDeviceVolumioProperties Aug 17 21:38:27 tube-rivo-audio volumio[3389]: info: Setting Additional Device Volumio Properties: [object Object] Aug 17 21:38:27 tube-rivo-audio volumio[3389]: info: Loading plugin "updater_comm"... Aug 17 21:38:27 tube-rivo-audio volumio[3389]: info: Loading plugin "cec_controller"... Aug 17 21:38:27 tube-rivo-audio volumio[3389]: info: Applying required configuration parameters for plugin cec_controller Aug 17 21:38:27 tube-rivo-audio volumio[3389]: info: Plugin mpdemulation is not enabled Aug 17 21:38:27 tube-rivo-audio volumio[3389]: info: Loading plugin "rest_api"... Aug 17 21:38:27 tube-rivo-audio volumio[3389]: info: Loading plugin "websocket"... Aug 17 21:38:27 tube-rivo-audio volumio[3389]: info: Starting Socket.io Server version 2.3.0 Aug 17 21:38:27 tube-rivo-audio volumio[3389]: info: Loading plugin "fusiondsp"... Aug 17 21:38:28 tube-rivo-audio volumio[3389]: info: Applying required configuration parameters for plugin fusiondsp Aug 17 21:38:28 tube-rivo-audio volumio[3389]: info: Loading i18n strings for locale en Aug 17 21:38:28 tube-rivo-audio volumio[3389]: Updating browse sources language Aug 17 21:38:28 tube-rivo-audio volumio[3389]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 17 21:38:28 tube-rivo-audio volumio[3389]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 17 21:38:28 tube-rivo-audio volumio[3389]: info: CoreCommandRouter::initPlayerControls Aug 17 21:38:28 tube-rivo-audio volumio[3389]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 21:38:28 tube-rivo-audio volumio[3389]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 21:38:28 tube-rivo-audio volumio[3389]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 21:38:28 tube-rivo-audio volumio[3389]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 21:38:28 tube-rivo-audio volumio[3389]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 21:38:28 tube-rivo-audio volumio[3389]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 21:38:28 tube-rivo-audio volumio[3389]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 21:38:28 tube-rivo-audio volumio[3389]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 21:38:28 tube-rivo-audio volumio[3389]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 17 21:38:28 tube-rivo-audio volumio[3389]: Express server listening on port 3000 Aug 17 21:38:28 tube-rivo-audio volumio[3389]: [Metrics] WebUI: 18s 935.13ms Aug 17 21:38:28 tube-rivo-audio volumio[3389]: info: CoreStateMachine::resetVolumioState Aug 17 21:38:28 tube-rivo-audio volumio[3389]: info: CoreStateMachine::getcurrentVolume Aug 17 21:38:28 tube-rivo-audio volumio[3389]: info: CoreCommandRouter::volumioRetrievevolume Aug 17 21:38:28 tube-rivo-audio volumio[3389]: info: CoreStateMachine::pushState Aug 17 21:38:28 tube-rivo-audio volumio[3389]: info: CorePlayQueue::getTrack 0 Aug 17 21:38:28 tube-rivo-audio volumio[3389]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 17 21:38:28 tube-rivo-audio volumio[3389]: info: CoreCommandRouter::volumioPushState Aug 17 21:38:28 tube-rivo-audio volumio[3389]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 17 21:38:29 tube-rivo-audio volumio[3389]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Aug 17 21:38:29 tube-rivo-audio volumio[3389]: info: Completed loading Core Plugins Aug 17 21:38:29 tube-rivo-audio volumio[3389]: info: Preparing to generate the ALSA configuration file Aug 17 21:38:29 tube-rivo-audio volumio[3389]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Aug 17 21:38:29 tube-rivo-audio volumio[3389]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Aug 17 21:38:29 tube-rivo-audio volumio[3389]: info: Reading ALSA contributions from plugins. Aug 17 21:38:29 tube-rivo-audio volumio[3389]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 17 21:38:29 tube-rivo-audio volumio[3389]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 17 21:38:29 tube-rivo-audio volumio[3389]: info: Discovery: Getting this device information Aug 17 21:38:29 tube-rivo-audio volumio[3389]: info: CoreCommandRouter::volumioGetState Aug 17 21:38:29 tube-rivo-audio volumio[3389]: info: CorePlayQueue::getTrack 0 Aug 17 21:38:29 tube-rivo-audio volumio[3389]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 17 21:38:29 tube-rivo-audio volumio[3389]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 17 21:38:29 tube-rivo-audio volumio[3389]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 17 21:38:29 tube-rivo-audio volumio[3389]: info: Discovery: Getting this device information Aug 17 21:38:29 tube-rivo-audio volumio[3389]: info: CoreCommandRouter::volumioGetState Aug 17 21:38:29 tube-rivo-audio volumio[3389]: info: CorePlayQueue::getTrack 0 Aug 17 21:38:29 tube-rivo-audio volumio[3389]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 17 21:38:29 tube-rivo-audio volumio[3389]: info: Reloading queue from file Aug 17 21:38:29 tube-rivo-audio volumio[3389]: info: CoreStateMachine::setRepeat false single undefined Aug 17 21:38:29 tube-rivo-audio volumio[3389]: info: CoreStateMachine::pushState Aug 17 21:38:29 tube-rivo-audio volumio[3389]: info: CorePlayQueue::getTrack 0 Aug 17 21:38:29 tube-rivo-audio volumio[3389]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 17 21:38:29 tube-rivo-audio volumio[3389]: info: CoreCommandRouter::volumioPushState Aug 17 21:38:29 tube-rivo-audio volumio[3389]: info: CoreStateMachine::setRandom false Aug 17 21:38:29 tube-rivo-audio volumio[3389]: info: CoreStateMachine::pushState Aug 17 21:38:29 tube-rivo-audio volumio[3389]: info: CorePlayQueue::getTrack 0 Aug 17 21:38:29 tube-rivo-audio volumio[3389]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 17 21:38:29 tube-rivo-audio volumio[3389]: info: CoreCommandRouter::volumioPushState Aug 17 21:38:29 tube-rivo-audio volumio[3389]: info: Asound.conf file unchanged, so no further update is needed Aug 17 21:38:29 tube-rivo-audio volumio[3389]: info: Output device has changed, restarting MPD Aug 17 21:38:29 tube-rivo-audio sudo[3524]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 17 21:38:29 tube-rivo-audio sudo[3524]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 21:38:29 tube-rivo-audio volumio[3389]: info: ___________ START PLUGINS ___________ Aug 17 21:38:29 tube-rivo-audio sudo[3524]: pam_unix(sudo:session): session closed for user root Aug 17 21:38:29 tube-rivo-audio volumio[3389]: info: ControllerMpd::onStart: Initializing MPD Aug 17 21:38:29 tube-rivo-audio volumio[3389]: info: Creating MPD Configuration file Aug 17 21:38:29 tube-rivo-audio sudo[3526]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 17 21:38:29 tube-rivo-audio sudo[3526]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 21:38:29 tube-rivo-audio sudo[3530]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 17 21:38:29 tube-rivo-audio sudo[3530]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 21:38:29 tube-rivo-audio volumio[3389]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 17 21:38:29 tube-rivo-audio systemd[1]: Listening on mpd.socket. Aug 17 21:38:29 tube-rivo-audio sudo[3530]: pam_unix(sudo:session): session closed for user root Aug 17 21:38:29 tube-rivo-audio systemd[1]: Starting Music Player Daemon... Aug 17 21:38:29 tube-rivo-audio sudo[3533]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 17 21:38:29 tube-rivo-audio sudo[3533]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 21:38:29 tube-rivo-audio volumio[3389]: info: Adding METAVOLUMIO REST API Endpoints Aug 17 21:38:29 tube-rivo-audio volumio[3389]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Aug 17 21:38:29 tube-rivo-audio volumio[3389]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio Aug 17 21:38:29 tube-rivo-audio volumio[3389]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio Aug 17 21:38:29 tube-rivo-audio volumio[3389]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio Aug 17 21:38:29 tube-rivo-audio volumio[3389]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 17 21:38:29 tube-rivo-audio volumio[3389]: info: [1723905509524] CoreMusicLibrary::Adding element Last_100 Aug 17 21:38:29 tube-rivo-audio volumio[3389]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 17 21:38:29 tube-rivo-audio volumio[3389]: info: Streaming services startup Aug 17 21:38:29 tube-rivo-audio volumio[3389]: info: Starting Streaming Daemon Aug 17 21:38:29 tube-rivo-audio sudo[3544]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/hciconfig hci0 name Tube Rivo Audio Aug 17 21:38:29 tube-rivo-audio sudo[3544]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 21:38:29 tube-rivo-audio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Aug 17 21:38:29 tube-rivo-audio systemd[1]: mpd.service: Succeeded. Aug 17 21:38:29 tube-rivo-audio sudo[3544]: pam_unix(sudo:session): session closed for user root Aug 17 21:38:29 tube-rivo-audio systemd[1]: Stopped Music Player Daemon. Aug 17 21:38:29 tube-rivo-audio systemd[1]: Starting Music Player Daemon... Aug 17 21:38:29 tube-rivo-audio sudo[3547]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Aug 17 21:38:29 tube-rivo-audio sudo[3547]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 21:38:29 tube-rivo-audio sudo[3547]: pam_unix(sudo:session): session closed for user root Aug 17 21:38:29 tube-rivo-audio volumio[3389]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 17 21:38:29 tube-rivo-audio volumio[3389]: info: [1723905509666] CoreMusicLibrary::Adding element Webradio Aug 17 21:38:29 tube-rivo-audio volumio[3389]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 17 21:38:29 tube-rivo-audio volumio[3389]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 17 21:38:29 tube-rivo-audio volumio[3389]: info: Initializing BBC Radios Aug 17 21:38:29 tube-rivo-audio sudo[3557]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Aug 17 21:38:29 tube-rivo-audio sudo[3557]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 21:38:29 tube-rivo-audio sudo[3548]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 17 21:38:29 tube-rivo-audio sudo[3548]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 21:38:29 tube-rivo-audio sudo[3557]: pam_unix(sudo:session): session closed for user root Aug 17 21:38:29 tube-rivo-audio sudo[3548]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Aug 17 21:38:29 tube-rivo-audio sudo[3548]: pam_unix(sudo:session): session closed for user root Aug 17 21:38:29 tube-rivo-audio volumio[3389]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 17 21:38:29 tube-rivo-audio volumio[3389]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 17 21:38:29 tube-rivo-audio volumio[3389]: error: Hi Res Audio Failed Login: Missing Login Data Aug 17 21:38:29 tube-rivo-audio volumio[3389]: info: Adding HIGHRESAUDIO REST API Endpoints Aug 17 21:38:29 tube-rivo-audio volumio[3389]: info: Adding getStreamUrlhi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Aug 17 21:38:29 tube-rivo-audio volumio[3389]: info: Initializing Serial Communication on port /dev/ttyS3 Aug 17 21:38:29 tube-rivo-audio volumio[3389]: info: Touch Event Listener Process Starting Aug 17 21:38:29 tube-rivo-audio kernel: meson_uart ffd22000.serial: ttyS3 use xtal(24M) 24000000 change 0 to 9600 Aug 17 21:38:29 tube-rivo-audio kernel: meson_uart ffd22000.serial: ttyS3 use xtal(24M) 24000000 change 9600 to 9600 Aug 17 21:38:29 tube-rivo-audio kernel: meson_uart ffd22000.serial: ttyS3 use xtal(24M) 24000000 change 9600 to 115200 Aug 17 21:38:29 tube-rivo-audio volumio[3389]: info: Refreshing TIDAL token Aug 17 21:38:29 tube-rivo-audio sudo[3573]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/xinput --test-xi2 --root Aug 17 21:38:29 tube-rivo-audio sudo[3573]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 21:38:29 tube-rivo-audio sudo[3573]: pam_unix(sudo:session): session closed for user root Aug 17 21:38:29 tube-rivo-audio sudo[3582]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x25 0x0 Aug 17 21:38:29 tube-rivo-audio sudo[3582]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 21:38:29 tube-rivo-audio sudo[3582]: pam_unix(sudo:session): session closed for user root Aug 17 21:38:29 tube-rivo-audio sudo[3585]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x28 0x0 Aug 17 21:38:29 tube-rivo-audio sudo[3585]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 21:38:29 tube-rivo-audio sudo[3585]: pam_unix(sudo:session): session closed for user root Aug 17 21:38:30 tube-rivo-audio sudo[3588]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x29 0x1 Aug 17 21:38:30 tube-rivo-audio sudo[3588]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 21:38:30 tube-rivo-audio sudo[3588]: pam_unix(sudo:session): session closed for user root Aug 17 21:38:30 tube-rivo-audio sudo[3591]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x33 0x1 Aug 17 21:38:30 tube-rivo-audio sudo[3591]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 21:38:30 tube-rivo-audio sudo[3591]: pam_unix(sudo:session): session closed for user root Aug 17 21:38:30 tube-rivo-audio volumio[3389]: info: Apply VIM3L Onboard LEDs Settings Aug 17 21:38:30 tube-rivo-audio volumio[3389]: info: Turning On Onboard LEDs Aug 17 21:38:30 tube-rivo-audio sudo[3595]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/tee /sys/class/leds/sys_led/trigger Aug 17 21:38:30 tube-rivo-audio sudo[3595]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 21:38:30 tube-rivo-audio volumio[3389]: info: Starting CEC Event listener Aug 17 21:38:30 tube-rivo-audio sudo[3595]: pam_unix(sudo:session): session closed for user root Aug 17 21:38:30 tube-rivo-audio volumio[3389]: info: Loading i18n strings for locale en Aug 17 21:38:30 tube-rivo-audio volumio[3389]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Aug 17 21:38:30 tube-rivo-audio volumio[3389]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 21:38:30 tube-rivo-audio volumio[3389]: info: FusionDsp - mixtype--------------------- None Aug 17 21:38:30 tube-rivo-audio volumio[3389]: info: Volumio Calling Home Aug 17 21:38:30 tube-rivo-audio sudo[3599]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/tee /sys/class/leds/red_red/trigger Aug 17 21:38:30 tube-rivo-audio sudo[3599]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 21:38:30 tube-rivo-audio sudo[3599]: pam_unix(sudo:session): session closed for user root Aug 17 21:38:30 tube-rivo-audio volumio[3389]: info: Preparing to generate the ALSA configuration file Aug 17 21:38:30 tube-rivo-audio volumio[3389]: info: Stopping AccessToken refresher cron for QOBUZ Aug 17 21:38:30 tube-rivo-audio volumio[3389]: info: AccessToken refresher cron started for QOBUZ Aug 17 21:38:30 tube-rivo-audio volumio[3389]: info: Adding QOBUZ REST API Endpoints Aug 17 21:38:30 tube-rivo-audio volumio[3389]: info: Adding getStreamUrlqobuz REST Endpoint for plugin: music_service/qobuz Aug 17 21:38:30 tube-rivo-audio volumio[3389]: info: Discovery: adding 1dc99a61-aea2-484f-a46a-3e4958b3c4a9 Aug 17 21:38:30 tube-rivo-audio volumio[3389]: info: Discovery: Found device Tube Rivo Audio Aug 17 21:38:30 tube-rivo-audio volumio[3389]: info: CoreCommandRouter::volumioGetState Aug 17 21:38:30 tube-rivo-audio volumio[3389]: info: CorePlayQueue::getTrack 0 Aug 17 21:38:30 tube-rivo-audio volumio[3389]: info: Discovery: this is already registered, 1dc99a61-aea2-484f-a46a-3e4958b3c4a9 Aug 17 21:38:30 tube-rivo-audio volumio[3389]: info: Discovery: Found device Tube Rivo Audio Aug 17 21:38:30 tube-rivo-audio volumio[3389]: info: CoreCommandRouter::volumioGetState Aug 17 21:38:30 tube-rivo-audio volumio[3389]: info: CorePlayQueue::getTrack 0 Aug 17 21:38:30 tube-rivo-audio volumio[3389]: info: Serial port opened successfully Aug 17 21:38:30 tube-rivo-audio volumio[3389]: info: Sending serial start messages Aug 17 21:38:30 tube-rivo-audio volumio[3389]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 21:38:30 tube-rivo-audio volumio[3389]: info: MP1 GPIO: Signalled system ready via GPIO Aug 17 21:38:30 tube-rivo-audio volumio[3389]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Aug 17 21:38:30 tube-rivo-audio volumio[3389]: info: Reading ALSA contributions from plugins. Aug 17 21:38:30 tube-rivo-audio volumio[3389]: info: Touch Event Listener Process Closed Aug 17 21:38:30 tube-rivo-audio volumio[3389]: error: Cannot start Volumio Streaming Daemon Aug 17 21:38:30 tube-rivo-audio volumio[3389]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Aug 17 21:38:30 tube-rivo-audio volumio[3389]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Aug 17 21:38:30 tube-rivo-audio volumio[3389]: info: Bluetooth name changed to Tube Rivo Audio Aug 17 21:38:30 tube-rivo-audio volumio[3389]: info: MPD Permissions set Aug 17 21:38:30 tube-rivo-audio volumio[3389]: info: MPD Permissions set Aug 17 21:38:30 tube-rivo-audio volumio[3389]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1 Aug 17 21:38:30 tube-rivo-audio volumio[3389]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 21:38:30 tube-rivo-audio volumio[3389]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 21:38:30 tube-rivo-audio volumio[3389]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 21:38:30 tube-rivo-audio volumio[3389]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 21:38:30 tube-rivo-audio volumio[3389]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 21:38:30 tube-rivo-audio volumio[3389]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 21:38:30 tube-rivo-audio volumio[3389]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 21:38:30 tube-rivo-audio volumio[3389]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 21:38:30 tube-rivo-audio volumio[3389]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 17 21:38:30 tube-rivo-audio volumio[3389]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Aug 17 21:38:30 tube-rivo-audio volumio[3389]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 21:38:30 tube-rivo-audio volumio[3389]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 21:38:30 tube-rivo-audio volumio[3389]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 21:38:30 tube-rivo-audio volumio[3389]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 21:38:30 tube-rivo-audio volumio[3389]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 21:38:30 tube-rivo-audio volumio[3389]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 21:38:30 tube-rivo-audio volumio[3389]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 21:38:30 tube-rivo-audio volumio[3389]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 21:38:30 tube-rivo-audio volumio[3389]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 21:38:30 tube-rivo-audio volumio[3389]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 17 21:38:30 tube-rivo-audio volumio[3389]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Aug 17 21:38:30 tube-rivo-audio volumio[3389]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 21:38:30 tube-rivo-audio volumio[3389]: 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 21:38:31 tube-rivo-audio volumio[3389]: info: Volumio called home Aug 17 21:38:31 tube-rivo-audio volumio[3389]: info: CoreCommandRouter::volumioGetState Aug 17 21:38:31 tube-rivo-audio volumio[3389]: info: CorePlayQueue::getTrack 0 Aug 17 21:38:31 tube-rivo-audio volumio[3389]: info: CoreCommandRouter::volumioGetState Aug 17 21:38:31 tube-rivo-audio volumio[3389]: info: CorePlayQueue::getTrack 0 Aug 17 21:38:31 tube-rivo-audio volumio[3389]: info: Asound.conf file unchanged, so no further update is needed Aug 17 21:38:31 tube-rivo-audio volumio[3389]: info: Output device has changed, restarting MPD Aug 17 21:38:31 tube-rivo-audio volumio[3389]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 21:38:31 tube-rivo-audio sudo[3622]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 17 21:38:31 tube-rivo-audio sudo[3622]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 21:38:31 tube-rivo-audio sudo[3622]: pam_unix(sudo:session): session closed for user root Aug 17 21:38:31 tube-rivo-audio sudo[3624]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 17 21:38:31 tube-rivo-audio sudo[3624]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 21:38:31 tube-rivo-audio volumio[3389]: info: MPD Permissions set Aug 17 21:38:31 tube-rivo-audio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Aug 17 21:38:31 tube-rivo-audio systemd[1]: mpd.service: Succeeded. Aug 17 21:38:31 tube-rivo-audio systemd[1]: Stopped Music Player Daemon. Aug 17 21:38:31 tube-rivo-audio volumio[3389]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 21:38:31 tube-rivo-audio volumio[3389]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 21:38:31 tube-rivo-audio volumio[3389]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 21:38:31 tube-rivo-audio volumio[3389]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 21:38:31 tube-rivo-audio volumio[3389]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 21:38:31 tube-rivo-audio volumio[3389]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 21:38:31 tube-rivo-audio volumio[3389]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 21:38:31 tube-rivo-audio volumio[3389]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 21:38:31 tube-rivo-audio systemd[1]: Starting Music Player Daemon... Aug 17 21:38:31 tube-rivo-audio volumio[3389]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 17 21:38:31 tube-rivo-audio volumio[3389]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Aug 17 21:38:31 tube-rivo-audio volumio-remote-updater[2841]: [2024-08-17 21:38:31] [connect] Successful connection Aug 17 21:38:31 tube-rivo-audio volumio[3389]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 21:38:31 tube-rivo-audio volumio-remote-updater[2841]: [2024-08-17 21:38:31] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1723905511 101 Aug 17 21:38:31 tube-rivo-audio volumio[3389]: 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: 3 Aug 17 21:38:31 tube-rivo-audio sudo[3627]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 17 21:38:31 tube-rivo-audio sudo[3627]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 21:38:31 tube-rivo-audio sudo[3627]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Aug 17 21:38:31 tube-rivo-audio sudo[3627]: pam_unix(sudo:session): session closed for user root Aug 17 21:38:31 tube-rivo-audio volumio[3389]: info: Access Token successfully retrieved Aug 17 21:38:32 tube-rivo-audio volumio[3389]: info: Successfully retrieved User Session From TIDAL Aug 17 21:38:32 tube-rivo-audio volumio[3389]: info: camilladsp spawned new process with pid undefined, instance 1, run: true Aug 17 21:38:32 tube-rivo-audio volumio[3389]: info: camilladsp service started and running in background, instance 1 Aug 17 21:38:32 tube-rivo-audio volumio[3389]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 17 21:38:32 tube-rivo-audio volumio[3389]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Aug 17 21:38:32 tube-rivo-audio volumio[3389]: 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 21:38:32 tube-rivo-audio volumio[3389]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Aug 17 21:38:32 tube-rivo-audio volumio[3389]: info: FusionDsp loaded Aug 17 21:38:32 tube-rivo-audio volumio[3389]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 17 21:38:32 tube-rivo-audio sudo[3647]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Aug 17 21:38:32 tube-rivo-audio sudo[3647]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 17 21:38:32 tube-rivo-audio volumio[3389]: info: FusionDsp - Reporting Fusion DSP Enabled Aug 17 21:38:32 tube-rivo-audio volumio[3389]: info: Adding Signal Path Element [object Object] Aug 17 21:38:32 tube-rivo-audio volumio[3389]: info: Adding fusiondspeq DSP Signal Path Element Aug 17 21:38:32 tube-rivo-audio volumio[3389]: info: FusionDsp - ---- installed callbackRead Aug 17 21:38:32 tube-rivo-audio volumio[3389]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 17 21:38:32 tube-rivo-audio sudo[3647]: pam_unix(sudo:session): session closed for user root Aug 17 21:38:32 tube-rivo-audio volumio[3389]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Aug 17 21:38:32 tube-rivo-audio volumio[3389]: at Process.ChildProcess._handle.onexit (internal/child_process.js:277:19) Aug 17 21:38:32 tube-rivo-audio volumio[3389]: at onErrorNT (internal/child_process.js:472:16) Aug 17 21:38:32 tube-rivo-audio volumio[3389]: at processTicksAndRejections (internal/process/task_queues.js:82:21) { Aug 17 21:38:32 tube-rivo-audio volumio[3389]: errno: -2, Aug 17 21:38:32 tube-rivo-audio volumio[3389]: code: 'ENOENT', Aug 17 21:38:32 tube-rivo-audio volumio[3389]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Aug 17 21:38:32 tube-rivo-audio volumio[3389]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Aug 17 21:38:32 tube-rivo-audio volumio[3389]: spawnargs: [ Aug 17 21:38:32 tube-rivo-audio volumio[3389]: '-p', Aug 17 21:38:32 tube-rivo-audio volumio[3389]: 9876, Aug 17 21:38:32 tube-rivo-audio volumio[3389]: '-o', Aug 17 21:38:32 tube-rivo-audio volumio[3389]: '/tmp/camilladsp.log', Aug 17 21:38:32 tube-rivo-audio volumio[3389]: '-l', Aug 17 21:38:32 tube-rivo-audio volumio[3389]: 'warn', Aug 17 21:38:32 tube-rivo-audio volumio[3389]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Aug 17 21:38:32 tube-rivo-audio volumio[3389]: ] Aug 17 21:38:32 tube-rivo-audio volumio[3389]: } Aug 17 21:38:32 tube-rivo-audio volumio[3389]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 17 21:38:33 tube-rivo-audio sudo[3658]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-08-17 21:37 Aug 17 21:38:33 tube-rivo-audio sudo[3658]: 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"