-- Logs begin at Tue 2024-09-24 13:56:20 CEST, end at Mon 2024-10-21 19:03:40 CEST. -- Oct 21 19:02:01 rivo volumio-remote-updater[2848]: [2024-10-21 19:02:01] [connect] Successful connection Oct 21 19:02:13 rivo volumio-remote-updater[2848]: [2024-10-21 19:02:13] [connect] Successful connection Oct 21 19:02:28 rivo volumio-remote-updater[2848]: [2024-10-21 19:02:28] [connect] Successful connection Oct 21 19:02:43 rivo volumio-remote-updater[2848]: [2024-10-21 19:02:43] [connect] Successful connection Oct 21 19:02:54 rivo sudo[6519]: pam_unix(sudo:session): session closed for user root Oct 21 19:02:54 rivo systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Oct 21 19:02:55 rivo systemd[1]: volumio.service: Failed with result 'exit-code'. Oct 21 19:02:55 rivo systemd[1]: Started dynamicswap service. Oct 21 19:02:55 rivo systemd[1]: dynamicswap.service: Succeeded. Oct 21 19:02:55 rivo systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Oct 21 19:02:55 rivo systemd[1]: volumio.service: Scheduled restart job, restart counter is at 2. Oct 21 19:02:55 rivo systemd[1]: Started dynamicswap service. Oct 21 19:02:55 rivo systemd[1]: Stopped Volumio Backend Module. Oct 21 19:02:55 rivo systemd[1]: Started Volumio Backend Module. Oct 21 19:02:55 rivo systemd[1]: dynamicswap.service: Succeeded. Oct 21 19:02:57 rivo volumio[6901]: info: ------------------------------------------- Oct 21 19:02:57 rivo volumio[6901]: info: ----- Volumio3 ---- Oct 21 19:02:57 rivo volumio[6901]: info: ------------------------------------------- Oct 21 19:02:57 rivo volumio[6901]: info: ----- System startup ---- Oct 21 19:02:57 rivo volumio[6901]: info: ------------------------------------------- Oct 21 19:02:58 rivo volumio[6901]: info: MYVOLUMIO Environment detected Oct 21 19:02:58 rivo volumio[6901]: info: Plugin folders cleanup Oct 21 19:02:58 rivo volumio[6901]: info: Scanning into folder /volumio/app/plugins/ Oct 21 19:02:58 rivo volumio[6901]: info: Scanning category audio_interface Oct 21 19:02:58 rivo volumio[6901]: info: Scanning category miscellanea Oct 21 19:02:58 rivo volumio[6901]: info: Scanning category music_service Oct 21 19:02:58 rivo volumio[6901]: info: Scanning category plugins.json Oct 21 19:02:58 rivo volumio[6901]: info: Scanning category system_controller Oct 21 19:02:58 rivo volumio[6901]: info: Scanning category user_interface Oct 21 19:02:58 rivo volumio[6901]: info: Scanning into folder /data/plugins/ Oct 21 19:02:58 rivo volumio[6901]: info: Scanning category music_service Oct 21 19:02:58 rivo volumio[6901]: info: Scanning category user_interface Oct 21 19:02:58 rivo volumio[6901]: info: Plugin folders cleanup completed Oct 21 19:02:58 rivo volumio[6901]: info: ------------------------------------------- Oct 21 19:02:58 rivo volumio[6901]: info: ----- Core plugins startup ---- Oct 21 19:02:58 rivo volumio[6901]: info: ------------------------------------------- Oct 21 19:02:58 rivo volumio[6901]: info: Loading plugins from folder /volumio/app/plugins/ Oct 21 19:02:58 rivo volumio[6901]: info: Adding plugin bluetooth to MyMusic Plugins Oct 21 19:02:58 rivo volumio[6901]: info: Adding plugin multiroom to MyMusic Plugins Oct 21 19:02:58 rivo volumio[6901]: info: Adding plugin upnp to MyMusic Plugins Oct 21 19:02:58 rivo volumio[6901]: info: Adding plugin metavolumio to MyMusic Plugins Oct 21 19:02:58 rivo volumio[6901]: info: Adding plugin airplay_emulation to MyMusic Plugins Oct 21 19:02:58 rivo volumio[6901]: info: Adding plugin cd_controller to MyMusic Plugins Oct 21 19:02:58 rivo volumio[6901]: info: Adding plugin raat to MyMusic Plugins Oct 21 19:02:58 rivo volumio[6901]: info: Adding plugin smart_inputs to MyMusic Plugins Oct 21 19:02:58 rivo volumio[6901]: info: Adding plugin tidalconnect to MyMusic Plugins Oct 21 19:02:58 rivo volumio[6901]: info: Adding plugin upnp_browser to MyMusic Plugins Oct 21 19:02:58 rivo volumio[6901]: info: Loading plugins from folder /data/plugins/ Oct 21 19:02:58 rivo volumio[6901]: info: Loading plugin "system"... Oct 21 19:02:58 rivo volumio[6901]: info: Loading plugin "appearance"... Oct 21 19:02:58 rivo volumio-remote-updater[2848]: [2024-10-21 19:02:58] [connect] Successful connection Oct 21 19:02:59 rivo volumio[6901]: info: Loading plugin "network"... Oct 21 19:02:59 rivo volumio[6901]: info: Refreshing Cached IP Addresses Oct 21 19:02:59 rivo volumio[6901]: info: Loading plugin "services"... Oct 21 19:02:59 rivo sudo[6927]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 21 19:02:59 rivo sudo[6927]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 21 19:02:59 rivo volumio[6901]: info: Loading plugin "alsa_controller"... Oct 21 19:02:59 rivo sudo[6929]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 21 19:02:59 rivo sudo[6929]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 21 19:02:59 rivo sudo[6927]: pam_unix(sudo:session): session closed for user root Oct 21 19:02:59 rivo sudo[6929]: pam_unix(sudo:session): session closed for user root Oct 21 19:02:59 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 21 19:02:59 rivo volumio[6901]: info: Loading plugin "wizard"... Oct 21 19:02:59 rivo volumio[6901]: info: Loading plugin "networkfs"... Oct 21 19:02:59 rivo volumio[6901]: info: Starting Udev Watcher for removable devices Oct 21 19:02:59 rivo sudo[6939]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t nfs -o ro,soft,noauto 192.168.2.100:/volume1/music /mnt/NAS/Synology Oct 21 19:02:59 rivo sudo[6939]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 21 19:02:59 rivo sudo[6941]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=TubeDAC,password=spliTT67#,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.2.219/To-share/Lossless /mnt/NAS/Tp-share Oct 21 19:02:59 rivo sudo[6941]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 21 19:02:59 rivo volumio[6901]: info: Mounting Device issd Oct 21 19:02:59 rivo volumio[6901]: /bin/mkdir: cannot create directory ‘/mnt/INTERNAL/’: File exists Oct 21 19:02:59 rivo volumio[6901]: error: Failed to create folder Error: Command failed: /bin/mkdir -m 777 "/mnt/INTERNAL/" Oct 21 19:02:59 rivo volumio[6901]: /bin/mkdir: cannot create directory ‘/mnt/INTERNAL/’: File exists Oct 21 19:02:59 rivo sudo[6953]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/mmcblk1p1 /mnt/INTERNAL/ -o noatime Oct 21 19:02:59 rivo sudo[6953]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 21 19:02:59 rivo mount.exfat[6955]: volume was not unmounted cleanly Oct 21 19:02:59 rivo sudo[6953]: pam_unix(sudo:session): session closed for user root Oct 21 19:02:59 rivo volumio[6901]: WARN: volume was not unmounted cleanly. Oct 21 19:02:59 rivo volumio[6901]: fuse: bad mount point `/mnt/INTERNAL/': Transport endpoint is not connected Oct 21 19:02:59 rivo volumio[6901]: error: Failed to mount issd: Error: Command failed: /usr/bin/sudo /bin/mount "/dev/mmcblk1p1" "/mnt/INTERNAL/" -o noatime Oct 21 19:02:59 rivo volumio[6901]: WARN: volume was not unmounted cleanly. Oct 21 19:02:59 rivo volumio[6901]: fuse: bad mount point `/mnt/INTERNAL/': Transport endpoint is not connected Oct 21 19:03:00 rivo volumio[6901]: info: Ignoring mount for partition: BOOT Oct 21 19:03:00 rivo volumio[6901]: info: Ignoring mount for partition: volumio Oct 21 19:03:00 rivo volumio[6901]: info: Ignoring mount for partition: volumio_data Oct 21 19:03:00 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 21 19:03:00 rivo volumio[6901]: info: Loading plugin "volumio_command_line_client"... Oct 21 19:03:00 rivo volumio[6901]: info: Loading plugin "upnp"... Oct 21 19:03:00 rivo volumio[6901]: info: [1729530180033] Starting Upmpd Daemon Oct 21 19:03:00 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 21 19:03:00 rivo volumio[6901]: info: Loading plugin "my_music"... Oct 21 19:03:00 rivo volumio[6901]: info: Loading plugin "mpd"... Oct 21 19:03:00 rivo volumio[6901]: info: Loading plugin "upnp_browser"... Oct 21 19:03:00 rivo volumio[6901]: info: Loading plugin "bluetooth"... Oct 21 19:03:00 rivo volumio[6901]: info: [1729530180972] Starting BluetoothController Oct 21 19:03:01 rivo volumio[6901]: info: Loading plugin "alarm-clock"... Oct 21 19:03:01 rivo volumio[6901]: info: Loading plugin "manifestui"... Oct 21 19:03:01 rivo volumio[6901]: info: Loading plugin "metavolumio"... Oct 21 19:03:02 rivo volumio[6901]: info: Loading plugin "airplay_emulation"... Oct 21 19:03:02 rivo volumio[6901]: info: Starting Shairport Sync Oct 21 19:03:02 rivo volumio[6901]: info: Plugin cd_controller is not enabled Oct 21 19:03:02 rivo volumio[6901]: info: Loading plugin "last_100"... Oct 21 19:03:02 rivo volumio[6901]: info: Plugin raat is not enabled Oct 21 19:03:02 rivo volumio[6901]: info: Loading plugin "streaming_services"... Oct 21 19:03:03 rivo volumio[6901]: info: Starting Streaming Service Transparent Proxy Oct 21 19:03:03 rivo volumio[6901]: info: Plugin tidalconnect is not enabled Oct 21 19:03:03 rivo volumio[6901]: info: Loading plugin "webradio"... Oct 21 19:03:03 rivo volumio[6901]: info: Loading plugin "i2s_dacs"... Oct 21 19:03:03 rivo volumio[6901]: info: I2S DAC not set, start Auto-detection Oct 21 19:03:03 rivo volumio[6901]: info: Loading plugin "volumiodiscovery"... Oct 21 19:03:03 rivo volumio[6901]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 21 19:03:03 rivo volumio[6901]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 21 19:03:03 rivo node[6901]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 21 19:03:03 rivo volumio[6901]: *** WARNING *** For more information see Oct 21 19:03:03 rivo volumio[6901]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 21 19:03:03 rivo volumio[6901]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 21 19:03:03 rivo volumio[6901]: *** WARNING *** For more information see Oct 21 19:03:03 rivo node[6901]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 21 19:03:03 rivo node[6901]: *** WARNING *** For more information see Oct 21 19:03:03 rivo node[6901]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 21 19:03:03 rivo node[6901]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 21 19:03:03 rivo node[6901]: *** WARNING *** For more information see Oct 21 19:03:03 rivo volumio[6901]: info: Applying required configuration parameters for plugin volumiodiscovery Oct 21 19:03:03 rivo volumio[6901]: info: Discovery: Started advertising with name: Rivo Oct 21 19:03:03 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 21 19:03:03 rivo volumio[6901]: info: Plugin calmradio is not enabled Oct 21 19:03:03 rivo volumio[6901]: info: Plugin multiroom is not enabled Oct 21 19:03:03 rivo volumio[6901]: info: Loading plugin "outputs"... Oct 21 19:03:03 rivo volumio[6901]: info: Loading plugin "albumart"... Oct 21 19:03:03 rivo volumio[6901]: info: Plugin example_plugin is not enabled Oct 21 19:03:03 rivo volumio[6901]: info: Loading plugin "hi_res_audio"... Oct 21 19:03:04 rivo volumio[6901]: Forking 3 albumart workers Oct 21 19:03:05 rivo volumio[6901]: STREAMING PROXY: Starting server on port 3245 Oct 21 19:03:05 rivo volumio[6901]: Node JS runtime: 14 Oct 21 19:03:05 rivo volumio[6901]: info: Applying required configuration parameters for plugin hi_res_audio Oct 21 19:03:05 rivo volumio[6901]: info: Loading plugin "inputs"... Oct 21 19:03:05 rivo volumio[6901]: Starting albumart workers Oct 21 19:03:05 rivo volumio[6901]: Starting albumart workers Oct 21 19:03:05 rivo volumio[6901]: Starting albumart workers Oct 21 19:03:05 rivo kernel: CIFS VFS: Error connecting to socket. Aborting operation. Oct 21 19:03:05 rivo kernel: CIFS VFS: cifs_mount failed w/return code = -113 Oct 21 19:03:05 rivo sudo[6941]: pam_unix(sudo:session): session closed for user root Oct 21 19:03:06 rivo volumio[6901]: info: Loading plugin "qobuz"... Oct 21 19:03:07 rivo volumio[6901]: info: Plugin smart_inputs is not enabled Oct 21 19:03:07 rivo volumio[6901]: info: Loading plugin "tidal"... Oct 21 19:03:08 rivo volumio[6901]: info: Loading plugin "rivocontrol"... Oct 21 19:03:08 rivo volumio[6901]: info: Adding this device properties Oct 21 19:03:08 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: system , setThisDeviceVolumioProperties Oct 21 19:03:08 rivo volumio[6901]: info: Setting Additional Device Volumio Properties: [object Object] Oct 21 19:03:08 rivo volumio[6901]: info: Loading plugin "updater_comm"... Oct 21 19:03:08 rivo volumio[6901]: info: Loading plugin "cec_controller"... Oct 21 19:03:09 rivo volumio[6901]: info: Applying required configuration parameters for plugin cec_controller Oct 21 19:03:09 rivo volumio[6901]: info: Plugin mpdemulation is not enabled Oct 21 19:03:09 rivo volumio[6901]: info: Loading plugin "rest_api"... Oct 21 19:03:09 rivo volumio[6901]: info: Loading plugin "websocket"... Oct 21 19:03:09 rivo volumio[6901]: info: Starting Socket.io Server version 2.3.0 Oct 21 19:03:09 rivo volumio[6901]: info: Plugin 80s80s is not enabled Oct 21 19:03:09 rivo volumio[6901]: info: Plugin motherearthradio is not enabled Oct 21 19:03:09 rivo volumio[6901]: info: Plugin radio_paradise is not enabled Oct 21 19:03:09 rivo volumio[6901]: info: Plugin Systeminfo is not enabled Oct 21 19:03:09 rivo volumio[6901]: info: Loading plugin "lastfm"... Oct 21 19:03:09 rivo volumio[6901]: info: Plugin randomizer is not enabled Oct 21 19:03:09 rivo volumio[6901]: info: Loading i18n strings for locale en Oct 21 19:03:09 rivo volumio[6901]: Updating browse sources language Oct 21 19:03:09 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 21 19:03:09 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 21 19:03:09 rivo volumio[6901]: info: CoreCommandRouter::initPlayerControls Oct 21 19:03:09 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 21 19:03:09 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 21 19:03:09 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 21 19:03:09 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 21 19:03:09 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 21 19:03:09 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 21 19:03:10 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 21 19:03:10 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 21 19:03:10 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 21 19:03:10 rivo volumio[6901]: Express server listening on port 3000 Oct 21 19:03:10 rivo volumio[6901]: [Metrics] WebUI: 13s 225.70ms Oct 21 19:03:10 rivo volumio[6901]: info: CoreStateMachine::resetVolumioState Oct 21 19:03:10 rivo volumio[6901]: info: CoreStateMachine::getcurrentVolume Oct 21 19:03:10 rivo volumio[6901]: info: CoreCommandRouter::volumioRetrievevolume Oct 21 19:03:10 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 21 19:03:10 rivo sudo[7027]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 21 19:03:10 rivo sudo[7027]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 21 19:03:10 rivo sudo[7027]: pam_unix(sudo:session): session closed for user root Oct 21 19:03:10 rivo sudo[7030]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 21 19:03:10 rivo sudo[7030]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 21 19:03:10 rivo volumio[6901]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Oct 21 19:03:10 rivo volumio[6901]: info: Completed loading Core Plugins Oct 21 19:03:10 rivo volumio[6901]: info: Preparing to generate the ALSA configuration file Oct 21 19:03:10 rivo sudo[7030]: pam_unix(sudo:session): session closed for user root Oct 21 19:03:10 rivo volumio[6901]: info: Cannot mount NAS Tp-share at system boot, trial number 1 ,retrying in 5 seconds Oct 21 19:03:10 rivo volumio[6901]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Oct 21 19:03:10 rivo volumio[6901]: verbose: New Socket.io Connection to 192.168.0.2 from 192.168.0.104 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 12_5_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 1 Oct 21 19:03:10 rivo volumio[6901]: verbose: New Socket.io Connection to 192.168.0.2 from 192.168.0.104 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 12_5_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 2 Oct 21 19:03:10 rivo volumio[6901]: verbose: New Socket.io Connection to 192.168.0.2 from 192.168.0.104 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 12_5_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 3 Oct 21 19:03:10 rivo volumio[6901]: verbose: New Socket.io Connection to 192.168.0.2 from 192.168.0.104 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 12_5_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 4 Oct 21 19:03:10 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 21 19:03:10 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 21 19:03:10 rivo volumio[6901]: info: Discovery: Getting this device information Oct 21 19:03:10 rivo volumio[6901]: info: CoreCommandRouter::volumioGetState Oct 21 19:03:10 rivo volumio[6901]: info: CorePlayQueue::getTrack 0 Oct 21 19:03:10 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 21 19:03:10 rivo volumio[6901]: verbose: New Socket.io Connection to 192.168.0.2 from 192.168.0.104 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 12_5_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 5 Oct 21 19:03:10 rivo volumio[6901]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Oct 21 19:03:10 rivo volumio[6901]: info: VolumeController:: Volume=89 Mute =false Oct 21 19:03:10 rivo volumio[6901]: info: CoreStateMachine::pushState Oct 21 19:03:10 rivo volumio[6901]: info: CorePlayQueue::getTrack 0 Oct 21 19:03:10 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 21 19:03:10 rivo volumio[6901]: info: CoreCommandRouter::volumioPushState Oct 21 19:03:10 rivo volumio[6901]: info: CoreStateMachine::updateTrackBlock Oct 21 19:03:10 rivo volumio[6901]: info: CorePlayQueue::getTrackBlock Oct 21 19:03:10 rivo volumio[6901]: info: CoreCommandRouter::volumioRetrievevolume Oct 21 19:03:10 rivo volumio[6901]: info: Reloading queue from file Oct 21 19:03:10 rivo volumio[6901]: info: Asound.conf file unchanged, so no further update is needed Oct 21 19:03:10 rivo volumio[6901]: info: Output device has changed, restarting MPD Oct 21 19:03:10 rivo sudo[7042]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 21 19:03:10 rivo sudo[7042]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 21 19:03:10 rivo volumio[6901]: info: Output device has changed, restarting Shairport Sync Oct 21 19:03:10 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 21 19:03:10 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 21 19:03:10 rivo sudo[7042]: pam_unix(sudo:session): session closed for user root Oct 21 19:03:10 rivo sudo[7045]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 21 19:03:10 rivo sudo[7045]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 21 19:03:10 rivo systemd[1]: Stopping Music Player Daemon... Oct 21 19:03:10 rivo volumio[6901]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 21 19:03:10 rivo volumio[6901]: info: ___________ START PLUGINS ___________ Oct 21 19:03:10 rivo volumio[6901]: info: ControllerMpd::onStart: Initializing MPD Oct 21 19:03:10 rivo volumio[6901]: info: Creating MPD Configuration file Oct 21 19:03:10 rivo systemd[1]: mpd.service: Succeeded. Oct 21 19:03:10 rivo systemd[1]: Stopped Music Player Daemon. Oct 21 19:03:10 rivo systemd[1]: Starting Music Player Daemon... Oct 21 19:03:10 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 21 19:03:10 rivo volumio[6901]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 21 19:03:10 rivo volumio[6901]: info: [1729530190879] CoreMusicLibrary::Adding element Media Servers Oct 21 19:03:10 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 21 19:03:10 rivo sudo[7052]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 21 19:03:10 rivo sudo[7052]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 21 19:03:10 rivo sudo[7052]: pam_unix(sudo:session): session closed for user root Oct 21 19:03:10 rivo sudo[7063]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 21 19:03:10 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 21 19:03:10 rivo sudo[7063]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 21 19:03:10 rivo volumio[6901]: info: Adding METAVOLUMIO REST API Endpoints Oct 21 19:03:10 rivo volumio[6901]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Oct 21 19:03:10 rivo volumio[6901]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio Oct 21 19:03:10 rivo volumio[6901]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio Oct 21 19:03:10 rivo volumio[6901]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio Oct 21 19:03:10 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 21 19:03:10 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 21 19:03:10 rivo systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Oct 21 19:03:10 rivo systemd[1]: mpd.service: Succeeded. Oct 21 19:03:10 rivo systemd[1]: Stopped Music Player Daemon. Oct 21 19:03:10 rivo sudo[7067]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/hciconfig hci0 name Rivo Oct 21 19:03:10 rivo systemd[1]: Starting Music Player Daemon... Oct 21 19:03:10 rivo sudo[7067]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 21 19:03:10 rivo sudo[7067]: pam_unix(sudo:session): session closed for user root Oct 21 19:03:11 rivo volumio[6901]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 21 19:03:11 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 21 19:03:11 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 21 19:03:11 rivo volumio[6901]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 21 19:03:11 rivo volumio[6901]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 21 19:03:11 rivo volumio[6901]: info: [1729530191091] CoreMusicLibrary::Adding element Last_100 Oct 21 19:03:11 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 21 19:03:11 rivo volumio[6901]: info: Streaming services startup Oct 21 19:03:11 rivo volumio[6901]: info: Starting Streaming Daemon Oct 21 19:03:11 rivo sudo[7069]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 21 19:03:11 rivo sudo[7069]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 21 19:03:11 rivo sudo[7078]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Oct 21 19:03:11 rivo sudo[7078]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 21 19:03:11 rivo sudo[7069]: pam_unix(sudo:session): session closed for user root Oct 21 19:03:11 rivo sudo[7078]: pam_unix(sudo:session): session closed for user root Oct 21 19:03:11 rivo volumio[6901]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 21 19:03:11 rivo volumio[6901]: info: [1729530191212] CoreMusicLibrary::Adding element Webradio Oct 21 19:03:11 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 21 19:03:11 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 21 19:03:11 rivo volumio[6901]: info: Initializing BBC Radios Oct 21 19:03:11 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 21 19:03:11 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 21 19:03:11 rivo volumio[6901]: error: Hi Res Audio Failed Login: Missing Login Data Oct 21 19:03:11 rivo volumio[6901]: info: Adding HIGHRESAUDIO REST API Endpoints Oct 21 19:03:11 rivo volumio[6901]: info: Adding getStreamUrlhi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Oct 21 19:03:11 rivo volumio[6901]: info: Initializing Serial Communication on port /dev/ttyS3 Oct 21 19:03:11 rivo volumio[6901]: info: Touch Event Listener Process Starting Oct 21 19:03:11 rivo kernel: meson_uart ffd22000.serial: ttyS3 use xtal(24M) 24000000 change 115200 to 115200 Oct 21 19:03:11 rivo volumio[6901]: info: Refreshing QOBUZ token Oct 21 19:03:11 rivo sudo[7099]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/xinput --test-xi2 --root Oct 21 19:03:11 rivo sudo[7099]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 21 19:03:11 rivo sudo[7099]: pam_unix(sudo:session): session closed for user root Oct 21 19:03:11 rivo sudo[7102]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x25 0x0 Oct 21 19:03:11 rivo sudo[7102]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 21 19:03:11 rivo sudo[7102]: pam_unix(sudo:session): session closed for user root Oct 21 19:03:11 rivo sudo[7105]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x28 0x0 Oct 21 19:03:11 rivo sudo[7105]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 21 19:03:11 rivo sudo[7105]: pam_unix(sudo:session): session closed for user root Oct 21 19:03:11 rivo sudo[7108]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x29 0x1 Oct 21 19:03:11 rivo sudo[7108]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 21 19:03:11 rivo sudo[7108]: pam_unix(sudo:session): session closed for user root Oct 21 19:03:11 rivo sudo[7111]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x33 0x1 Oct 21 19:03:11 rivo sudo[7111]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 21 19:03:11 rivo sudo[7111]: pam_unix(sudo:session): session closed for user root Oct 21 19:03:11 rivo volumio[6901]: info: Apply VIM3L Onboard LEDs Settings Oct 21 19:03:11 rivo volumio[6901]: info: Turning On Onboard LEDs Oct 21 19:03:11 rivo sudo[7115]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/tee /sys/class/leds/sys_led/trigger Oct 21 19:03:11 rivo sudo[7115]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 21 19:03:11 rivo volumio[6901]: info: Starting CEC Event listener Oct 21 19:03:11 rivo sudo[7115]: pam_unix(sudo:session): session closed for user root Oct 21 19:03:11 rivo volumio[6901]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 21 19:03:11 rivo volumio[6901]: info: [1729530191663] CoreMusicLibrary::Adding element LastFM Oct 21 19:03:11 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 21 19:03:11 rivo volumio[6901]: Cannot find translation for source LastFM Oct 21 19:03:11 rivo volumio[6901]: info: [LastFM] scrobbler initiated! Oct 21 19:03:11 rivo volumio[6901]: info: [LastFM] extended logging: false Oct 21 19:03:11 rivo volumio[6901]: info: [LastFM] try scrobble stream/radio plays: true Oct 21 19:03:11 rivo volumio[6901]: info: [LastFM] Left init routine Oct 21 19:03:11 rivo volumio[6901]: info: [LastFM] Socket already connected: true Oct 21 19:03:11 rivo volumio[6901]: info: Volumio Calling Home Oct 21 19:03:11 rivo sudo[7119]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/tee /sys/class/leds/red_red/trigger Oct 21 19:03:11 rivo sudo[7119]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 21 19:03:11 rivo sudo[7119]: pam_unix(sudo:session): session closed for user root Oct 21 19:03:11 rivo volumio[6901]: info: Stopping AccessToken refresher cron Oct 21 19:03:11 rivo volumio[6901]: info: AccessToken refresher cron started Oct 21 19:03:11 rivo volumio[6901]: info: Adding TIDAL REST API Endpoints Oct 21 19:03:11 rivo volumio[6901]: info: Adding getStreamUrltidal REST Endpoint for plugin: music_service/tidal Oct 21 19:03:11 rivo volumio[6901]: info: CoreStateMachine::setRepeat false single undefined Oct 21 19:03:11 rivo volumio[6901]: info: CoreStateMachine::pushState Oct 21 19:03:11 rivo volumio[6901]: info: CorePlayQueue::getTrack 0 Oct 21 19:03:11 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 21 19:03:11 rivo volumio[6901]: info: CoreCommandRouter::volumioPushState Oct 21 19:03:11 rivo volumio[6901]: info: CoreStateMachine::setRandom true Oct 21 19:03:11 rivo volumio[6901]: info: CoreStateMachine::pushState Oct 21 19:03:11 rivo volumio[6901]: info: CorePlayQueue::getTrack 0 Oct 21 19:03:11 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 21 19:03:11 rivo volumio[6901]: info: CoreCommandRouter::volumioPushState Oct 21 19:03:12 rivo volumio[6901]: verbose: New Socket.io Connection to 192.168.0.2:3000 from 192.168.0.104 UA: Dart/3.4 (dart:io) Engine version: 3 Transport: websocket Total Clients: 7 Oct 21 19:03:12 rivo volumio[6901]: info: Serial port opened successfully Oct 21 19:03:12 rivo volumio[6901]: info: Sending serial start messages Oct 21 19:03:12 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 21 19:03:12 rivo volumio[6901]: info: MP1 GPIO: Signalled system ready via GPIO Oct 21 19:03:12 rivo volumio[6901]: info: Touch Event Listener Process Closed Oct 21 19:03:12 rivo volumio[6901]: error: Cannot start Volumio Streaming Daemon Oct 21 19:03:12 rivo volumio[6901]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Oct 21 19:03:12 rivo volumio[6901]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Oct 21 19:03:12 rivo volumio[6901]: info: Bluetooth name changed to Rivo Oct 21 19:03:12 rivo volumio[6901]: info: MPD Permissions set Oct 21 19:03:12 rivo volumio[6901]: info: MPD Permissions set Oct 21 19:03:12 rivo volumio[6901]: info: VolumeController:: Volume=89 Mute =false Oct 21 19:03:12 rivo volumio[6901]: info: CoreStateMachine::pushState Oct 21 19:03:12 rivo volumio[6901]: info: CorePlayQueue::getTrack 0 Oct 21 19:03:12 rivo volumio[6901]: info: CoreCommandRouter::volumioPushState Oct 21 19:03:12 rivo sudo[7128]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Oct 21 19:03:12 rivo sudo[7128]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 21 19:03:12 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setDeviceVolumeOverride Oct 21 19:03:12 rivo volumio[6901]: info: Setting Device Volume Override Oct 21 19:03:12 rivo sudo[7128]: pam_unix(sudo:session): session closed for user root Oct 21 19:03:12 rivo volumio[6901]: info: CoreCommandRouter::volumioUpdateVolumeSettings Oct 21 19:03:12 rivo volumio[6901]: info: Updating Volume Controller Parameters: Device: 5 Name: xCORE USB Audio 2.0 Mixer: xCORE USB Audio 2.0 Output Max Vol: 90 Vol Curve; logarithmic Vol Steps: 5 Oct 21 19:03:12 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Oct 21 19:03:12 rivo volumio[6901]: info: Disabling external Volume Control Oct 21 19:03:12 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 21 19:03:12 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 21 19:03:12 rivo volumio[6901]: info: CoreStateMachine::pushState Oct 21 19:03:12 rivo volumio[6901]: info: CorePlayQueue::getTrack 0 Oct 21 19:03:12 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 21 19:03:12 rivo volumio[6901]: info: CoreCommandRouter::volumioPushState Oct 21 19:03:12 rivo volumio[6901]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Oct 21 19:03:12 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 21 19:03:12 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 21 19:03:12 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 21 19:03:12 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 21 19:03:12 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 21 19:03:12 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 21 19:03:12 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 21 19:03:12 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 21 19:03:12 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 21 19:03:12 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 21 19:03:12 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 21 19:03:12 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 21 19:03:12 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 21 19:03:12 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 21 19:03:12 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 21 19:03:12 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 21 19:03:12 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 21 19:03:12 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 21 19:03:12 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 21 19:03:12 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 21 19:03:12 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 21 19:03:12 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 21 19:03:12 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: system , setAdditionalSVInfo Oct 21 19:03:12 rivo volumio[6901]: info: Setting Additional System Software info: Hardware Revision: 2.0 Oct 21 19:03:12 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: system , setHwFwVersion Oct 21 19:03:12 rivo volumio[6901]: info: Setting HW Firmware info: undefined Oct 21 19:03:12 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: system , setHwVersion Oct 21 19:03:12 rivo volumio[6901]: info: Setting HW Version info: 2.0 Oct 21 19:03:12 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: system , setAdditionalSVInfo Oct 21 19:03:12 rivo volumio[6901]: info: Setting Additional System Software info: Hardware Revision: 2.0, Firmware Version: 0.3.3 Oct 21 19:03:12 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: system , setHwFwVersion Oct 21 19:03:12 rivo volumio[6901]: info: Setting HW Firmware info: 0.3.3 Oct 21 19:03:12 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: system , setHwVersion Oct 21 19:03:12 rivo volumio[6901]: info: Setting HW Version info: 2.0 Oct 21 19:03:12 rivo volumio[6901]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Oct 21 19:03:12 rivo volumio[6901]: info: MCU Signalled Headphone Mode Disabled Oct 21 19:03:12 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: raat , reportHeadphoneState Oct 21 19:03:12 rivo volumio[6901]: info: MCU Signalled Sleep Mode Disabled Oct 21 19:03:12 rivo volumio[6901]: info: Enabling Advanced system settings configuration Oct 21 19:03:12 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: system , addAdditionalUISections Oct 21 19:03:12 rivo volumio[6901]: info: Additional UI Settings Added for plugin music_service/inputs Oct 21 19:03:12 rivo volumio[6901]: info: MCU Signalled Auto Boot Mode On Power Active Oct 21 19:03:12 rivo volumio[6901]: error: Serial API: Failed to decode command: MAXVOL, message: 90 Oct 21 19:03:12 rivo volumio[6901]: info: CoreStateMachine::pushState Oct 21 19:03:12 rivo volumio[6901]: info: CorePlayQueue::getTrack 0 Oct 21 19:03:12 rivo volumio[6901]: info: CoreCommandRouter::volumioPushState Oct 21 19:03:12 rivo sudo[7149]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/xset dpms force on Oct 21 19:03:12 rivo sudo[7149]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 21 19:03:12 rivo sudo[7149]: pam_unix(sudo:session): session closed for user root Oct 21 19:03:12 rivo volumio[6901]: info: Upmpdcli Daemon Started Oct 21 19:03:12 rivo volumio[6901]: info: VolumeController:: Volume=89 Mute =false Oct 21 19:03:12 rivo volumio[6901]: info: CoreStateMachine::pushState Oct 21 19:03:12 rivo volumio[6901]: info: CorePlayQueue::getTrack 0 Oct 21 19:03:12 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 21 19:03:12 rivo volumio[6901]: info: CoreCommandRouter::volumioPushState Oct 21 19:03:12 rivo sudo[7153]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/xset dpms 0 0 0 Oct 21 19:03:12 rivo volumio[6901]: info: Starting Shairport Sync Oct 21 19:03:12 rivo sudo[7153]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 21 19:03:12 rivo sudo[7153]: pam_unix(sudo:session): session closed for user root Oct 21 19:03:12 rivo volumio[6901]: info: Starting Shairport Sync Oct 21 19:03:13 rivo sudo[7156]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 21 19:03:13 rivo sudo[7156]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 21 19:03:13 rivo volumio[6901]: info: Starting Shairport Sync Oct 21 19:03:13 rivo sudo[7159]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 21 19:03:13 rivo sudo[7159]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 21 19:03:13 rivo volumio[6901]: info: Adding Inputs via Serial API Oct 21 19:03:13 rivo volumio[6901]: verbose: New Socket.io Connection to 192.168.0.2 from 192.168.0.104 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 12_5_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 9 Oct 21 19:03:13 rivo sudo[7161]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 21 19:03:13 rivo sudo[7161]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 21 19:03:13 rivo systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 21 19:03:13 rivo volumio[6901]: info: CoreStateMachine::pushState Oct 21 19:03:13 rivo volumio[6901]: info: CorePlayQueue::getTrack 0 Oct 21 19:03:13 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 21 19:03:13 rivo volumio[6901]: info: CoreCommandRouter::volumioPushState Oct 21 19:03:13 rivo systemd[1]: shairport-sync.service: Succeeded. Oct 21 19:03:13 rivo systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 21 19:03:13 rivo volumio[6901]: info: CoreCommandRouter::servicePushState Oct 21 19:03:13 rivo volumio[6901]: info: CorePlayQueue::getTrack 0 Oct 21 19:03:13 rivo volumio[6901]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current qobuz Received inputs Oct 21 19:03:13 rivo volumio[6901]: info: CoreCommandRouter::volumiosetSourceActiveno-source Oct 21 19:03:13 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 21 19:03:13 rivo volumio[6901]: Cannot find translation for source LastFM Oct 21 19:03:13 rivo systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 21 19:03:13 rivo sudo[7156]: pam_unix(sudo:session): session closed for user root Oct 21 19:03:13 rivo volumio[6901]: info: Shairport-Sync Started Oct 21 19:03:13 rivo volumio[6901]: Error adding Membership: Error: addMembership EINVAL Oct 21 19:03:13 rivo sudo[7159]: pam_unix(sudo:session): session closed for user root Oct 21 19:03:13 rivo systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 21 19:03:13 rivo volumio[6901]: info: Shairport-Sync Started Oct 21 19:03:13 rivo systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Oct 21 19:03:13 rivo systemd[1]: shairport-sync.service: Succeeded. Oct 21 19:03:13 rivo systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 21 19:03:13 rivo systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 21 19:03:13 rivo sudo[7161]: pam_unix(sudo:session): session closed for user root Oct 21 19:03:13 rivo volumio[6901]: info: Shairport-Sync Started Oct 21 19:03:13 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 21 19:03:13 rivo volumio[6901]: info: CoreCommandRouter::volumioGetVisibleSources Oct 21 19:03:13 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 21 19:03:13 rivo volumio[6901]: info: CoreCommandRouter::volumioGetState Oct 21 19:03:13 rivo volumio[6901]: info: CorePlayQueue::getTrack 0 Oct 21 19:03:13 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 21 19:03:13 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 21 19:03:13 rivo mpd[7085]: Oct 21 19:03 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Oct 21 19:03:13 rivo volumio[6901]: info: Received Get System Info Oct 21 19:03:13 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 21 19:03:13 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 21 19:03:13 rivo volumio[6901]: info: Discovery: Getting this device information Oct 21 19:03:13 rivo volumio[6901]: info: CoreCommandRouter::volumioGetState Oct 21 19:03:13 rivo volumio[6901]: info: CorePlayQueue::getTrack 0 Oct 21 19:03:13 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 21 19:03:13 rivo volumio[6901]: info: CoreCommandRouter::volumioGetState Oct 21 19:03:13 rivo volumio[6901]: info: CorePlayQueue::getTrack 0 Oct 21 19:03:13 rivo volumio[6901]: info: Listing playlists Oct 21 19:03:13 rivo volumio[6901]: info: CoreCommandRouter::volumioGetQueue Oct 21 19:03:13 rivo volumio[6901]: info: CoreStateMachine::getQueue Oct 21 19:03:13 rivo volumio[6901]: info: CorePlayQueue::getQueue Oct 21 19:03:13 rivo volumio-remote-updater[2848]: [2024-10-21 19:03:13] [connect] Successful connection Oct 21 19:03:13 rivo systemd[1]: Started Music Player Daemon. Oct 21 19:03:13 rivo volumio-remote-updater[2848]: [2024-10-21 19:03:13] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1729530193 101 Oct 21 19:03:13 rivo sudo[7063]: pam_unix(sudo:session): session closed for user root Oct 21 19:03:13 rivo volumio[6901]: 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: 10 Oct 21 19:03:13 rivo sudo[7045]: pam_unix(sudo:session): session closed for user root Oct 21 19:03:13 rivo volumio[6901]: error: MPD error: The expression evaluated to a falsy value: Oct 21 19:03:13 rivo volumio[6901]: assert.ok(self.idling) Oct 21 19:03:13 rivo volumio[6901]: error: The expression evaluated to a falsy value: Oct 21 19:03:13 rivo volumio[6901]: assert.ok(self.idling) Oct 21 19:03:13 rivo volumio[6901]: info: MPD running with PID7085 Oct 21 19:03:13 rivo volumio[6901]: ,establishing connection Oct 21 19:03:13 rivo volumio[6901]: error: updateQueue error: null Oct 21 19:03:13 rivo volumio[6901]: error: updateQueue error: null Oct 21 19:03:13 rivo sudo[7174]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service Oct 21 19:03:13 rivo sudo[7174]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 21 19:03:14 rivo sudo[7174]: pam_unix(sudo:session): session closed for user root Oct 21 19:03:14 rivo volumio[6901]: info: Volumio BT Module successfully started Oct 21 19:03:14 rivo volumio[6901]: info: Turning Off Onboard LEDs Oct 21 19:03:14 rivo sudo[7178]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/tee /sys/class/leds/sys_led/trigger Oct 21 19:03:14 rivo sudo[7178]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 21 19:03:14 rivo sudo[7178]: pam_unix(sudo:session): session closed for user root Oct 21 19:03:14 rivo sudo[7181]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/tee /sys/class/leds/red_red/trigger Oct 21 19:03:14 rivo sudo[7181]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 21 19:03:14 rivo sudo[7181]: pam_unix(sudo:session): session closed for user root Oct 21 19:03:14 rivo volumio[6901]: info: Onboard LEDs initialized Oct 21 19:03:14 rivo volumio[6901]: info: CoreCommandRouter::volumioGetState Oct 21 19:03:14 rivo volumio[6901]: info: CorePlayQueue::getTrack 0 Oct 21 19:03:14 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 21 19:03:14 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 21 19:03:15 rivo sudo[7185]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=TubeDAC,password=spliTT67#,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.2.219/To-share/Lossless /mnt/NAS/Tp-share Oct 21 19:03:15 rivo sudo[7185]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 21 19:03:19 rivo volumio[6901]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Oct 21 19:03:19 rivo kernel: CIFS VFS: Error connecting to socket. Aborting operation. Oct 21 19:03:19 rivo kernel: CIFS VFS: cifs_mount failed w/return code = -113 Oct 21 19:03:19 rivo sudo[7185]: pam_unix(sudo:session): session closed for user root Oct 21 19:03:19 rivo volumio[6901]: info: Cannot mount NAS Tp-share at system boot, trial number 2 ,retrying in 5 seconds Oct 21 19:03:21 rivo volumio[6901]: info: Checking for updated MCU Firmware Oct 21 19:03:21 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 21 19:03:21 rivo volumio[6901]: info: Firware on device is on latest version, no need to update Oct 21 19:03:24 rivo sudo[7190]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=TubeDAC,password=spliTT67#,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.2.219/To-share/Lossless /mnt/NAS/Tp-share Oct 21 19:03:24 rivo sudo[7190]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 21 19:03:30 rivo sudo[7190]: pam_unix(sudo:session): session closed for user root Oct 21 19:03:30 rivo kernel: CIFS VFS: Error connecting to socket. Aborting operation. Oct 21 19:03:30 rivo kernel: CIFS VFS: cifs_mount failed w/return code = -113 Oct 21 19:03:30 rivo volumio[6901]: info: Cannot mount NAS Tp-share at system boot, trial number 3 ,retrying in 5 seconds Oct 21 19:03:35 rivo sudo[7197]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=TubeDAC,password=spliTT67#,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.2.219/To-share/Lossless /mnt/NAS/Tp-share Oct 21 19:03:35 rivo sudo[7197]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 21 19:03:39 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 21 19:03:39 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 21 19:03:39 rivo volumio[6901]: info: Discovery: Getting this device information Oct 21 19:03:39 rivo volumio[6901]: info: CoreCommandRouter::volumioGetState Oct 21 19:03:39 rivo volumio[6901]: info: CorePlayQueue::getTrack 0 Oct 21 19:03:39 rivo volumio[6901]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 21 19:03:39 rivo volumio[6901]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 21 19:03:39 rivo volumio[6901]: Error: getaddrinfo ENOTFOUND ws.audioscrobbler.com Oct 21 19:03:39 rivo volumio[6901]: at GetAddrInfoReqWrap.onlookup [as oncomplete] (dns.js:71:26) { Oct 21 19:03:39 rivo volumio[6901]: errno: -3007, Oct 21 19:03:39 rivo volumio[6901]: code: 'ENOTFOUND', Oct 21 19:03:39 rivo volumio[6901]: syscall: 'getaddrinfo', Oct 21 19:03:39 rivo volumio[6901]: hostname: 'ws.audioscrobbler.com' Oct 21 19:03:39 rivo volumio[6901]: } Oct 21 19:03:39 rivo volumio[6901]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 21 19:03:39 rivo sudo[7197]: pam_unix(sudo:session): session closed for user root Oct 21 19:03:39 rivo kernel: CIFS VFS: Error connecting to socket. Aborting operation. Oct 21 19:03:39 rivo kernel: CIFS VFS: cifs_mount failed w/return code = -113 Oct 21 19:03:40 rivo sudo[7250]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-21 19:02 Oct 21 19:03:40 rivo sudo[7250]: 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"