-- Logs begin at Sat 2024-08-17 22:11:53 WIB, end at Sun 2024-08-18 01:23:43 WIB. -- Aug 18 01:23:31 tube-rivo-audio ntpd[3320]: receive: Unexpected origin timestamp 0xea6b3c5e.4697ca60 does not match aorg 0000000000.00000000 from server@103.169.192.229 xmt 0xea6b6923.8fd7cacc Aug 18 01:23:31 tube-rivo-audio ntpd[3320]: receive: Unexpected origin timestamp 0xea6b3c5e.468ce15e does not match aorg 0000000000.00000000 from server@203.89.31.13 xmt 0xea6b6923.91f3eafd Aug 18 01:23:31 tube-rivo-audio ntpd[3320]: receive: Unexpected origin timestamp 0xea6b3c5e.4692dabe does not match aorg 0000000000.00000000 from server@103.134.77.146 xmt 0xea6b6923.946a4cff Aug 18 01:23:31 tube-rivo-audio ntpd[3320]: receive: Unexpected origin timestamp 0xea6b3c5e.469065fd does not match aorg 0000000000.00000000 from server@103.177.8.14 xmt 0xea6b6923.96290af4 Aug 18 01:23:31 tube-rivo-audio volumio[3250]: Starting albumart workers Aug 18 01:23:31 tube-rivo-audio volumio[3250]: Starting albumart workers Aug 18 01:23:31 tube-rivo-audio volumio[3250]: Starting albumart workers Aug 18 01:23:32 tube-rivo-audio volumio[3250]: info: Applying required configuration parameters for plugin hi_res_audio Aug 18 01:23:32 tube-rivo-audio volumio[3250]: info: Loading plugin "inputs"... Aug 18 01:23:33 tube-rivo-audio volumio[3250]: info: Loading plugin "qobuz"... Aug 18 01:23:34 tube-rivo-audio volumio[3250]: info: Plugin smart_inputs is not enabled Aug 18 01:23:34 tube-rivo-audio volumio[3250]: info: Loading plugin "tidal"... Aug 18 01:23:36 tube-rivo-audio nmbd[3043]: [2024/08/18 01:23:36.069753, 0] ../source3/libsmb/nmblib.c:917(send_udp) Aug 18 01:23:36 tube-rivo-audio nmbd[3043]: Packet send failed to 169.254.255.255(138) ERRNO=Network is unreachable Aug 18 01:23:36 tube-rivo-audio nmbd[3043]: [2024/08/18 01:23:36.070214, 0] ../source3/libsmb/nmblib.c:917(send_udp) Aug 18 01:23:36 tube-rivo-audio nmbd[3043]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable Aug 18 01:23:36 tube-rivo-audio nmbd[3043]: [2024/08/18 01:23:36.070383, 0] ../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Aug 18 01:23:36 tube-rivo-audio nmbd[3043]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed Aug 18 01:23:36 tube-rivo-audio nmbd[3043]: [2024/08/18 01:23:36.070532, 0] ../source3/libsmb/nmblib.c:917(send_udp) Aug 18 01:23:36 tube-rivo-audio nmbd[3043]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable Aug 18 01:23:36 tube-rivo-audio nmbd[3043]: [2024/08/18 01:23:36.070663, 0] ../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Aug 18 01:23:36 tube-rivo-audio nmbd[3043]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed Aug 18 01:23:36 tube-rivo-audio nmbd[3043]: [2024/08/18 01:23:36.070801, 0] ../source3/libsmb/nmblib.c:917(send_udp) Aug 18 01:23:36 tube-rivo-audio nmbd[3043]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable Aug 18 01:23:36 tube-rivo-audio nmbd[3043]: [2024/08/18 01:23:36.070930, 0] ../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Aug 18 01:23:36 tube-rivo-audio nmbd[3043]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed Aug 18 01:23:36 tube-rivo-audio nmbd[3043]: [2024/08/18 01:23:36.071071, 0] ../source3/libsmb/nmblib.c:917(send_udp) Aug 18 01:23:36 tube-rivo-audio nmbd[3043]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable Aug 18 01:23:36 tube-rivo-audio nmbd[3043]: [2024/08/18 01:23:36.071201, 0] ../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Aug 18 01:23:36 tube-rivo-audio nmbd[3043]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed Aug 18 01:23:36 tube-rivo-audio nmbd[3043]: [2024/08/18 01:23:36.071353, 0] ../source3/libsmb/nmblib.c:917(send_udp) Aug 18 01:23:36 tube-rivo-audio nmbd[3043]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable Aug 18 01:23:36 tube-rivo-audio nmbd[3043]: [2024/08/18 01:23:36.071566, 0] ../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Aug 18 01:23:36 tube-rivo-audio nmbd[3043]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed Aug 18 01:23:36 tube-rivo-audio volumio[3250]: info: Loading plugin "rivocontrol"... Aug 18 01:23:37 tube-rivo-audio volumio[3250]: info: Adding this device properties Aug 18 01:23:37 tube-rivo-audio volumio[3250]: info: CoreCommandRouter::executeOnPlugin: system , setThisDeviceVolumioProperties Aug 18 01:23:37 tube-rivo-audio volumio[3250]: info: Setting Additional Device Volumio Properties: [object Object] Aug 18 01:23:37 tube-rivo-audio volumio[3250]: info: Loading plugin "updater_comm"... Aug 18 01:23:37 tube-rivo-audio volumio[3250]: info: Loading plugin "cec_controller"... Aug 18 01:23:37 tube-rivo-audio volumio-remote-updater[2830]: [2024-08-18 01:23:37] [connect] Successful connection Aug 18 01:23:37 tube-rivo-audio volumio[3250]: info: Applying required configuration parameters for plugin cec_controller Aug 18 01:23:37 tube-rivo-audio volumio[3250]: info: Plugin mpdemulation is not enabled Aug 18 01:23:37 tube-rivo-audio volumio[3250]: info: Loading plugin "rest_api"... Aug 18 01:23:37 tube-rivo-audio volumio[3250]: info: Loading plugin "websocket"... Aug 18 01:23:37 tube-rivo-audio volumio[3250]: info: Starting Socket.io Server version 2.3.0 Aug 18 01:23:37 tube-rivo-audio volumio[3250]: info: Loading plugin "fusiondsp"... Aug 18 01:23:38 tube-rivo-audio volumio[3250]: info: Applying required configuration parameters for plugin fusiondsp Aug 18 01:23:38 tube-rivo-audio volumio[3250]: info: Loading i18n strings for locale en Aug 18 01:23:38 tube-rivo-audio volumio[3250]: Updating browse sources language Aug 18 01:23:38 tube-rivo-audio volumio[3250]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 18 01:23:38 tube-rivo-audio volumio[3250]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 18 01:23:38 tube-rivo-audio volumio[3250]: info: CoreCommandRouter::initPlayerControls Aug 18 01:23:38 tube-rivo-audio volumio[3250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 01:23:38 tube-rivo-audio volumio[3250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 01:23:38 tube-rivo-audio volumio[3250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 01:23:38 tube-rivo-audio volumio[3250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 01:23:38 tube-rivo-audio volumio[3250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 01:23:38 tube-rivo-audio volumio[3250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 01:23:38 tube-rivo-audio volumio[3250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 01:23:38 tube-rivo-audio volumio[3250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 01:23:38 tube-rivo-audio volumio[3250]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 18 01:23:38 tube-rivo-audio volumio[3250]: Express server listening on port 3000 Aug 18 01:23:38 tube-rivo-audio volumio[3250]: [Metrics] WebUI: 18s 906.84ms Aug 18 01:23:38 tube-rivo-audio volumio[3250]: info: CoreStateMachine::resetVolumioState Aug 18 01:23:38 tube-rivo-audio volumio[3250]: info: CoreStateMachine::getcurrentVolume Aug 18 01:23:38 tube-rivo-audio volumio[3250]: info: CoreCommandRouter::volumioRetrievevolume Aug 18 01:23:38 tube-rivo-audio volumio[3250]: info: CoreStateMachine::pushState Aug 18 01:23:38 tube-rivo-audio volumio[3250]: info: CorePlayQueue::getTrack 0 Aug 18 01:23:38 tube-rivo-audio volumio[3250]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 18 01:23:38 tube-rivo-audio volumio[3250]: info: CoreCommandRouter::volumioPushState Aug 18 01:23:38 tube-rivo-audio volumio[3250]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 18 01:23:38 tube-rivo-audio volumio[3250]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Aug 18 01:23:38 tube-rivo-audio volumio[3250]: info: Completed loading Core Plugins Aug 18 01:23:38 tube-rivo-audio volumio[3250]: info: Preparing to generate the ALSA configuration file Aug 18 01:23:39 tube-rivo-audio volumio[3250]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Aug 18 01:23:39 tube-rivo-audio volumio[3250]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Aug 18 01:23:39 tube-rivo-audio volumio[3250]: info: Reading ALSA contributions from plugins. Aug 18 01:23:39 tube-rivo-audio volumio-remote-updater[2830]: [2024-08-18 01:23:39] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1723919017 101 Aug 18 01:23:39 tube-rivo-audio volumio[3250]: 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 18 01:23:39 tube-rivo-audio volumio[3250]: info: Reloading queue from file Aug 18 01:23:39 tube-rivo-audio volumio[3250]: info: CoreStateMachine::setRepeat false single undefined Aug 18 01:23:39 tube-rivo-audio volumio[3250]: info: CoreStateMachine::pushState Aug 18 01:23:39 tube-rivo-audio volumio[3250]: info: CorePlayQueue::getTrack 0 Aug 18 01:23:39 tube-rivo-audio volumio[3250]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 18 01:23:39 tube-rivo-audio volumio[3250]: info: CoreCommandRouter::volumioPushState Aug 18 01:23:39 tube-rivo-audio volumio[3250]: info: CoreStateMachine::setRandom false Aug 18 01:23:39 tube-rivo-audio volumio[3250]: info: CoreStateMachine::pushState Aug 18 01:23:39 tube-rivo-audio volumio[3250]: info: CorePlayQueue::getTrack 0 Aug 18 01:23:39 tube-rivo-audio volumio[3250]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 18 01:23:39 tube-rivo-audio volumio[3250]: info: CoreCommandRouter::volumioPushState Aug 18 01:23:39 tube-rivo-audio volumio[3250]: info: Discovery: A device disappeared from network Aug 18 01:23:39 tube-rivo-audio volumio[3250]: info: Discovery: Browse raised the following error TypeError: Cannot read property 'toLowerCase' of undefined Aug 18 01:23:39 tube-rivo-audio systemd[1]: Starting Daily man-db regeneration... Aug 18 01:23:39 tube-rivo-audio volumio[3250]: info: Asound.conf file unchanged, so no further update is needed Aug 18 01:23:39 tube-rivo-audio volumio[3250]: info: Output device has changed, restarting MPD Aug 18 01:23:39 tube-rivo-audio systemd[1]: systemd-hostnamed.service: Succeeded. Aug 18 01:23:39 tube-rivo-audio sudo[3474]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 18 01:23:39 tube-rivo-audio sudo[3474]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 01:23:39 tube-rivo-audio volumio[3250]: info: ___________ START PLUGINS ___________ Aug 18 01:23:39 tube-rivo-audio sudo[3474]: pam_unix(sudo:session): session closed for user root Aug 18 01:23:39 tube-rivo-audio volumio[3250]: info: ControllerMpd::onStart: Initializing MPD Aug 18 01:23:39 tube-rivo-audio volumio[3250]: info: Creating MPD Configuration file Aug 18 01:23:39 tube-rivo-audio sudo[3477]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 18 01:23:39 tube-rivo-audio sudo[3477]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 01:23:39 tube-rivo-audio volumio[3250]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 18 01:23:39 tube-rivo-audio sudo[3481]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 18 01:23:39 tube-rivo-audio sudo[3481]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 01:23:39 tube-rivo-audio sudo[3481]: pam_unix(sudo:session): session closed for user root Aug 18 01:23:39 tube-rivo-audio systemd[1]: Listening on mpd.socket. Aug 18 01:23:39 tube-rivo-audio sudo[3483]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 18 01:23:39 tube-rivo-audio sudo[3483]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 01:23:39 tube-rivo-audio systemd[1]: Starting Music Player Daemon... Aug 18 01:23:39 tube-rivo-audio systemd[1]: man-db.service: Succeeded. Aug 18 01:23:39 tube-rivo-audio systemd[1]: Started Daily man-db regeneration. Aug 18 01:23:39 tube-rivo-audio volumio[3250]: info: Adding METAVOLUMIO REST API Endpoints Aug 18 01:23:39 tube-rivo-audio volumio[3250]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Aug 18 01:23:39 tube-rivo-audio volumio[3250]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio Aug 18 01:23:39 tube-rivo-audio volumio[3250]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio Aug 18 01:23:39 tube-rivo-audio volumio[3250]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio Aug 18 01:23:39 tube-rivo-audio volumio[3250]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 18 01:23:39 tube-rivo-audio volumio[3250]: info: [1723919019468] CoreMusicLibrary::Adding element Last_100 Aug 18 01:23:39 tube-rivo-audio volumio[3250]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 18 01:23:39 tube-rivo-audio volumio[3250]: info: Streaming services startup Aug 18 01:23:39 tube-rivo-audio volumio[3250]: info: Starting Streaming Daemon Aug 18 01:23:39 tube-rivo-audio sudo[3489]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/hciconfig hci0 name Tube Rivo Audio Aug 18 01:23:39 tube-rivo-audio sudo[3489]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 01:23:39 tube-rivo-audio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Aug 18 01:23:39 tube-rivo-audio systemd[1]: mpd.service: Succeeded. Aug 18 01:23:39 tube-rivo-audio systemd[1]: Stopped Music Player Daemon. Aug 18 01:23:39 tube-rivo-audio sudo[3489]: pam_unix(sudo:session): session closed for user root Aug 18 01:23:39 tube-rivo-audio systemd[1]: Starting Music Player Daemon... Aug 18 01:23:39 tube-rivo-audio sudo[3492]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Aug 18 01:23:39 tube-rivo-audio sudo[3492]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 01:23:39 tube-rivo-audio sudo[3492]: pam_unix(sudo:session): session closed for user root Aug 18 01:23:39 tube-rivo-audio volumio[3250]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 18 01:23:39 tube-rivo-audio volumio[3250]: info: [1723919019596] CoreMusicLibrary::Adding element Webradio Aug 18 01:23:39 tube-rivo-audio volumio[3250]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 18 01:23:39 tube-rivo-audio volumio[3250]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 18 01:23:39 tube-rivo-audio volumio[3250]: info: Initializing BBC Radios Aug 18 01:23:39 tube-rivo-audio sudo[3501]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Aug 18 01:23:39 tube-rivo-audio sudo[3501]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 01:23:39 tube-rivo-audio sudo[3501]: pam_unix(sudo:session): session closed for user root Aug 18 01:23:39 tube-rivo-audio sudo[3493]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 18 01:23:39 tube-rivo-audio sudo[3493]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 01:23:39 tube-rivo-audio sudo[3493]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Aug 18 01:23:39 tube-rivo-audio volumio[3250]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 18 01:23:39 tube-rivo-audio sudo[3493]: pam_unix(sudo:session): session closed for user root Aug 18 01:23:39 tube-rivo-audio volumio[3250]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 18 01:23:39 tube-rivo-audio volumio[3250]: error: Hi Res Audio Failed Login: Missing Login Data Aug 18 01:23:39 tube-rivo-audio volumio[3250]: info: Adding HIGHRESAUDIO REST API Endpoints Aug 18 01:23:39 tube-rivo-audio volumio[3250]: info: Adding getStreamUrlhi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Aug 18 01:23:39 tube-rivo-audio volumio[3250]: info: Initializing Serial Communication on port /dev/ttyS3 Aug 18 01:23:39 tube-rivo-audio volumio[3250]: info: Touch Event Listener Process Starting Aug 18 01:23:39 tube-rivo-audio kernel: meson_uart ffd22000.serial: ttyS3 use xtal(24M) 24000000 change 0 to 9600 Aug 18 01:23:39 tube-rivo-audio kernel: meson_uart ffd22000.serial: ttyS3 use xtal(24M) 24000000 change 9600 to 9600 Aug 18 01:23:39 tube-rivo-audio kernel: meson_uart ffd22000.serial: ttyS3 use xtal(24M) 24000000 change 9600 to 115200 Aug 18 01:23:39 tube-rivo-audio volumio[3250]: info: Refreshing TIDAL token Aug 18 01:23:39 tube-rivo-audio sudo[3517]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/xinput --test-xi2 --root Aug 18 01:23:39 tube-rivo-audio sudo[3517]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 01:23:39 tube-rivo-audio sudo[3517]: pam_unix(sudo:session): session closed for user root Aug 18 01:23:39 tube-rivo-audio sudo[3526]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x25 0x0 Aug 18 01:23:39 tube-rivo-audio sudo[3526]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 01:23:39 tube-rivo-audio sudo[3526]: pam_unix(sudo:session): session closed for user root Aug 18 01:23:39 tube-rivo-audio sudo[3529]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x28 0x0 Aug 18 01:23:39 tube-rivo-audio sudo[3529]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 01:23:39 tube-rivo-audio sudo[3529]: pam_unix(sudo:session): session closed for user root Aug 18 01:23:39 tube-rivo-audio sudo[3532]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x29 0x1 Aug 18 01:23:39 tube-rivo-audio sudo[3532]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 01:23:39 tube-rivo-audio sudo[3532]: pam_unix(sudo:session): session closed for user root Aug 18 01:23:40 tube-rivo-audio sudo[3535]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x33 0x1 Aug 18 01:23:40 tube-rivo-audio sudo[3535]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 01:23:40 tube-rivo-audio sudo[3535]: pam_unix(sudo:session): session closed for user root Aug 18 01:23:40 tube-rivo-audio volumio[3250]: info: Apply VIM3L Onboard LEDs Settings Aug 18 01:23:40 tube-rivo-audio volumio[3250]: info: Turning On Onboard LEDs Aug 18 01:23:40 tube-rivo-audio sudo[3539]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/tee /sys/class/leds/sys_led/trigger Aug 18 01:23:40 tube-rivo-audio sudo[3539]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 01:23:40 tube-rivo-audio volumio[3250]: info: Starting CEC Event listener Aug 18 01:23:40 tube-rivo-audio sudo[3539]: pam_unix(sudo:session): session closed for user root Aug 18 01:23:40 tube-rivo-audio volumio[3250]: info: Loading i18n strings for locale en Aug 18 01:23:40 tube-rivo-audio volumio[3250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Aug 18 01:23:40 tube-rivo-audio volumio[3250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 01:23:40 tube-rivo-audio sudo[3543]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/tee /sys/class/leds/red_red/trigger Aug 18 01:23:40 tube-rivo-audio volumio[3250]: info: FusionDsp - mixtype--------------------- None Aug 18 01:23:40 tube-rivo-audio sudo[3543]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 01:23:40 tube-rivo-audio volumio[3250]: info: Volumio Calling Home Aug 18 01:23:40 tube-rivo-audio sudo[3543]: pam_unix(sudo:session): session closed for user root Aug 18 01:23:40 tube-rivo-audio volumio[3250]: info: Preparing to generate the ALSA configuration file Aug 18 01:23:40 tube-rivo-audio volumio[3250]: info: Stopping AccessToken refresher cron for QOBUZ Aug 18 01:23:40 tube-rivo-audio volumio[3250]: info: AccessToken refresher cron started for QOBUZ Aug 18 01:23:40 tube-rivo-audio volumio[3250]: info: Adding QOBUZ REST API Endpoints Aug 18 01:23:40 tube-rivo-audio volumio[3250]: info: Adding getStreamUrlqobuz REST Endpoint for plugin: music_service/qobuz Aug 18 01:23:40 tube-rivo-audio volumio[3250]: info: Serial port opened successfully Aug 18 01:23:40 tube-rivo-audio volumio[3250]: info: Sending serial start messages Aug 18 01:23:40 tube-rivo-audio volumio[3250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 01:23:40 tube-rivo-audio volumio[3250]: info: MP1 GPIO: Signalled system ready via GPIO Aug 18 01:23:40 tube-rivo-audio volumio[3250]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Aug 18 01:23:40 tube-rivo-audio volumio[3250]: info: Reading ALSA contributions from plugins. Aug 18 01:23:40 tube-rivo-audio volumio[3250]: info: Touch Event Listener Process Closed Aug 18 01:23:40 tube-rivo-audio volumio[3250]: error: Cannot start Volumio Streaming Daemon Aug 18 01:23:40 tube-rivo-audio volumio[3250]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Aug 18 01:23:40 tube-rivo-audio volumio[3250]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Aug 18 01:23:40 tube-rivo-audio volumio[3250]: info: Bluetooth name changed to Tube Rivo Audio Aug 18 01:23:40 tube-rivo-audio volumio[3250]: info: MPD Permissions set Aug 18 01:23:40 tube-rivo-audio volumio[3250]: info: MPD Permissions set Aug 18 01:23:40 tube-rivo-audio volumio[3250]: 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 18 01:23:40 tube-rivo-audio volumio[3250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 01:23:40 tube-rivo-audio volumio[3250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 01:23:40 tube-rivo-audio volumio[3250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 01:23:40 tube-rivo-audio volumio[3250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 01:23:40 tube-rivo-audio volumio[3250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 01:23:40 tube-rivo-audio volumio[3250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 01:23:40 tube-rivo-audio volumio[3250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 01:23:40 tube-rivo-audio volumio[3250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 01:23:40 tube-rivo-audio volumio[3250]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 18 01:23:40 tube-rivo-audio volumio[3250]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Aug 18 01:23:40 tube-rivo-audio volumio[3250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 01:23:40 tube-rivo-audio volumio[3250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 01:23:40 tube-rivo-audio volumio[3250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 01:23:40 tube-rivo-audio volumio[3250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 01:23:40 tube-rivo-audio volumio[3250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 01:23:40 tube-rivo-audio volumio[3250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 01:23:40 tube-rivo-audio volumio[3250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 01:23:40 tube-rivo-audio volumio[3250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 01:23:40 tube-rivo-audio volumio[3250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 01:23:40 tube-rivo-audio volumio[3250]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 18 01:23:40 tube-rivo-audio volumio[3250]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Aug 18 01:23:40 tube-rivo-audio volumio[3250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 01:23:40 tube-rivo-audio volumio[3250]: info: Asound.conf file unchanged, so no further update is needed Aug 18 01:23:40 tube-rivo-audio volumio[3250]: info: Output device has changed, restarting MPD Aug 18 01:23:40 tube-rivo-audio volumio[3250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 01:23:40 tube-rivo-audio sudo[3565]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 18 01:23:40 tube-rivo-audio sudo[3565]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 01:23:40 tube-rivo-audio volumio[3250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 01:23:40 tube-rivo-audio volumio[3250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 01:23:40 tube-rivo-audio volumio[3250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 01:23:40 tube-rivo-audio volumio[3250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 01:23:40 tube-rivo-audio volumio[3250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 01:23:40 tube-rivo-audio volumio[3250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 01:23:40 tube-rivo-audio volumio[3250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 01:23:40 tube-rivo-audio volumio[3250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 01:23:40 tube-rivo-audio sudo[3565]: pam_unix(sudo:session): session closed for user root Aug 18 01:23:40 tube-rivo-audio sudo[3567]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 18 01:23:40 tube-rivo-audio sudo[3567]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 01:23:40 tube-rivo-audio volumio[3250]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 18 01:23:40 tube-rivo-audio volumio[3250]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Aug 18 01:23:40 tube-rivo-audio volumio[3250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 01:23:40 tube-rivo-audio volumio[3250]: info: MPD Permissions set Aug 18 01:23:40 tube-rivo-audio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Aug 18 01:23:40 tube-rivo-audio systemd[1]: mpd.service: Succeeded. Aug 18 01:23:40 tube-rivo-audio systemd[1]: Stopped Music Player Daemon. Aug 18 01:23:40 tube-rivo-audio systemd[1]: Starting Music Player Daemon... Aug 18 01:23:41 tube-rivo-audio sudo[3577]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 18 01:23:41 tube-rivo-audio sudo[3577]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 01:23:41 tube-rivo-audio sudo[3577]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Aug 18 01:23:41 tube-rivo-audio sudo[3577]: pam_unix(sudo:session): session closed for user root Aug 18 01:23:42 tube-rivo-audio volumio[3250]: info: camilladsp spawned new process with pid undefined, instance 1, run: true Aug 18 01:23:42 tube-rivo-audio volumio[3250]: info: camilladsp service started and running in background, instance 1 Aug 18 01:23:42 tube-rivo-audio volumio[3250]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 18 01:23:42 tube-rivo-audio volumio[3250]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Aug 18 01:23:42 tube-rivo-audio volumio[3250]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Aug 18 01:23:42 tube-rivo-audio volumio[3250]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Aug 18 01:23:42 tube-rivo-audio volumio[3250]: info: FusionDsp loaded Aug 18 01:23:42 tube-rivo-audio volumio[3250]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 18 01:23:42 tube-rivo-audio sudo[3590]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Aug 18 01:23:42 tube-rivo-audio sudo[3590]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 18 01:23:42 tube-rivo-audio volumio[3250]: info: FusionDsp - Reporting Fusion DSP Enabled Aug 18 01:23:42 tube-rivo-audio volumio[3250]: info: Adding Signal Path Element [object Object] Aug 18 01:23:42 tube-rivo-audio volumio[3250]: info: Adding fusiondspeq DSP Signal Path Element Aug 18 01:23:42 tube-rivo-audio volumio[3250]: info: FusionDsp - ---- installed callbackRead Aug 18 01:23:42 tube-rivo-audio volumio[3250]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 18 01:23:42 tube-rivo-audio sudo[3590]: pam_unix(sudo:session): session closed for user root Aug 18 01:23:42 tube-rivo-audio volumio[3250]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Aug 18 01:23:42 tube-rivo-audio volumio[3250]: at Process.ChildProcess._handle.onexit (internal/child_process.js:277:19) Aug 18 01:23:42 tube-rivo-audio volumio[3250]: at onErrorNT (internal/child_process.js:472:16) Aug 18 01:23:42 tube-rivo-audio volumio[3250]: at processTicksAndRejections (internal/process/task_queues.js:82:21) { Aug 18 01:23:42 tube-rivo-audio volumio[3250]: errno: -2, Aug 18 01:23:42 tube-rivo-audio volumio[3250]: code: 'ENOENT', Aug 18 01:23:42 tube-rivo-audio volumio[3250]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Aug 18 01:23:42 tube-rivo-audio volumio[3250]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Aug 18 01:23:42 tube-rivo-audio volumio[3250]: spawnargs: [ Aug 18 01:23:42 tube-rivo-audio volumio[3250]: '-p', Aug 18 01:23:42 tube-rivo-audio volumio[3250]: 9876, Aug 18 01:23:42 tube-rivo-audio volumio[3250]: '-o', Aug 18 01:23:42 tube-rivo-audio volumio[3250]: '/tmp/camilladsp.log', Aug 18 01:23:42 tube-rivo-audio volumio[3250]: '-l', Aug 18 01:23:42 tube-rivo-audio volumio[3250]: 'warn', Aug 18 01:23:42 tube-rivo-audio volumio[3250]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Aug 18 01:23:42 tube-rivo-audio volumio[3250]: ] Aug 18 01:23:42 tube-rivo-audio volumio[3250]: } Aug 18 01:23:42 tube-rivo-audio volumio[3250]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 18 01:23:43 tube-rivo-audio sudo[3601]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-08-18 01:22 Aug 18 01:23:43 tube-rivo-audio sudo[3601]: 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"