-- Logs begin at Sat 2025-04-19 18:11:43 IST, end at Sun 2025-04-20 11:33:18 IST. --
Apr 20 11:32:05 volumio systemd[1]: systemd-timedated.service: Succeeded.
Apr 20 11:32:14 volumio volumio[1153]: ............................................................................++++
Apr 20 11:32:17 volumio volumio[1153]: ..........++++
Apr 20 11:32:17 volumio volumio[1153]: e is 65537 (0x010001)
Apr 20 11:32:17 volumio volumio[1153]: writing RSA key
Apr 20 11:32:19 volumio volumio[875]: error: Plugin system_controller networkfs failed to complete 'onVolumioStart' in a timely fashion
Apr 20 11:32:19 volumio volumio[875]: info: Preparing to generate the ALSA configuration file
Apr 20 11:32:19 volumio volumio[875]: info: Asound.conf file unchanged, so no further update is needed
Apr 20 11:32:19 volumio volumio[875]: info: Output device has changed, restarting MPD
Apr 20 11:32:19 volumio volumio[875]: info: Output device has changed, restarting Shairport Sync
Apr 20 11:32:19 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 20 11:32:19 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 20 11:32:19 volumio sudo[1256]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Apr 20 11:32:19 volumio sudo[1256]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 20 11:32:19 volumio sudo[1256]: pam_unix(sudo:session): session closed for user root
Apr 20 11:32:19 volumio sudo[1258]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Apr 20 11:32:19 volumio sudo[1258]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 20 11:32:19 volumio systemd[1]: Stopping Music Player Daemon...
Apr 20 11:32:19 volumio volumio[875]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Apr 20 11:32:19 volumio volumio[875]: info: ___________ START PLUGINS ___________
Apr 20 11:32:19 volumio volumio[875]: info: ControllerMpd::onStart: Initializing MPD
Apr 20 11:32:19 volumio volumio[875]: info: Creating MPD Configuration file
Apr 20 11:32:19 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 20 11:32:19 volumio volumio[875]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 20 11:32:19 volumio volumio[875]: info: [1745128939529] CoreMusicLibrary::Adding element Media Servers
Apr 20 11:32:19 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 20 11:32:19 volumio sudo[1265]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Apr 20 11:32:19 volumio sudo[1265]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 20 11:32:19 volumio sudo[1267]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Apr 20 11:32:19 volumio sudo[1267]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 20 11:32:19 volumio sudo[1265]: pam_unix(sudo:session): session closed for user root
Apr 20 11:32:19 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 20 11:32:19 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 20 11:32:19 volumio systemd[1]: mpd.service: Succeeded.
Apr 20 11:32:19 volumio systemd[1]: Stopped Music Player Daemon.
Apr 20 11:32:19 volumio volumio[875]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Apr 20 11:32:19 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 20 11:32:19 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 20 11:32:19 volumio systemd[1]: Starting Music Player Daemon...
Apr 20 11:32:19 volumio volumio[875]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Apr 20 11:32:19 volumio volumio[875]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 20 11:32:19 volumio volumio[875]: info: [1745128939796] CoreMusicLibrary::Adding element Last_100
Apr 20 11:32:19 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 20 11:32:19 volumio volumio[875]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 20 11:32:19 volumio volumio[875]: info: [1745128939804] CoreMusicLibrary::Adding element Webradio
Apr 20 11:32:19 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 20 11:32:19 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 20 11:32:19 volumio volumio[875]: info: Initializing BBC Radios
Apr 20 11:32:19 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 20 11:32:19 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 20 11:32:19 volumio volumio[875]: info: Volumio Calling Home
Apr 20 11:32:19 volumio sudo[1273]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Apr 20 11:32:19 volumio sudo[1273]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 20 11:32:19 volumio sudo[1273]: pam_unix(sudo:session): session closed for user root
Apr 20 11:32:20 volumio ntpd[620]: Soliciting pool server 192.46.211.253
Apr 20 11:32:20 volumio volumio[875]: info: MPD Permissions set
Apr 20 11:32:20 volumio volumio[875]: info: MPD Permissions set
Apr 20 11:32:20 volumio volumio[875]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2
Apr 20 11:32:20 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 20 11:32:20 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 20 11:32:20 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 20 11:32:20 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 20 11:32:20 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 20 11:32:20 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 20 11:32:20 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 20 11:32:20 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 20 11:32:20 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 20 11:32:20 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 20 11:32:20 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 20 11:32:20 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 20 11:32:20 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 20 11:32:20 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 20 11:32:20 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 20 11:32:20 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 20 11:32:20 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 20 11:32:20 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 20 11:32:20 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 20 11:32:20 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 20 11:32:20 volumio volumio[875]: info: Starting Shairport Sync
Apr 20 11:32:20 volumio volumio[875]: info: Starting Shairport Sync
Apr 20 11:32:20 volumio volumio[875]: info: Starting Shairport Sync
Apr 20 11:32:20 volumio sudo[1303]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Apr 20 11:32:20 volumio sudo[1303]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 20 11:32:20 volumio sudo[1305]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Apr 20 11:32:21 volumio sudo[1305]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 20 11:32:21 volumio volumio[875]: info: CoreCommandRouter::volumioGetState
Apr 20 11:32:21 volumio volumio[875]: info: CorePlayQueue::getTrack 0
Apr 20 11:32:21 volumio sudo[1308]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Apr 20 11:32:21 volumio sudo[1308]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 20 11:32:21 volumio ntpd[620]: Soliciting pool server 172.105.60.167
Apr 20 11:32:21 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Apr 20 11:32:21 volumio systemd[1]: shairport-sync.service: Succeeded.
Apr 20 11:32:21 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Apr 20 11:32:21 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Apr 20 11:32:21 volumio sudo[1303]: pam_unix(sudo:session): session closed for user root
Apr 20 11:32:21 volumio volumio[875]: info: Shairport-Sync Started
Apr 20 11:32:21 volumio volumio[875]: Error adding Membership: Error: addMembership EINVAL
Apr 20 11:32:21 volumio shairport-sync[1311]: free(): double free detected in tcache 2
Apr 20 11:32:21 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Apr 20 11:32:21 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=6/ABRT
Apr 20 11:32:21 volumio systemd[1]: shairport-sync.service: Failed with result 'signal'.
Apr 20 11:32:21 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Apr 20 11:32:21 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Apr 20 11:32:21 volumio sudo[1305]: pam_unix(sudo:session): session closed for user root
Apr 20 11:32:21 volumio volumio[875]: info: Shairport-Sync Started
Apr 20 11:32:21 volumio sudo[1308]: pam_unix(sudo:session): session closed for user root
Apr 20 11:32:21 volumio volumio[875]: info: Shairport-Sync Started
Apr 20 11:32:22 volumio ntpd[620]: Soliciting pool server 95.216.192.15
Apr 20 11:32:22 volumio mpd[1290]: Apr 20 11:32 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Apr 20 11:32:22 volumio systemd[1]: Started Music Player Daemon.
Apr 20 11:32:22 volumio sudo[1267]: pam_unix(sudo:session): session closed for user root
Apr 20 11:32:22 volumio sudo[1258]: pam_unix(sudo:session): session closed for user root
Apr 20 11:32:22 volumio volumio[875]: info: Completed starting Core Plugins
Apr 20 11:32:22 volumio volumio[875]: info: -------------------------------------------
Apr 20 11:32:22 volumio volumio[875]: info: ----- MyVolumio plugins startup ----
Apr 20 11:32:22 volumio volumio[875]: info: -------------------------------------------
Apr 20 11:32:22 volumio volumio[875]: info: [MyVolumio PluginManager] Fetching plans data....
Apr 20 11:32:22 volumio volumio[875]: error: MPD error: The expression evaluated to a falsy value:
Apr 20 11:32:22 volumio volumio[875]: assert.ok(self.idling)
Apr 20 11:32:22 volumio volumio[875]: error: The expression evaluated to a falsy value:
Apr 20 11:32:22 volumio volumio[875]: assert.ok(self.idling)
Apr 20 11:32:22 volumio volumio[875]: info: MPD running with PID1290
Apr 20 11:32:22 volumio volumio[875]: ,establishing connection
Apr 20 11:32:22 volumio volumio[875]: error: updateQueue error: null
Apr 20 11:32:22 volumio volumio[875]: error: updateQueue error: null
Apr 20 11:32:23 volumio ntpd[620]: Soliciting pool server 17.253.18.99
Apr 20 11:32:23 volumio ntpd[620]: Soliciting pool server 139.59.55.93
Apr 20 11:32:24 volumio ntpd[620]: Soliciting pool server 40.81.94.65
Apr 20 11:32:24 volumio ntpd[620]: Soliciting pool server 192.46.215.60
Apr 20 11:32:25 volumio ntpd[620]: Soliciting pool server 139.59.15.185
Apr 20 11:32:25 volumio ntpd[620]: Soliciting pool server 65.0.119.56
Apr 20 11:32:25 volumio volumio[875]: info: Volumio called home
Apr 20 11:32:25 volumio ntpd[620]: Soliciting pool server 162.159.200.123
Apr 20 11:32:26 volumio ntpd[620]: Soliciting pool server 162.159.200.1
Apr 20 11:32:26 volumio ntpd[620]: Soliciting pool server 15.207.248.194
Apr 20 11:32:26 volumio ntpd[620]: Soliciting pool server 14.139.60.106
Apr 20 11:32:27 volumio ntpd[620]: Soliciting pool server 3.6.43.90
Apr 20 11:32:27 volumio ntpd[620]: Soliciting pool server 2001:1600:4:1::f
Apr 20 11:32:28 volumio ntpd[620]: receive: Unexpected origin timestamp 0xebaf0c73.02e966c0 does not match aorg 0000000000.00000000 from server@40.81.94.65 xmt 0xebaf0c74.9f70d123
Apr 20 11:32:28 volumio ntpd[620]: Soliciting pool server 160.250.111.68
Apr 20 11:32:29 volumio volumio[875]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory
Apr 20 11:32:29 volumio ntpd[620]: Soliciting pool server 95.216.144.226
Apr 20 11:32:29 volumio ntpd[620]: Soliciting pool server 95.216.144.226
Apr 20 11:32:33 volumio volumio[875]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium
Apr 20 11:32:33 volumio volumio[875]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium
Apr 20 11:32:33 volumio volumio[875]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium
Apr 20 11:32:33 volumio volumio[875]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium
Apr 20 11:32:33 volumio volumio[875]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium
Apr 20 11:32:33 volumio volumio[875]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium
Apr 20 11:32:33 volumio volumio[875]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium
Apr 20 11:32:33 volumio volumio[875]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium
Apr 20 11:32:33 volumio volumio[875]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium
Apr 20 11:32:33 volumio volumio[875]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium
Apr 20 11:32:33 volumio volumio[875]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar
Apr 20 11:32:33 volumio volumio[875]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar
Apr 20 11:32:33 volumio volumio[875]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar
Apr 20 11:32:33 volumio volumio[875]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar
Apr 20 11:32:33 volumio volumio[875]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar
Apr 20 11:32:33 volumio volumio[875]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar
Apr 20 11:32:33 volumio volumio[875]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar
Apr 20 11:32:33 volumio volumio[875]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar
Apr 20 11:32:33 volumio volumio[875]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar
Apr 20 11:32:33 volumio volumio[875]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar
Apr 20 11:32:33 volumio volumio[875]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso
Apr 20 11:32:33 volumio volumio[875]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso
Apr 20 11:32:33 volumio volumio[875]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso
Apr 20 11:32:33 volumio volumio[875]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso
Apr 20 11:32:33 volumio volumio[875]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso
Apr 20 11:32:33 volumio volumio[875]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso
Apr 20 11:32:33 volumio volumio[875]: info: Adding plugin bluetooth to MyMusic Plugins
Apr 20 11:32:33 volumio volumio[875]: info: Adding plugin multiroom to MyMusic Plugins
Apr 20 11:32:33 volumio volumio[875]: info: Adding plugin metavolumio to MyMusic Plugins
Apr 20 11:32:33 volumio volumio[875]: info: Adding plugin cd_controller to MyMusic Plugins
Apr 20 11:32:33 volumio volumio[875]: info: Adding plugin smart_inputs to MyMusic Plugins
Apr 20 11:32:33 volumio volumio[875]: info: Adding plugin tidalconnect to MyMusic Plugins
Apr 20 11:32:33 volumio volumio[875]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"...
Apr 20 11:32:35 volumio volumio[875]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded
Apr 20 11:32:35 volumio volumio[875]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio
Apr 20 11:32:35 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 20 11:32:35 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 20 11:32:35 volumio volumio[875]: info: Starting MyVolumio Remote Streaming Endpoints
Apr 20 11:32:35 volumio volumio[875]: info: MyVolumio not started
Apr 20 11:32:35 volumio volumio[875]: info: Initializing device activation check
Apr 20 11:32:36 volumio volumio[875]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started
Apr 20 11:32:36 volumio volumio[875]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"...
Apr 20 11:32:38 volumio volumio[875]: info: Starting Streaming Service Transparent Proxy
Apr 20 11:32:38 volumio volumio[875]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded
Apr 20 11:32:38 volumio volumio[875]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services
Apr 20 11:32:38 volumio volumio[875]: info: Streaming services startup
Apr 20 11:32:38 volumio volumio[875]: info: Starting Streaming Daemon
Apr 20 11:32:38 volumio sudo[1358]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Apr 20 11:32:38 volumio sudo[1358]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 20 11:32:38 volumio volumio[875]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started
Apr 20 11:32:38 volumio sudo[1358]: pam_unix(sudo:session): session closed for user root
Apr 20 11:32:39 volumio volumio[875]: error: Cannot start Volumio Streaming Daemon
Apr 20 11:32:39 volumio volumio[875]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
Apr 20 11:32:39 volumio volumio[875]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
Apr 20 11:32:41 volumio volumio[875]: STREAMING PROXY: Starting server on port 3245
Apr 20 11:32:41 volumio volumio[875]: Node JS runtime: 14
Apr 20 11:32:49 volumio sudo[1383]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Apr 20 11:32:49 volumio sudo[1383]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 20 11:32:49 volumio sudo[1383]: pam_unix(sudo:session): session closed for user root
Apr 20 11:32:49 volumio sudo[1385]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 20 11:32:49 volumio sudo[1385]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 20 11:32:49 volumio sudo[1385]: pam_unix(sudo:session): session closed for user root
Apr 20 11:32:49 volumio volumio[875]: verbose: New Socket.io Connection to 192.168.1.11 from 192.168.1.4 UA: Mozilla/5.0 (X11; Linux x86_64; rv:137.0) Gecko/20100101 Firefox/137.0 Engine version: 3 Transport: polling Total Clients: 3
Apr 20 11:32:49 volumio sudo[1389]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Apr 20 11:32:49 volumio sudo[1389]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 20 11:32:49 volumio sudo[1389]: pam_unix(sudo:session): session closed for user root
Apr 20 11:32:49 volumio sudo[1391]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 20 11:32:49 volumio sudo[1391]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 20 11:32:49 volumio sudo[1391]: pam_unix(sudo:session): session closed for user root
Apr 20 11:32:49 volumio volumio[875]: verbose: New Socket.io Connection to 192.168.1.11 from 192.168.1.4 UA: Mozilla/5.0 (X11; Linux x86_64; rv:137.0) Gecko/20100101 Firefox/137.0 Engine version: 3 Transport: polling Total Clients: 4
Apr 20 11:32:49 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Apr 20 11:32:50 volumio volumio[875]: info: CoreCommandRouter::volumioGetVisibleSources
Apr 20 11:32:50 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 20 11:32:50 volumio volumio[875]: info: CoreCommandRouter::volumioGetState
Apr 20 11:32:50 volumio volumio[875]: info: CorePlayQueue::getTrack 0
Apr 20 11:32:50 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Apr 20 11:32:50 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Apr 20 11:32:50 volumio volumio[875]: info: Received Get System Info
Apr 20 11:32:50 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 20 11:32:50 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 20 11:32:50 volumio volumio[875]: info: Discovery: Getting this device information
Apr 20 11:32:50 volumio volumio[875]: info: CoreCommandRouter::volumioGetState
Apr 20 11:32:50 volumio volumio[875]: info: CorePlayQueue::getTrack 0
Apr 20 11:32:50 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 20 11:32:50 volumio volumio[875]: info: CoreCommandRouter::volumioGetState
Apr 20 11:32:50 volumio volumio[875]: info: CorePlayQueue::getTrack 0
Apr 20 11:32:50 volumio volumio[875]: info: Listing playlists
Apr 20 11:32:50 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Apr 20 11:32:50 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Apr 20 11:32:50 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Apr 20 11:32:50 volumio volumio[875]: info: CoreCommandRouter::volumioGetState
Apr 20 11:32:50 volumio volumio[875]: info: CorePlayQueue::getTrack 0
Apr 20 11:32:50 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Apr 20 11:32:50 volumio volumio[875]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5
Apr 20 11:32:51 volumio volumio[875]: info: CoreCommandRouter::volumioGetState
Apr 20 11:32:51 volumio volumio[875]: info: CorePlayQueue::getTrack 0
Apr 20 11:32:51 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 20 11:32:51 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 20 11:32:51 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Apr 20 11:32:51 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard
Apr 20 11:32:51 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Apr 20 11:32:51 volumio volumio[875]: info: Received Get System Info
Apr 20 11:32:51 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 20 11:32:51 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 20 11:32:51 volumio volumio[875]: info: Discovery: Getting this device information
Apr 20 11:32:51 volumio volumio[875]: info: CoreCommandRouter::volumioGetState
Apr 20 11:32:51 volumio volumio[875]: info: CorePlayQueue::getTrack 0
Apr 20 11:32:51 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 20 11:32:51 volumio volumio-remote-updater[501]: No test mode
Apr 20 11:32:51 volumio volumio-remote-updater[501]: No alpha test mode
Apr 20 11:32:51 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled
Apr 20 11:32:55 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 20 11:32:55 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 20 11:32:55 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam
Apr 20 11:32:55 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam
Apr 20 11:32:55 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Apr 20 11:32:55 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject
Apr 20 11:32:55 volumio volumio[875]: info: CoreCommandRouter::volumioGetBrowseSources
Apr 20 11:32:55 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 20 11:32:56 volumio volumio[875]: info: CoreCommandRouter::volumioGetQueue
Apr 20 11:32:56 volumio volumio[875]: info: CoreStateMachine::getQueue
Apr 20 11:32:56 volumio volumio[875]: info: CorePlayQueue::getQueue
Apr 20 11:32:57 volumio volumio[875]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"FIXES
- Improved translations
NEW ADDITIONS
- Update to TIDAL Connect
- Add Install-to-disk option for the new RPi5 HW revisions
","title":"Update v3.799","updateavailable":true}
Apr 20 11:32:57 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Apr 20 11:32:58 volumio volumio[875]: error: MyVolumio Plugin failed to authenticate in a timely fashion
Apr 20 11:32:58 volumio volumio[875]: info: Completed starting MyVolumio Plugin
Apr 20 11:32:58 volumio volumio[875]: [Metrics] CommandRouter: 77s 437.66ms
Apr 20 11:32:58 volumio volumio[875]: info: CoreCommandRouter::volumiosetStartupVolume
Apr 20 11:32:58 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 20 11:32:58 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 20 11:32:58 volumio volumio[875]: info: CoreCommandRouter::Close All Modals sent
Apr 20 11:32:58 volumio volumio[875]: info: CoreCommandRouter::Close All Modals sent
Apr 20 11:32:59 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Apr 20 11:32:59 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
Apr 20 11:32:59 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Apr 20 11:32:59 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
Apr 20 11:33:01 volumio sudo[1057]: pam_unix(sudo:session): session closed for user root
Apr 20 11:33:01 volumio volumio[875]: info: Cannot mount NAS rr at system boot, trial number 1 ,retrying in 5 seconds
Apr 20 11:33:01 volumio sudo[1055]: pam_unix(sudo:session): session closed for user root
Apr 20 11:33:01 volumio volumio[875]: info: Cannot mount NAS RPi5 at system boot, trial number 1 ,retrying in 5 seconds
Apr 20 11:33:05 volumio volumio[875]: info: BOOT COMPLETED
Apr 20 11:33:06 volumio sudo[1422]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t nfs -o ro,soft,noauto raspberrypi.local:/home/arun/Music /mnt/NAS/rr
Apr 20 11:33:06 volumio sudo[1422]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 20 11:33:06 volumio sudo[1424]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t nfs -o ro,soft,noauto,vers=4 raspberrypi.local:/home/arun/Music /mnt/NAS/RPi5
Apr 20 11:33:06 volumio sudo[1424]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 20 11:33:07 volumio sudo[1424]: pam_unix(sudo:session): session closed for user root
Apr 20 11:33:07 volumio volumio[875]: info: Cannot mount NAS RPi5 at system boot, trial number 2 ,retrying in 5 seconds
Apr 20 11:33:07 volumio sudo[1422]: pam_unix(sudo:session): session closed for user root
Apr 20 11:33:07 volumio volumio[875]: info: Cannot mount NAS rr at system boot, trial number 2 ,retrying in 5 seconds
Apr 20 11:33:08 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Apr 20 11:33:08 volumio volumio[875]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
Apr 20 11:33:08 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
Apr 20 11:33:08 volumio volumio[875]: info: Received Get System Version
Apr 20 11:33:08 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 20 11:33:08 volumio volumio[875]: info: Received Get System Info
Apr 20 11:33:08 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 20 11:33:08 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 20 11:33:08 volumio volumio[875]: info: Discovery: Getting this device information
Apr 20 11:33:08 volumio volumio[875]: info: CoreCommandRouter::volumioGetState
Apr 20 11:33:08 volumio volumio[875]: info: CorePlayQueue::getTrack 0
Apr 20 11:33:08 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 20 11:33:08 volumio volumio[875]: info: CoreCommandRouter::volumioGetState
Apr 20 11:33:08 volumio volumio[875]: info: CorePlayQueue::getTrack 0
Apr 20 11:33:10 volumio volumio[875]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 20 11:33:10 volumio volumio[875]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 20 11:33:10 volumio volumio[875]: info: Retrieving Cloud Streaming UI
Apr 20 11:33:10 volumio volumio[875]: info: Getting Tidal Cloud Configuration
Apr 20 11:33:10 volumio volumio[875]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 20 11:33:10 volumio volumio[875]: info: Getting Qobuz Cloud Configuration
Apr 20 11:33:10 volumio volumio[875]: info: Asking plugin for UI Config
Apr 20 11:33:10 volumio volumio[875]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 20 11:33:10 volumio volumio[875]: info: Getting Spotify Cloud Configuration
Apr 20 11:33:10 volumio volumio[875]: info: Asking plugin for UI Config
Apr 20 11:33:10 volumio volumio[875]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 20 11:33:10 volumio volumio[875]: info: Saving Spotify Acccount
Apr 20 11:33:10 volumio volumio[875]: info: Got Tidal Cloud Configuration
Apr 20 11:33:10 volumio volumio[875]: info: Got it
Apr 20 11:33:10 volumio volumio[875]: info: Got it
Apr 20 11:33:10 volumio volumio[875]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
Apr 20 11:33:10 volumio volumio[875]: info: CoreCommandRouter::getUIConfigOnPlugin
Apr 20 11:33:10 volumio volumio[875]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined
Apr 20 11:33:10 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Apr 20 11:33:10 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Apr 20 11:33:10 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Apr 20 11:33:10 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Apr 20 11:33:10 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 20 11:33:10 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 20 11:33:10 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 20 11:33:10 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 20 11:33:10 volumio volumio[875]: info: CoreCommandRouter::volumioGetBrowseSources
Apr 20 11:33:10 volumio volumio[875]: info: CoreCommandRouter::volumioGetBrowseSources
Apr 20 11:33:10 volumio volumio[875]: info: CoreCommandRouter::volumioGetBrowseSources
Apr 20 11:33:10 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 20 11:33:10 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
Apr 20 11:33:12 volumio sudo[1456]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t nfs -o ro,soft,noauto,vers=4 raspberrypi.local:/home/arun/Music /mnt/NAS/RPi5
Apr 20 11:33:12 volumio sudo[1456]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 20 11:33:12 volumio sudo[1460]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t nfs -o ro,soft,noauto raspberrypi.local:/home/arun/Music /mnt/NAS/rr
Apr 20 11:33:12 volumio sudo[1460]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 20 11:33:12 volumio sudo[1456]: pam_unix(sudo:session): session closed for user root
Apr 20 11:33:12 volumio volumio[875]: info: Cannot mount NAS RPi5 at system boot, trial number 3 ,retrying in 5 seconds
Apr 20 11:33:12 volumio sudo[1460]: pam_unix(sudo:session): session closed for user root
Apr 20 11:33:12 volumio volumio[875]: info: Cannot mount NAS rr at system boot, trial number 3 ,retrying in 5 seconds
Apr 20 11:33:14 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Apr 20 11:33:15 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: networkfs , deleteShare
Apr 20 11:33:16 volumio volumio[875]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
Apr 20 11:33:17 volumio volumio[875]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 20 11:33:17 volumio sudo[1512]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t nfs -o ro,soft,noauto,vers=4 raspberrypi.local:/home/arun/Music /mnt/NAS/RPi5
Apr 20 11:33:17 volumio sudo[1512]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 20 11:33:17 volumio volumio[875]: TypeError: Cannot read property 'replace' of undefined
Apr 20 11:33:17 volumio volumio[875]: at ControllerNetworkfs.mountShare (/volumio/app/plugins/system_controller/networkfs/index.js:202:28)
Apr 20 11:33:17 volumio volumio[875]: at Timeout._onTimeout (/volumio/app/plugins/system_controller/networkfs/index.js:255:20)
Apr 20 11:33:17 volumio volumio[875]: at listOnTimeout (internal/timers.js:554:17)
Apr 20 11:33:17 volumio volumio[875]: at processTimers (internal/timers.js:497:7)
Apr 20 11:33:17 volumio volumio[875]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 20 11:33:17 volumio sudo[1512]: pam_unix(sudo:session): session closed for user root
Apr 20 11:33:18 volumio sudo[1542]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-04-20 11:32
Apr 20 11:33:18 volumio sudo[1542]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Raspbian GNU/Linux 10 (buster)"
NAME="Raspbian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=raspbian
ID_LIKE=debian
HOME_URL="http://www.raspbian.org/"
SUPPORT_URL="http://www.raspbian.org/RaspbianForums"
BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs"
VOLUMIO_BUILD_VERSION="147953990fca4aa103a8f90538ef56fb0454638c"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="a01a833dd28483f88cb390596f5090b7187992af"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Thu 27 Feb 2025 11:42:54 AM CET"
VOLUMIO_VERSION="3.795"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="4049a67f1c09d4a94e033ba35a80a144"