-- Logs begin at Sun 2024-09-29 14:32:58 CEST, end at Wed 2024-10-16 13:42:28 CEST. -- Oct 16 13:42:08 rivo ntpd[3400]: receive: Unexpected origin timestamp 0xeaa3c798.35f0873e does not match aorg 0000000000.00000000 from server@162.159.200.1 xmt 0xeaba2510.483c99ac Oct 16 13:42:08 rivo ntpd[3400]: receive: Unexpected origin timestamp 0xeaa3c798.35ee6158 does not match aorg 0000000000.00000000 from server@85.199.214.99 xmt 0xeaba2510.49d40cd5 Oct 16 13:42:08 rivo systemd[1]: Starting Daily man-db regeneration... Oct 16 13:42:08 rivo ntpd[3400]: receive: Unexpected origin timestamp 0xeaa3c798.35f2bf22 does not match aorg 0000000000.00000000 from server@217.61.62.224 xmt 0xeaba2510.4cc01b3e Oct 16 13:42:08 rivo systemd[1]: Starting Daily apt download activities... Oct 16 13:42:08 rivo volumio[3412]: info: Loading plugin "metavolumio"... Oct 16 13:42:08 rivo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04f9f7000 drv_status 0x0 e_type 69 e_states 8 Oct 16 13:42:08 rivo systemd[1]: man-db.service: Succeeded. Oct 16 13:42:08 rivo systemd[1]: Started Daily man-db regeneration. Oct 16 13:42:08 rivo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04f9f7000 drv_status 0x0 e_type 69 e_states 0 Oct 16 13:42:08 rivo sudo[3453]: pam_unix(sudo:session): session closed for user root Oct 16 13:42:09 rivo systemd[1]: apt-daily.service: Succeeded. Oct 16 13:42:09 rivo systemd[1]: Started Daily apt download activities. Oct 16 13:42:09 rivo systemd[1]: Starting Daily apt upgrade and clean activities... Oct 16 13:42:10 rivo volumio[3412]: info: Loading plugin "airplay_emulation"... Oct 16 13:42:10 rivo volumio[3412]: info: Starting Shairport Sync Oct 16 13:42:10 rivo volumio[3412]: info: Loading plugin "cd_controller"... Oct 16 13:42:10 rivo systemd[1]: apt-daily-upgrade.service: Succeeded. Oct 16 13:42:10 rivo systemd[1]: Started Daily apt upgrade and clean activities. Oct 16 13:42:10 rivo volumio[3412]: info: Loading plugin "last_100"... Oct 16 13:42:10 rivo volumio[3412]: info: Loading plugin "raat"... Oct 16 13:42:10 rivo volumio[3412]: info: RAAT Plugin loaded Oct 16 13:42:10 rivo volumio[3412]: info: Adding restartRAATSocket REST API Endpoint Oct 16 13:42:10 rivo volumio[3412]: info: Adding restartRAATSocket REST Endpoint for plugin: music_service/raat Oct 16 13:42:10 rivo volumio[3412]: info: Loading plugin "streaming_services"... Oct 16 13:42:11 rivo systemd[1]: systemd-fsckd.service: Succeeded. Oct 16 13:42:12 rivo volumio[3412]: info: Starting Streaming Service Transparent Proxy Oct 16 13:42:12 rivo volumio[3412]: info: Loading plugin "tidalconnect"... Oct 16 13:42:12 rivo volumio[3412]: info: Loading plugin "webradio"... Oct 16 13:42:12 rivo volumio[3412]: info: Loading plugin "i2s_dacs"... Oct 16 13:42:12 rivo volumio[3412]: info: I2S DAC not set, start Auto-detection Oct 16 13:42:12 rivo volumio[3412]: info: Loading plugin "volumiodiscovery"... Oct 16 13:42:12 rivo volumio[3412]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 16 13:42:12 rivo volumio[3412]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 16 13:42:12 rivo node[3412]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 16 13:42:12 rivo volumio[3412]: *** WARNING *** For more information see Oct 16 13:42:12 rivo volumio[3412]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 16 13:42:12 rivo volumio[3412]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 16 13:42:12 rivo volumio[3412]: *** WARNING *** For more information see Oct 16 13:42:12 rivo node[3412]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 16 13:42:12 rivo node[3412]: *** WARNING *** For more information see Oct 16 13:42:12 rivo node[3412]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 16 13:42:12 rivo node[3412]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 16 13:42:12 rivo node[3412]: *** WARNING *** For more information see Oct 16 13:42:12 rivo volumio[3412]: info: Applying required configuration parameters for plugin volumiodiscovery Oct 16 13:42:12 rivo volumio[3412]: info: Discovery: Started advertising with name: Rivo Oct 16 13:42:12 rivo volumio[3412]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 16 13:42:12 rivo volumio[3412]: info: Loading plugin "spop"... Oct 16 13:42:13 rivo volumio[3412]: STREAMING PROXY: Starting server on port 3245 Oct 16 13:42:13 rivo volumio[3412]: Node JS runtime: 14 Oct 16 13:42:14 rivo volumio[3412]: info: Plugin multiroom is not enabled Oct 16 13:42:14 rivo volumio[3412]: info: Loading plugin "outputs"... Oct 16 13:42:14 rivo volumio[3412]: info: Loading plugin "albumart"... Oct 16 13:42:14 rivo volumio[3412]: info: Plugin example_plugin is not enabled Oct 16 13:42:14 rivo volumio[3412]: info: Loading plugin "hi_res_audio"... Oct 16 13:42:15 rivo volumio[3412]: Forking 3 albumart workers Oct 16 13:42:16 rivo volumio[3412]: Starting albumart workers Oct 16 13:42:16 rivo volumio[3412]: Starting albumart workers Oct 16 13:42:16 rivo volumio[3412]: Starting albumart workers Oct 16 13:42:16 rivo volumio[3412]: info: Applying required configuration parameters for plugin hi_res_audio Oct 16 13:42:16 rivo volumio[3412]: info: Loading plugin "inputs"... Oct 16 13:42:17 rivo volumio[3412]: info: Loading plugin "qobuz"... Oct 16 13:42:19 rivo volumio[3412]: info: Loading plugin "smart_inputs"... Oct 16 13:42:19 rivo volumio[3412]: info: Loading plugin "tidal"... Oct 16 13:42:20 rivo volumio-remote-updater[2854]: [2024-10-16 13:42:20] [connect] Successful connection Oct 16 13:42:21 rivo volumio[3412]: info: Loading plugin "rivocontrol"... Oct 16 13:42:21 rivo volumio[3412]: info: Adding this device properties Oct 16 13:42:21 rivo volumio[3412]: info: CoreCommandRouter::executeOnPlugin: system , setThisDeviceVolumioProperties Oct 16 13:42:21 rivo volumio[3412]: info: Setting Additional Device Volumio Properties: [object Object] Oct 16 13:42:21 rivo volumio[3412]: info: Loading plugin "updater_comm"... Oct 16 13:42:22 rivo volumio[3412]: info: Loading plugin "cec_controller"... Oct 16 13:42:22 rivo volumio[3412]: info: Applying required configuration parameters for plugin cec_controller Oct 16 13:42:22 rivo volumio[3412]: info: Plugin mpdemulation is not enabled Oct 16 13:42:22 rivo volumio[3412]: info: Loading plugin "rest_api"... Oct 16 13:42:22 rivo volumio[3412]: info: Loading plugin "websocket"... Oct 16 13:42:22 rivo volumio[3412]: info: Starting Socket.io Server version 2.3.0 Oct 16 13:42:22 rivo volumio[3412]: info: Loading i18n strings for locale it Oct 16 13:42:22 rivo volumio[3412]: Updating browse sources language Oct 16 13:42:22 rivo volumio[3412]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 16 13:42:22 rivo volumio[3412]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 16 13:42:22 rivo volumio[3412]: info: CoreCommandRouter::initPlayerControls Oct 16 13:42:22 rivo volumio[3412]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 13:42:22 rivo volumio[3412]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 13:42:22 rivo volumio[3412]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 13:42:22 rivo volumio[3412]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 13:42:22 rivo volumio[3412]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 13:42:22 rivo volumio[3412]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 13:42:22 rivo volumio[3412]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 13:42:22 rivo volumio[3412]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 13:42:22 rivo volumio[3412]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 16 13:42:22 rivo volumio[3412]: Express server listening on port 3000 Oct 16 13:42:22 rivo volumio[3412]: [Metrics] WebUI: 22s 395.21ms Oct 16 13:42:22 rivo volumio[3412]: info: CoreStateMachine::resetVolumioState Oct 16 13:42:22 rivo volumio[3412]: info: CoreStateMachine::getcurrentVolume Oct 16 13:42:22 rivo volumio[3412]: info: CoreCommandRouter::volumioRetrievevolume Oct 16 13:42:23 rivo volumio[3412]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 13:42:23 rivo sudo[3669]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 16 13:42:23 rivo sudo[3669]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 13:42:23 rivo sudo[3669]: pam_unix(sudo:session): session closed for user root Oct 16 13:42:23 rivo volumio[3412]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Oct 16 13:42:23 rivo sudo[3671]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 16 13:42:23 rivo volumio[3412]: info: Completed loading Core Plugins Oct 16 13:42:23 rivo sudo[3671]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 13:42:23 rivo volumio[3412]: info: Preparing to generate the ALSA configuration file Oct 16 13:42:23 rivo sudo[3671]: pam_unix(sudo:session): session closed for user root Oct 16 13:42:23 rivo volumio[3412]: info: CoreStateMachine::pushState Oct 16 13:42:23 rivo volumio[3412]: info: CorePlayQueue::getTrack 0 Oct 16 13:42:23 rivo volumio[3412]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 13:42:23 rivo volumio[3412]: info: CoreCommandRouter::volumioPushState Oct 16 13:42:23 rivo volumio[3412]: info: CoreStateMachine::updateTrackBlock Oct 16 13:42:23 rivo volumio[3412]: info: CorePlayQueue::getTrackBlock Oct 16 13:42:23 rivo volumio[3412]: info: CoreCommandRouter::volumioRetrievevolume Oct 16 13:42:23 rivo volumio[3412]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Oct 16 13:42:23 rivo volumio[3412]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Oct 16 13:42:23 rivo volumio[3412]: info: Reading ALSA contributions from plugins. Oct 16 13:42:23 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.41 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 1 Oct 16 13:42:23 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.41 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 2 Oct 16 13:42:23 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.41 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 3 Oct 16 13:42:23 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.41 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 4 Oct 16 13:42:23 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.41 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 5 Oct 16 13:42:23 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.41 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 6 Oct 16 13:42:23 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.42 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 7 Oct 16 13:42:23 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.42 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 8 Oct 16 13:42:23 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.42 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 9 Oct 16 13:42:23 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.42 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 10 Oct 16 13:42:23 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.42 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 11 Oct 16 13:42:23 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.42 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 12 Oct 16 13:42:23 rivo volumio-remote-updater[2854]: [2024-10-16 13:42:23] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1729078940 101 Oct 16 13:42:23 rivo volumio[3412]: 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: 13 Oct 16 13:42:23 rivo systemd[1]: systemd-hostnamed.service: Succeeded. Oct 16 13:42:23 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.41 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 14 Oct 16 13:42:23 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.41 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 15 Oct 16 13:42:23 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.41 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 16 Oct 16 13:42:23 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.41 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 17 Oct 16 13:42:23 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.41 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 18 Oct 16 13:42:23 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.41 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 19 Oct 16 13:42:23 rivo volumio[3412]: info: CoreStateMachine::pushState Oct 16 13:42:23 rivo volumio[3412]: info: CorePlayQueue::getTrack 0 Oct 16 13:42:23 rivo volumio[3412]: info: CoreCommandRouter::volumioPushState Oct 16 13:42:23 rivo volumio[3412]: info: Reloading queue from file Oct 16 13:42:23 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.41 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 20 Oct 16 13:42:23 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.41 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 21 Oct 16 13:42:23 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.41 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 22 Oct 16 13:42:23 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.41 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 23 Oct 16 13:42:23 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.41 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 24 Oct 16 13:42:23 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.42 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 25 Oct 16 13:42:23 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.42 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 26 Oct 16 13:42:23 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.42 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 27 Oct 16 13:42:23 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.42 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 28 Oct 16 13:42:23 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.42 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 29 Oct 16 13:42:23 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.42 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 30 Oct 16 13:42:23 rivo volumio[3412]: info: CoreStateMachine::setRepeat true single undefined Oct 16 13:42:23 rivo volumio[3412]: info: CoreStateMachine::pushState Oct 16 13:42:23 rivo volumio[3412]: info: CorePlayQueue::getTrack 0 Oct 16 13:42:23 rivo volumio[3412]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 13:42:23 rivo volumio[3412]: info: CoreCommandRouter::volumioPushState Oct 16 13:42:23 rivo volumio[3412]: info: CoreStateMachine::setRandom null Oct 16 13:42:23 rivo volumio[3412]: info: CoreStateMachine::pushState Oct 16 13:42:23 rivo volumio[3412]: info: CorePlayQueue::getTrack 0 Oct 16 13:42:23 rivo volumio[3412]: info: CoreCommandRouter::volumioPushState Oct 16 13:42:23 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.42 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 31 Oct 16 13:42:23 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.42 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 32 Oct 16 13:42:23 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.42 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 33 Oct 16 13:42:23 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.42 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 34 Oct 16 13:42:23 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.42 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 35 Oct 16 13:42:23 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.42 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 36 Oct 16 13:42:23 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.42 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 37 Oct 16 13:42:23 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.42 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 38 Oct 16 13:42:23 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.42 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 39 Oct 16 13:42:23 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.42 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 40 Oct 16 13:42:23 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.42 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 41 Oct 16 13:42:23 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.41 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 42 Oct 16 13:42:23 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.42 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 43 Oct 16 13:42:23 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.42 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 44 Oct 16 13:42:23 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.42 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 45 Oct 16 13:42:23 rivo sudo[3692]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Oct 16 13:42:23 rivo sudo[3692]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 13:42:23 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.42 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 46 Oct 16 13:42:23 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.42 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 47 Oct 16 13:42:23 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.42 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 48 Oct 16 13:42:23 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.42 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 49 Oct 16 13:42:23 rivo systemd[1]: Started UPnP Renderer front-end to MPD. Oct 16 13:42:23 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.42 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 50 Oct 16 13:42:23 rivo sudo[3692]: pam_unix(sudo:session): session closed for user root Oct 16 13:42:23 rivo volumio[3412]: info: CoreCommandRouter::volumioGetState Oct 16 13:42:23 rivo volumio[3412]: info: CorePlayQueue::getTrack 0 Oct 16 13:42:23 rivo volumio[3412]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Oct 16 13:42:23 rivo volumio[3412]: info: Discovery: Browse raised the following error Error: getaddrinfo -3007 Oct 16 13:42:23 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.42 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 51 Oct 16 13:42:23 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.42 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 52 Oct 16 13:42:23 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.42 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 53 Oct 16 13:42:23 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.42 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 54 Oct 16 13:42:23 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.42 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 55 Oct 16 13:42:23 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.42 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 56 Oct 16 13:42:23 rivo volumio[3412]: info: Upmpdcli Daemon Started Oct 16 13:42:23 rivo volumio[3412]: info: Asound.conf file unchanged, so no further update is needed Oct 16 13:42:23 rivo volumio[3412]: info: Output device has changed, restarting MPD Oct 16 13:42:24 rivo sudo[3704]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 16 13:42:24 rivo sudo[3704]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 13:42:24 rivo volumio[3412]: info: Output device has changed, restarting Shairport Sync Oct 16 13:42:24 rivo volumio[3412]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 13:42:24 rivo volumio[3412]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 13:42:24 rivo sudo[3704]: pam_unix(sudo:session): session closed for user root Oct 16 13:42:24 rivo sudo[3706]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 16 13:42:24 rivo sudo[3706]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 13:42:24 rivo systemd[1]: Listening on mpd.socket. Oct 16 13:42:24 rivo systemd[1]: Starting Music Player Daemon... Oct 16 13:42:24 rivo volumio[3412]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 16 13:42:24 rivo volumio[3412]: info: ___________ START PLUGINS ___________ Oct 16 13:42:24 rivo volumio[3412]: info: ControllerMpd::onStart: Initializing MPD Oct 16 13:42:24 rivo volumio[3412]: info: Creating MPD Configuration file Oct 16 13:42:24 rivo sudo[3715]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 16 13:42:24 rivo sudo[3715]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 13:42:24 rivo volumio[3412]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 16 13:42:24 rivo volumio[3412]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 16 13:42:24 rivo volumio[3412]: info: [1729078944209] CoreMusicLibrary::Adding element Server multimediali Oct 16 13:42:24 rivo volumio[3412]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 16 13:42:24 rivo sudo[3715]: pam_unix(sudo:session): session closed for user root Oct 16 13:42:24 rivo sudo[3717]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 16 13:42:24 rivo sudo[3717]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 13:42:24 rivo volumio[3412]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 16 13:42:24 rivo volumio[3412]: info: Adding METAVOLUMIO REST API Endpoints Oct 16 13:42:24 rivo volumio[3412]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Oct 16 13:42:24 rivo volumio[3412]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio Oct 16 13:42:24 rivo volumio[3412]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio Oct 16 13:42:24 rivo volumio[3412]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio Oct 16 13:42:24 rivo volumio[3412]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 13:42:24 rivo volumio[3412]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 13:42:24 rivo systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Oct 16 13:42:24 rivo systemd[1]: mpd.service: Succeeded. Oct 16 13:42:24 rivo systemd[1]: Stopped Music Player Daemon. Oct 16 13:42:24 rivo sudo[3721]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/hciconfig hci0 name Rivo Oct 16 13:42:24 rivo sudo[3721]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 13:42:24 rivo systemd[1]: Starting Music Player Daemon... Oct 16 13:42:24 rivo sudo[3721]: pam_unix(sudo:session): session closed for user root Oct 16 13:42:24 rivo volumio[3412]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 16 13:42:24 rivo volumio[3412]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 13:42:24 rivo volumio[3412]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 13:42:24 rivo volumio[3412]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 16 13:42:24 rivo volumio[3412]: info: Preparing CD Folders Oct 16 13:42:24 rivo volumio[3412]: info: Adding CD REST API Endpoints Oct 16 13:42:24 rivo volumio[3412]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller Oct 16 13:42:24 rivo volumio[3412]: info: Starting UDEV Watcher for CD Oct 16 13:42:24 rivo volumio[3412]: info: Detecting CD presence with UDEV Oct 16 13:42:24 rivo volumio[3412]: info: CoreCommandRouter::executeOnPlugin: networkfs , getUdevDevices Oct 16 13:42:24 rivo sudo[3724]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 16 13:42:24 rivo sudo[3724]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 13:42:24 rivo sudo[3724]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Oct 16 13:42:24 rivo sudo[3724]: pam_unix(sudo:session): session closed for user root Oct 16 13:42:24 rivo volumio[3412]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 16 13:42:24 rivo volumio[3412]: info: [1729078944483] CoreMusicLibrary::Adding element Last_100 Oct 16 13:42:24 rivo volumio[3412]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 16 13:42:24 rivo volumio[3412]: info: Starting RAAT Plugin Oct 16 13:42:24 rivo volumio[3412]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , addAdditionalUISections Oct 16 13:42:24 rivo volumio[3412]: info: Additional UI Settings Added for plugin music_service/raat Oct 16 13:42:24 rivo volumio[3412]: info: Registering DSP Elements listener and retrieving current ones Oct 16 13:42:24 rivo volumio[3412]: info: Additional DSP elements updated Oct 16 13:42:24 rivo volumio[3412]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 13:42:24 rivo volumio[3412]: info: Updating RAAT Signal Path Oct 16 13:42:24 rivo volumio[3412]: error: Cannot write to RAAT Client: TypeError: Cannot read property 'write' of undefined Oct 16 13:42:24 rivo volumio[3412]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 13:42:24 rivo volumio[3412]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 13:42:24 rivo volumio[3412]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 13:42:24 rivo volumio[3412]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 13:42:24 rivo volumio[3412]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 13:42:24 rivo volumio[3412]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 13:42:24 rivo volumio[3412]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 16 13:42:24 rivo volumio[3412]: info: Overriding Software Volume supported Formats Oct 16 13:42:24 rivo volumio[3412]: info: Not Reporting Auto name since its the default one Oct 16 13:42:24 rivo volumio[3412]: info: Streaming services startup Oct 16 13:42:24 rivo volumio[3412]: info: Starting Streaming Daemon Oct 16 13:42:24 rivo sudo[3739]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Oct 16 13:42:24 rivo sudo[3739]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 13:42:24 rivo sudo[3739]: pam_unix(sudo:session): session closed for user root Oct 16 13:42:24 rivo volumio[3412]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 16 13:42:24 rivo volumio[3412]: info: [1729078944702] CoreMusicLibrary::Adding element Webradio Oct 16 13:42:24 rivo volumio[3412]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 16 13:42:24 rivo volumio[3412]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 16 13:42:24 rivo volumio[3412]: info: Initializing BBC Radios Oct 16 13:42:24 rivo sudo[3747]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Oct 16 13:42:24 rivo sudo[3747]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 13:42:24 rivo sudo[3747]: pam_unix(sudo:session): session closed for user root Oct 16 13:42:24 rivo volumio[3412]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 16 13:42:24 rivo volumio[3412]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 13:42:24 rivo volumio[3412]: info: Creating Spotify config file Oct 16 13:42:24 rivo volumio[3412]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 13:42:24 rivo volumio[3412]: error: Hi Res Audio Failed Login: Missing Login Data Oct 16 13:42:24 rivo volumio[3412]: info: Adding HIGHRESAUDIO REST API Endpoints Oct 16 13:42:24 rivo volumio[3412]: info: Adding getStreamUrlhi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Oct 16 13:42:24 rivo volumio[3412]: info: Initializing Serial Communication on port /dev/ttyS3 Oct 16 13:42:24 rivo kernel: meson_uart ffd22000.serial: ttyS3 use xtal(24M) 24000000 change 0 to 9600 Oct 16 13:42:24 rivo kernel: meson_uart ffd22000.serial: ttyS3 use xtal(24M) 24000000 change 9600 to 9600 Oct 16 13:42:24 rivo kernel: meson_uart ffd22000.serial: ttyS3 use xtal(24M) 24000000 change 9600 to 115200 Oct 16 13:42:24 rivo volumio[3412]: info: Touch Event Listener Process Starting Oct 16 13:42:24 rivo volumio[3412]: info: Refreshing QOBUZ token Oct 16 13:42:25 rivo sudo[3761]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/xinput --test-xi2 --root Oct 16 13:42:25 rivo sudo[3761]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 13:42:25 rivo volumio[3412]: info: Adding inputs REST Endpoints Oct 16 13:42:25 rivo volumio[3412]: info: Adding scanAudioInputs REST Endpoint for plugin: music_service/smart_inputs Oct 16 13:42:25 rivo volumio[3412]: info: Scanning Audio Inputs Oct 16 13:42:25 rivo sudo[3761]: pam_unix(sudo:session): session closed for user root Oct 16 13:42:25 rivo volumio[3412]: info: Checking against Known Cards name Oct 16 13:42:25 rivo volumio[3412]: info: Checking against Known Cards name Oct 16 13:42:25 rivo volumio[3412]: info: Checking against Known Cards name Oct 16 13:42:25 rivo volumio[3412]: info: Checking against Known Cards name Oct 16 13:42:25 rivo volumio[3412]: info: Checking against Known Cards name Oct 16 13:42:25 rivo volumio[3412]: info: Adding Server instance for streaming Oct 16 13:42:25 rivo volumio[3412]: info: Refreshing TIDAL token Oct 16 13:42:25 rivo sudo[3772]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x25 0x0 Oct 16 13:42:25 rivo sudo[3772]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 13:42:25 rivo sudo[3772]: pam_unix(sudo:session): session closed for user root Oct 16 13:42:25 rivo sudo[3775]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x28 0x0 Oct 16 13:42:25 rivo sudo[3775]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 13:42:25 rivo sudo[3775]: pam_unix(sudo:session): session closed for user root Oct 16 13:42:25 rivo sudo[3778]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x29 0x1 Oct 16 13:42:25 rivo sudo[3778]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 13:42:25 rivo sudo[3778]: pam_unix(sudo:session): session closed for user root Oct 16 13:42:25 rivo sudo[3781]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x33 0x1 Oct 16 13:42:25 rivo sudo[3781]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 13:42:25 rivo sudo[3781]: pam_unix(sudo:session): session closed for user root Oct 16 13:42:25 rivo volumio[3412]: info: Apply VIM3L Onboard LEDs Settings Oct 16 13:42:25 rivo volumio[3412]: info: Turning On Onboard LEDs Oct 16 13:42:25 rivo sudo[3785]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/tee /sys/class/leds/sys_led/trigger Oct 16 13:42:25 rivo sudo[3785]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 13:42:25 rivo volumio[3412]: info: Starting CEC Event listener Oct 16 13:42:25 rivo sudo[3785]: pam_unix(sudo:session): session closed for user root Oct 16 13:42:25 rivo volumio[3412]: info: Volumio Calling Home Oct 16 13:42:25 rivo sudo[3789]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/tee /sys/class/leds/red_red/trigger Oct 16 13:42:25 rivo sudo[3789]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 13:42:25 rivo sudo[3789]: pam_unix(sudo:session): session closed for user root Oct 16 13:42:25 rivo volumio[3412]: (node:3412) [DEP0005] DeprecationWarning: Buffer() is deprecated due to security and usability issues. Please use the Buffer.alloc(), Buffer.allocUnsafe(), or Buffer.from() methods instead. Oct 16 13:42:25 rivo volumio[3412]: (Use `node --trace-deprecation ...` to show where the warning was created) Oct 16 13:42:25 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.42 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 57 Oct 16 13:42:25 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.42 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 58 Oct 16 13:42:25 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.42 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 59 Oct 16 13:42:25 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.42 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 60 Oct 16 13:42:25 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.42 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 61 Oct 16 13:42:25 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.42 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 62 Oct 16 13:42:25 rivo volumio[3412]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 16 13:42:25 rivo volumio[3412]: info: Listing playlists Oct 16 13:42:25 rivo volumio[3412]: info: CoreCommandRouter::volumioGetQueue Oct 16 13:42:25 rivo volumio[3412]: info: CoreStateMachine::getQueue Oct 16 13:42:25 rivo volumio[3412]: info: CorePlayQueue::getQueue Oct 16 13:42:25 rivo volumio[3412]: info: CoreCommandRouter::volumioGetVisibleSources Oct 16 13:42:25 rivo volumio[3412]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 16 13:42:25 rivo volumio[3412]: info: Serial port opened successfully Oct 16 13:42:25 rivo volumio[3412]: info: Sending serial start messages Oct 16 13:42:25 rivo volumio[3412]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 13:42:25 rivo volumio[3412]: info: MP1 GPIO: Signalled system ready via GPIO Oct 16 13:42:25 rivo volumio[3412]: info: Touch Event Listener Process Closed Oct 16 13:42:25 rivo volumio[3412]: error: Cannot start Volumio Streaming Daemon Oct 16 13:42:25 rivo volumio[3412]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Oct 16 13:42:25 rivo volumio[3412]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Oct 16 13:42:25 rivo volumio[3412]: info: RAAT Albumart path created successfully Oct 16 13:42:25 rivo volumio[3412]: info: Bluetooth name changed to Rivo Oct 16 13:42:25 rivo volumio[3412]: info: MPD Permissions set Oct 16 13:42:25 rivo volumio[3412]: info: MPD Permissions set Oct 16 13:42:25 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.42 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 63 Oct 16 13:42:25 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.42 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 64 Oct 16 13:42:25 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.42 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 65 Oct 16 13:42:25 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.42 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 66 Oct 16 13:42:25 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.42 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 67 Oct 16 13:42:25 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.42 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 68 Oct 16 13:42:25 rivo volumio[3412]: info: Volumio called home Oct 16 13:42:25 rivo volumio[3412]: info: Spotify config file written Oct 16 13:42:26 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.42 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 69 Oct 16 13:42:26 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.42 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 70 Oct 16 13:42:26 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.42 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 71 Oct 16 13:42:26 rivo sudo[3796]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Oct 16 13:42:26 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.42 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 72 Oct 16 13:42:26 rivo sudo[3796]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 13:42:26 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.42 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 73 Oct 16 13:42:26 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.42 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 74 Oct 16 13:42:26 rivo systemd[1]: Started go-librespot Daemon. Oct 16 13:42:26 rivo sudo[3796]: pam_unix(sudo:session): session closed for user root Oct 16 13:42:26 rivo go-librespot[3798]: Librespot-go daemon starting... Oct 16 13:42:26 rivo volumio[3412]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 75 Oct 16 13:42:26 rivo volumio[3412]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 13:42:26 rivo volumio[3412]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 13:42:26 rivo volumio[3412]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 13:42:26 rivo volumio[3412]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 13:42:26 rivo volumio[3412]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 13:42:26 rivo volumio[3412]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 13:42:26 rivo volumio[3412]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 13:42:26 rivo volumio[3412]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 13:42:26 rivo volumio[3412]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 13:42:26 rivo volumio[3412]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 16 13:42:26 rivo volumio[3412]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 13:42:26 rivo volumio[3412]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 13:42:26 rivo volumio[3412]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 13:42:26 rivo volumio[3412]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 13:42:26 rivo volumio[3412]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 13:42:26 rivo volumio[3412]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 13:42:26 rivo volumio[3412]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 13:42:26 rivo volumio[3412]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 13:42:26 rivo volumio[3412]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 13:42:26 rivo go-librespot[3798]: time="2024-10-16T13:42:26+02:00" level=info msg="generated new device id: a6c80e03415ad10347ed4e76fd3fb656ffcbe6d8" Oct 16 13:42:26 rivo go-librespot[3798]: time="2024-10-16T13:42:26+02:00" level=debug msg="stored credentials found for darionoemi08" Oct 16 13:42:26 rivo volumio[3412]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 13:42:26 rivo volumio[3412]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 16 13:42:26 rivo volumio[3412]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 13:42:26 rivo volumio[3412]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Oct 16 13:42:26 rivo volumio[3412]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setDeviceVolumeOverride Oct 16 13:42:26 rivo volumio[3412]: info: Setting Device Volume Override Oct 16 13:42:26 rivo sudo[3823]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Oct 16 13:42:26 rivo sudo[3823]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 13:42:26 rivo sudo[3823]: pam_unix(sudo:session): session closed for user root Oct 16 13:42:26 rivo sudo[3827]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Oct 16 13:42:26 rivo sudo[3827]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 13:42:26 rivo volumio[3412]: info: CoreCommandRouter::volumioUpdateVolumeSettings Oct 16 13:42:26 rivo volumio[3412]: info: Updating Volume Controller Parameters: Device: 0,2 Name: softvolume Mixer: SoftMaster Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Oct 16 13:42:26 rivo volumio[3412]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Oct 16 13:42:26 rivo volumio[3412]: info: Disabling external Volume Control Oct 16 13:42:26 rivo systemd[1]: Started RAAT DAEMON. Oct 16 13:42:26 rivo sudo[3827]: pam_unix(sudo:session): session closed for user root Oct 16 13:42:26 rivo volumio[3412]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 13:42:26 rivo volumio[3412]: info: CoreStateMachine::pushState Oct 16 13:42:26 rivo volumio[3412]: info: CorePlayQueue::getTrack 0 Oct 16 13:42:26 rivo volumio[3412]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 13:42:26 rivo volumio[3412]: info: CoreCommandRouter::volumioPushState Oct 16 13:42:26 rivo volumio[3412]: info: CoreCommandRouter::executeOnPlugin: system , setAdditionalSVInfo Oct 16 13:42:26 rivo volumio[3412]: info: Setting Additional System Software info: Hardware Revision: 2.0 Oct 16 13:42:26 rivo volumio[3412]: info: CoreCommandRouter::executeOnPlugin: system , setHwFwVersion Oct 16 13:42:26 rivo volumio[3412]: info: Setting HW Firmware info: undefined Oct 16 13:42:26 rivo volumio[3412]: info: CoreCommandRouter::executeOnPlugin: system , setHwVersion Oct 16 13:42:26 rivo volumio[3412]: info: Setting HW Version info: 2.0 Oct 16 13:42:26 rivo volumio[3412]: info: CoreCommandRouter::executeOnPlugin: system , setAdditionalSVInfo Oct 16 13:42:26 rivo kernel: aml_spdif_open Oct 16 13:42:26 rivo kernel: audio_ddr_mngr: frddrs[0] registered by device ff660000.audiobus:spdif@0 Oct 16 13:42:26 rivo kernel: spdif_a keep clk continuous Oct 16 13:42:26 rivo kernel: aml_spdif_close Oct 16 13:42:26 rivo kernel: audio_ddr_mngr: frddrs[0] released by device ff660000.audiobus:spdif@0 Oct 16 13:42:26 rivo volumio[3412]: info: Setting Additional System Software info: Hardware Revision: 2.0, Firmware Version: 0.3.3 Oct 16 13:42:26 rivo volumio[3412]: info: CoreCommandRouter::executeOnPlugin: system , setHwFwVersion Oct 16 13:42:26 rivo volumio[3412]: info: Setting HW Firmware info: 0.3.3 Oct 16 13:42:26 rivo volumio[3412]: info: CoreCommandRouter::executeOnPlugin: system , setHwVersion Oct 16 13:42:26 rivo volumio[3412]: info: Setting HW Version info: 2.0 Oct 16 13:42:26 rivo volumio[3412]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Oct 16 13:42:26 rivo volumio[3412]: info: MCU Signalled Headphone Mode Disabled Oct 16 13:42:26 rivo volumio[3412]: info: CoreCommandRouter::executeOnPlugin: raat , reportHeadphoneState Oct 16 13:42:26 rivo volumio[3412]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 13:42:26 rivo volumio[3412]: info: Updating RAAT Signal Path Oct 16 13:42:26 rivo volumio[3412]: error: Cannot write to RAAT Client: TypeError: Cannot read property 'write' of undefined Oct 16 13:42:26 rivo volumio[3412]: info: MCU Signalled Sleep Mode Disabled Oct 16 13:42:26 rivo volumio[3412]: info: Enabling Advanced system settings configuration Oct 16 13:42:26 rivo volumio[3412]: info: CoreCommandRouter::executeOnPlugin: system , addAdditionalUISections Oct 16 13:42:26 rivo volumio[3412]: info: Additional UI Settings Added for plugin music_service/inputs Oct 16 13:42:26 rivo volumio[3412]: info: MCU Signalled Auto Boot Mode On Power Active Oct 16 13:42:26 rivo kernel: fb: mem_free_work, free memory: addr:800000 Oct 16 13:42:26 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.42 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 76 Oct 16 13:42:26 rivo sudo[3850]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/xset dpms force on Oct 16 13:42:26 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.42 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 77 Oct 16 13:42:26 rivo sudo[3850]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 13:42:26 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.42 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 78 Oct 16 13:42:26 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.42 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 79 Oct 16 13:42:26 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.42 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 80 Oct 16 13:42:26 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.42 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 81 Oct 16 13:42:26 rivo sudo[3850]: pam_unix(sudo:session): session closed for user root Oct 16 13:42:26 rivo go-librespot[3798]: time="2024-10-16T13:42:26+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Oct 16 13:42:26 rivo go-librespot[3798]: time="2024-10-16T13:42:26+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 16 13:42:26 rivo go-librespot[3798]: time="2024-10-16T13:42:26+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 16 13:42:26 rivo go-librespot[3798]: time="2024-10-16T13:42:26+02:00" level=debug msg="zeroconf server listening on port 38211" Oct 16 13:42:26 rivo volumio[3412]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 82 Oct 16 13:42:26 rivo volumio[3412]: error: Serial API: Failed to decode command: MAXVOL, message: 100 Oct 16 13:42:26 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.42 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 83 Oct 16 13:42:26 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.42 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 84 Oct 16 13:42:26 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.42 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 85 Oct 16 13:42:26 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.42 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 86 Oct 16 13:42:26 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.42 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 87 Oct 16 13:42:26 rivo go-librespot[3798]: time="2024-10-16T13:42:26+02:00" level=debug msg="obtained new client token: AAC+S088jsJAGzFMFzMloXdwfJbDY7bil6c7HFSlXOJWpUCsCab/GxnzBuabEJMChxH4J5hkCwukX8DYotou8373X5asR/9KYHRfmIhGzQZ8ebLrwkDKwpsAXyV6VMKmOk6fkFvi0UHL1zDN15H1BGpmlLhOm54C2IZpeBsVc6xO2nUdOF0pwhGIRrLFANNb/N6Ng0QJiFHg+UGFGoXx/k389BUdZ9u+FqYRod9fAat6ABQp5iNkJ5sXn5ip" Oct 16 13:42:26 rivo volumio[3412]: verbose: New Socket.io Connection to 192.168.1.42 from 192.168.1.38 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_0_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 88 Oct 16 13:42:26 rivo volumio[3412]: info: Access Token successfully retrieved Oct 16 13:42:26 rivo volumio[3412]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 16 13:42:26 rivo volumio[3412]: info: [1729078946998] CoreMusicLibrary::Adding element QOBUZ Oct 16 13:42:26 rivo volumio[3412]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 16 13:42:27 rivo volumio[3412]: Cannot find translation for source QOBUZ Oct 16 13:42:27 rivo volumio[3412]: info: Stopping AccessToken refresher cron for QOBUZ Oct 16 13:42:27 rivo volumio[3412]: info: AccessToken refresher cron started for QOBUZ Oct 16 13:42:27 rivo volumio[3412]: info: Adding QOBUZ REST API Endpoints Oct 16 13:42:27 rivo volumio[3412]: info: Adding getStreamUrlqobuz REST Endpoint for plugin: music_service/qobuz Oct 16 13:42:27 rivo go-librespot[3798]: time="2024-10-16T13:42:27+02:00" level=debug msg="completed keyexchange" Oct 16 13:42:27 rivo volumio[3412]: info: Access Token successfully retrieved Oct 16 13:42:27 rivo volumio[3412]: info: Preload queue cleared Oct 16 13:42:27 rivo volumio[3412]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 16 13:42:27 rivo volumio[3412]: info: CoreStateMachine::ClearQueue Oct 16 13:42:27 rivo volumio[3412]: info: CoreStateMachine::stop Oct 16 13:42:27 rivo volumio[3412]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 13:42:27 rivo volumio[3412]: info: CorePlayQueue::clearPlayQueue Oct 16 13:42:27 rivo volumio[3412]: info: CorePlayQueue::saveQueue Oct 16 13:42:27 rivo volumio[3412]: info: CoreCommandRouter::volumioPushQueue Oct 16 13:42:27 rivo volumio[3412]: info: CoreStateMachine::addQueueItems Oct 16 13:42:27 rivo volumio[3412]: info: CorePlayQueue::addQueueItems Oct 16 13:42:27 rivo volumio[3412]: info: Preload queue cleared Oct 16 13:42:27 rivo volumio[3412]: info: Adding Item to queue: music-library/USB/TOSHIBA_EXT/Bluesound songs/Estera/Metallica/Metallica 24-96/1-Enter Sandman.flac Oct 16 13:42:27 rivo volumio[3412]: info: Exploding uri music-library/USB/TOSHIBA_EXT/Bluesound songs/Estera/Metallica/Metallica 24-96/1-Enter Sandman.flac in service mpd Oct 16 13:42:27 rivo volumio[3412]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 16 13:42:27 rivo go-librespot[3798]: time="2024-10-16T13:42:27+02:00" level=debug msg="completed challenge" Oct 16 13:42:27 rivo volumio[3412]: TypeError: Cannot read property 'then' of undefined Oct 16 13:42:27 rivo volumio[3412]: at ControllerMpd.scanFolder (/volumio/app/plugins/music_service/mpd/index.js:2527:19) Oct 16 13:42:27 rivo volumio[3412]: at ControllerMpd.explodeUri (/volumio/app/plugins/music_service/mpd/index.js:2325:21) Oct 16 13:42:27 rivo volumio[3412]: at CoreCommandRouter.explodeUriFromService (/volumio/app/index.js:1365:16) Oct 16 13:42:27 rivo volumio[3412]: at CorePlayQueue.explodeUriFromCache (/volumio/app/playqueue.js:123:24) Oct 16 13:42:27 rivo volumio[3412]: at CorePlayQueue.explodeUri (/volumio/app/playqueue.js:181:19) Oct 16 13:42:27 rivo volumio[3412]: at CorePlayQueue.addQueueItems (/volumio/app/playqueue.js:223:30) Oct 16 13:42:27 rivo volumio[3412]: at CoreStateMachine.addQueueItems (/volumio/app/statemachine.js:247:25) Oct 16 13:42:27 rivo volumio[3412]: at CoreCommandRouter.replaceAndPlay (/volumio/app/index.js:507:23) Oct 16 13:42:27 rivo volumio[3412]: at CoreCommandRouter.playItemsList (/volumio/app/index.js:483:17) Oct 16 13:42:27 rivo volumio[3412]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:142:33) Oct 16 13:42:27 rivo volumio[3412]: at Socket.emit (events.js:400:28) Oct 16 13:42:27 rivo volumio[3412]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Oct 16 13:42:27 rivo volumio[3412]: at processTicksAndRejections (internal/process/task_queues.js:77:11) Oct 16 13:42:27 rivo volumio[3412]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 16 13:42:27 rivo mpd[3731]: Oct 16 13:42 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Oct 16 13:42:27 rivo go-librespot[3798]: time="2024-10-16T13:42:27+02:00" level=debug msg="authenticated as darionoemi08" Oct 16 13:42:27 rivo systemd[1]: Started Music Player Daemon. Oct 16 13:42:27 rivo sudo[3706]: pam_unix(sudo:session): session closed for user root Oct 16 13:42:27 rivo sudo[3717]: pam_unix(sudo:session): session closed for user root Oct 16 13:42:27 rivo go-librespot[3798]: time="2024-10-16T13:42:27+02:00" level=debug msg="authenticated as darionoemi08" Oct 16 13:42:27 rivo go-librespot[3798]: time="2024-10-16T13:42:27+02:00" level=debug msg="dealer connection opened" Oct 16 13:42:27 rivo go-librespot[3798]: time="2024-10-16T13:42:27+02:00" level=debug msg="initializing zeroconf session, username: darionoemi08" Oct 16 13:42:27 rivo go-librespot[3798]: time="2024-10-16T13:42:27+02:00" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336" Oct 16 13:42:27 rivo go-librespot[3798]: time="2024-10-16T13:42:27+02:00" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2" Oct 16 13:42:27 rivo go-librespot[3798]: time="2024-10-16T13:42:27+02:00" level=debug msg="received connection id: NzQ4YWQ3MDAtYTQ5OS00M2YyLTk3MzktZGUwMjUzNGExY2MxK2RlYWxlcit0Y3A6Ly8wYWNhNTg1Zi5pcC5nZXc0LnNwb3RpZnkubmV0OjU3MDArOEYwOTg4MzdEQzA3QzQ0QjFFOUU2M0UyMkQ2NUM3MjgyRTc0OTNGNkNFRTgzMzUzNURBOUZEOEM2RkQ1N0QxMQ==" Oct 16 13:42:28 rivo go-librespot[3798]: time="2024-10-16T13:42:28+02:00" level=debug msg="put connect state because NEW_DEVICE" Oct 16 13:42:28 rivo go-librespot[3798]: time="2024-10-16T13:42:28+02:00" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17" Oct 16 13:42:28 rivo go-librespot[3798]: time="2024-10-16T13:42:28+02:00" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0" Oct 16 13:42:28 rivo go-librespot[3798]: time="2024-10-16T13:42:28+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 495" Oct 16 13:42:28 rivo go-librespot[3798]: time="2024-10-16T13:42:28+02:00" level=debug msg="autoplay enabled: false" Oct 16 13:42:28 rivo sudo[3863]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-16 13:41 Oct 16 13:42:28 rivo sudo[3863]: 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="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="rivo" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 17 Sep 2024 05:47:06 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Rivo" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Rivo" VOLUMIO_HASH="b3e08c3e210a64867536255c2503fb09"