-- Logs begin at Thu 2019-02-14 11:11:58 CET, end at Sun 2025-05-11 18:10:47 CEST. -- May 11 18:10:26 volumio systemd-timedated[1032]: Changed local time to Sun May 11 18:10:26 2025 May 11 18:10:26 volumio sudo[1030]: pam_unix(sudo:session): session closed for user root May 11 18:10:26 volumio volumio-time-update[654]: volumio-time-update-util: System time updated successfully. May 11 18:10:26 volumio systemd[1]: Starting Daily apt download activities... May 11 18:10:26 volumio systemd[1]: Started Volumio Time Update Utility. May 11 18:10:26 volumio volumio[998]: info: Applying required configuration parameters for plugin ampswitch May 11 18:10:26 volumio volumio[998]: info: Loading plugin "appearance"... May 11 18:10:26 volumio systemd[1]: apt-daily.service: Succeeded. May 11 18:10:26 volumio systemd[1]: Started Daily apt download activities. May 11 18:10:26 volumio systemd[1]: Starting Daily apt upgrade and clean activities... May 11 18:10:27 volumio nmbd[761]: [2025/05/11 18:10:27.119453, 0] ../lib/util/become_daemon.c:138(daemon_ready) May 11 18:10:27 volumio nmbd[761]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections May 11 18:10:27 volumio systemd[1]: Started Samba NMB Daemon. May 11 18:10:27 volumio nmbd[761]: [2025/05/11 18:10:27.147787, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) May 11 18:10:27 volumio nmbd[761]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.1.106 for name WORKGROUP<1d>. May 11 18:10:27 volumio nmbd[761]: This response was from IP 192.168.1.57, reporting an IP address of 192.168.1.57. May 11 18:10:27 volumio systemd[1]: Starting Samba Winbind Daemon... May 11 18:10:27 volumio systemd[1]: apt-daily-upgrade.service: Succeeded. May 11 18:10:27 volumio systemd[1]: Started Daily apt upgrade and clean activities. May 11 18:10:27 volumio winbindd[1119]: [2025/05/11 18:10:27.424723, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) May 11 18:10:27 volumio winbindd[1119]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 May 11 18:10:27 volumio winbindd[1119]: [2025/05/11 18:10:27.446969, 0] ../lib/util/become_daemon.c:138(daemon_ready) May 11 18:10:27 volumio systemd[1]: Started Samba Winbind Daemon. May 11 18:10:27 volumio winbindd[1119]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections May 11 18:10:27 volumio volumio[998]: info: Loading plugin "network"... May 11 18:10:27 volumio systemd[1]: Starting Samba SMB Daemon... May 11 18:10:27 volumio volumio[998]: info: Refreshing Cached IP Addresses May 11 18:10:27 volumio sudo[1141]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 11 18:10:27 volumio sudo[1141]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 18:10:27 volumio sudo[1141]: pam_unix(sudo:session): session closed for user root May 11 18:10:27 volumio sudo[1143]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 11 18:10:27 volumio sudo[1143]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 18:10:27 volumio sudo[1143]: pam_unix(sudo:session): session closed for user root May 11 18:10:27 volumio volumio[998]: info: Loading plugin "services"... May 11 18:10:27 volumio volumio[998]: info: Loading plugin "alsa_controller"... May 11 18:10:27 volumio sudo[1152]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan May 11 18:10:27 volumio sudo[1152]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 18:10:27 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 11 18:10:27 volumio volumio[998]: info: Loading plugin "wizard"... May 11 18:10:27 volumio volumio[998]: info: Loading plugin "networkfs"... May 11 18:10:27 volumio volumio[998]: info: Starting Udev Watcher for removable devices May 11 18:10:27 volumio sudo[1169]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=admin,password=oliwer13,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.3/Volume 1 /mnt/NAS/Qnap May 11 18:10:27 volumio sudo[1169]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 18:10:27 volumio volumio[998]: info: Ignoring mount for partition: boot May 11 18:10:27 volumio volumio[998]: info: Ignoring mount for partition: volumio May 11 18:10:27 volumio volumio[998]: info: Ignoring mount for partition: volumio_data May 11 18:10:27 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 11 18:10:27 volumio volumio[998]: info: Loading plugin "volumio_command_line_client"... May 11 18:10:27 volumio volumio[998]: info: Loading plugin "upnp"... May 11 18:10:27 volumio volumio[998]: info: [1746979827864] Starting Upmpd Daemon May 11 18:10:27 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 11 18:10:27 volumio volumio[998]: info: Loading plugin "my_music"... May 11 18:10:27 volumio volumio[998]: info: Loading plugin "mpd"... May 11 18:10:27 volumio volumio-remote-updater[632]: [2025-05-11 18:10:27] [connect] Successful connection May 11 18:10:27 volumio smbd[1139]: [2025/05/11 18:10:27.968834, 0] ../lib/util/become_daemon.c:138(daemon_ready) May 11 18:10:27 volumio systemd[1]: Started Samba SMB Daemon. May 11 18:10:27 volumio smbd[1139]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections May 11 18:10:27 volumio systemd[1]: Reached target Multi-User System. May 11 18:10:27 volumio systemd[1]: Reached target Graphical Interface. May 11 18:10:27 volumio kernel: Key type cifs.spnego registered May 11 18:10:27 volumio kernel: Key type cifs.idmap registered May 11 18:10:27 volumio kernel: CIFS: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3.1.1), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3.1.1 (or even SMB3 or SMB2.1) specify vers=1.0 on mount. May 11 18:10:27 volumio kernel: CIFS: Attempting to mount //192.168.1.3/Volume 1 May 11 18:10:28 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... May 11 18:10:28 volumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. May 11 18:10:28 volumio systemd[1]: Started Update UTMP about System Runlevel Changes. May 11 18:10:28 volumio systemd[1]: Startup finished in 12.445s (kernel) + 27.142s (userspace) = 39.587s. May 11 18:10:28 volumio kernel: cryptd: max_cpu_qlen set to 1000 May 11 18:10:28 volumio volumio[998]: info: Loading plugin "upnp_browser"... May 11 18:10:28 volumio volumio[998]: info: Loading plugin "alarm-clock"... May 11 18:10:28 volumio sudo[1169]: pam_unix(sudo:session): session closed for user root May 11 18:10:28 volumio volumio[998]: info: Loading plugin "airplay_emulation"... May 11 18:10:28 volumio volumio[998]: info: Starting Shairport Sync May 11 18:10:28 volumio volumio[998]: info: Loading plugin "last_100"... May 11 18:10:28 volumio volumio[998]: info: Loading plugin "webradio"... May 11 18:10:28 volumio volumio[998]: info: Loading plugin "i2s_dacs"... May 11 18:10:28 volumio volumio[998]: info: Loading plugin "volumiodiscovery"... May 11 18:10:28 volumio volumio[998]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 11 18:10:28 volumio volumio[998]: *** WARNING *** Please fix your application to use the native API of Avahi! May 11 18:10:28 volumio node[998]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 11 18:10:28 volumio volumio[998]: *** WARNING *** For more information see May 11 18:10:28 volumio volumio[998]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 11 18:10:28 volumio volumio[998]: *** WARNING *** Please fix your application to use the native API of Avahi! May 11 18:10:28 volumio volumio[998]: *** WARNING *** For more information see May 11 18:10:28 volumio node[998]: *** WARNING *** Please fix your application to use the native API of Avahi! May 11 18:10:28 volumio node[998]: *** WARNING *** For more information see May 11 18:10:28 volumio node[998]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 11 18:10:28 volumio node[998]: *** WARNING *** Please fix your application to use the native API of Avahi! May 11 18:10:28 volumio node[998]: *** WARNING *** For more information see May 11 18:10:28 volumio volumio[998]: info: Applying required configuration parameters for plugin volumiodiscovery May 11 18:10:28 volumio volumio[998]: info: Discovery: Started advertising with name: Volumio May 11 18:10:28 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 11 18:10:28 volumio volumio[998]: info: Loading plugin "outputs"... May 11 18:10:28 volumio volumio[998]: info: Loading plugin "albumart"... May 11 18:10:28 volumio volumio[998]: info: Plugin example_plugin is not enabled May 11 18:10:28 volumio volumio[998]: info: Loading plugin "inputs"... May 11 18:10:28 volumio volumio[998]: info: Loading plugin "updater_comm"... May 11 18:10:29 volumio volumio[998]: info: Plugin mpdemulation is not enabled May 11 18:10:29 volumio volumio[998]: info: Loading plugin "rest_api"... May 11 18:10:29 volumio volumio[998]: info: Loading plugin "websocket"... May 11 18:10:29 volumio volumio[998]: info: Starting Socket.io Server version 2.3.0 May 11 18:10:29 volumio volumio[998]: info: Loading plugin "Systeminfo"... May 11 18:10:29 volumio volumio[998]: Forking 3 albumart workers May 11 18:10:29 volumio volumio[998]: info: Loading i18n strings for locale pl May 11 18:10:29 volumio volumio[998]: Updating browse sources language May 11 18:10:29 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 11 18:10:29 volumio volumio[998]: Starting albumart workers May 11 18:10:29 volumio volumio[998]: Starting albumart workers May 11 18:10:29 volumio volumio[998]: Starting albumart workers May 11 18:10:29 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 11 18:10:29 volumio volumio[998]: info: CoreCommandRouter::initPlayerControls May 11 18:10:29 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 18:10:29 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 18:10:29 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 18:10:29 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 18:10:29 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 18:10:29 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 18:10:29 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 18:10:29 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 18:10:29 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 11 18:10:29 volumio volumio[998]: Express server listening on port 3000 May 11 18:10:29 volumio volumio[998]: [Metrics] WebUI: 5s 467.80ms May 11 18:10:29 volumio volumio[998]: info: CoreStateMachine::resetVolumioState May 11 18:10:29 volumio volumio[998]: info: CoreStateMachine::getcurrentVolume May 11 18:10:29 volumio volumio[998]: info: CoreCommandRouter::volumioRetrievevolume May 11 18:10:30 volumio volumio[998]: info: Volumio Network Manager: Network status updated: 2 May 11 18:10:30 volumio volumio-remote-updater[632]: [2025-05-11 18:10:30] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1746979827 101 May 11 18:10:30 volumio volumio[998]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 1 May 11 18:10:30 volumio volumio[998]: info: CoreCommandRouter::volumioGetState May 11 18:10:30 volumio volumio[998]: info: CorePlayQueue::getTrack 0 May 11 18:10:30 volumio volumio[998]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 May 11 18:10:30 volumio volumio[998]: info: Reloading queue from file May 11 18:10:30 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 11 18:10:30 volumio volumio[998]: info: Executing start script for DAC IQaudIO DAC Plus May 11 18:10:30 volumio volumio[998]: info: VolumeController:: Volume=100 Mute =false May 11 18:10:30 volumio volumio[998]: info: CoreStateMachine::pushState May 11 18:10:30 volumio volumio[998]: info: CorePlayQueue::getTrack 0 May 11 18:10:30 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 11 18:10:30 volumio volumio[998]: info: CoreCommandRouter::volumioPushState May 11 18:10:30 volumio volumio[998]: info: CoreStateMachine::updateTrackBlock May 11 18:10:30 volumio volumio[998]: info: CorePlayQueue::getTrackBlock May 11 18:10:30 volumio volumio[998]: info: CoreCommandRouter::volumioRetrievevolume May 11 18:10:30 volumio volumio[998]: info: Setting Device type: Raspberry PI May 11 18:10:30 volumio volumio[998]: info: CoreStateMachine::setRepeat null single undefined May 11 18:10:30 volumio volumio[998]: info: CoreStateMachine::pushState May 11 18:10:30 volumio volumio[998]: info: CorePlayQueue::getTrack 0 May 11 18:10:30 volumio volumio[998]: info: CoreCommandRouter::volumioPushState May 11 18:10:30 volumio volumio[998]: info: CoreStateMachine::setRandom null May 11 18:10:30 volumio volumio[998]: info: CoreStateMachine::pushState May 11 18:10:30 volumio volumio[998]: info: CorePlayQueue::getTrack 0 May 11 18:10:30 volumio volumio[998]: info: CoreCommandRouter::volumioPushState May 11 18:10:30 volumio volumio[998]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb May 11 18:10:30 volumio volumio[998]: info: USB Boot Capable - System SBC Revision found in cpuinfo: c03115 May 11 18:10:30 volumio volumio[998]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI May 11 18:10:30 volumio volumio[998]: info: DAC script executed May 11 18:10:30 volumio volumio[998]: info: Completed loading Core Plugins May 11 18:10:30 volumio volumio[998]: info: Preparing to generate the ALSA configuration file May 11 18:10:30 volumio volumio[998]: info: Listing playlists May 11 18:10:30 volumio volumio[998]: info: Listing playlists May 11 18:10:30 volumio volumio[998]: info: Asound.conf file unchanged, so no further update is needed May 11 18:10:30 volumio volumio[998]: info: Output device has changed, restarting MPD May 11 18:10:30 volumio sudo[1289]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 11 18:10:30 volumio volumio[998]: info: Output device has changed, restarting Shairport Sync May 11 18:10:30 volumio sudo[1289]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 18:10:30 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 18:10:30 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 11 18:10:30 volumio sudo[1289]: pam_unix(sudo:session): session closed for user root May 11 18:10:30 volumio sudo[1291]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 11 18:10:30 volumio sudo[1291]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 18:10:30 volumio systemd[1]: Stopping Music Player Daemon... May 11 18:10:30 volumio volumio[998]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 11 18:10:30 volumio volumio[998]: info: ___________ START PLUGINS ___________ May 11 18:10:30 volumio volumio[998]: info: ControllerMpd::onStart: Initializing MPD May 11 18:10:30 volumio volumio[998]: info: Creating MPD Configuration file May 11 18:10:30 volumio sudo[1309]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 11 18:10:30 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 11 18:10:30 volumio sudo[1309]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 18:10:30 volumio volumio[998]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 11 18:10:30 volumio volumio[998]: info: [1746979830564] CoreMusicLibrary::Adding element Serwery Mediów May 11 18:10:30 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 11 18:10:30 volumio sudo[1309]: pam_unix(sudo:session): session closed for user root May 11 18:10:30 volumio sudo[1311]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 11 18:10:30 volumio sudo[1311]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 18:10:30 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 18:10:30 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 11 18:10:30 volumio volumio[998]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 11 18:10:30 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 18:10:30 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 11 18:10:30 volumio systemd[1]: mpd.service: Succeeded. May 11 18:10:30 volumio systemd[1]: Stopped Music Player Daemon. May 11 18:10:30 volumio volumio[998]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 11 18:10:30 volumio volumio[998]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 11 18:10:30 volumio volumio[998]: info: [1746979830646] CoreMusicLibrary::Adding element Last_100 May 11 18:10:30 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 11 18:10:30 volumio volumio[998]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 11 18:10:30 volumio volumio[998]: info: [1746979830648] CoreMusicLibrary::Adding element Webradio May 11 18:10:30 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 11 18:10:30 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 11 18:10:30 volumio volumio[998]: info: Initializing BBC Radios May 11 18:10:30 volumio systemd[1]: Starting Music Player Daemon... May 11 18:10:30 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 11 18:10:30 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 11 18:10:30 volumio volumio[998]: info: Volumio Calling Home May 11 18:10:30 volumio sudo[1318]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log May 11 18:10:30 volumio sudo[1318]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 18:10:30 volumio sudo[1318]: pam_unix(sudo:session): session closed for user root May 11 18:10:30 volumio volumio[998]: info: VolumeController:: Volume=100 Mute =false May 11 18:10:30 volumio volumio[998]: info: CoreStateMachine::pushState May 11 18:10:30 volumio volumio[998]: info: CorePlayQueue::getTrack 0 May 11 18:10:30 volumio volumio[998]: info: CoreCommandRouter::volumioPushState May 11 18:10:30 volumio volumio[998]: info: Discovery: adding 27f36f77-8778-4588-8608-a6fe20f4f6e2 May 11 18:10:30 volumio volumio[998]: info: Discovery: Found device Volumio May 11 18:10:30 volumio volumio[998]: info: CoreCommandRouter::volumioGetState May 11 18:10:30 volumio volumio[998]: info: CorePlayQueue::getTrack 0 May 11 18:10:30 volumio volumio[998]: info: MPD Permissions set May 11 18:10:30 volumio volumio[998]: info: MPD Permissions set May 11 18:10:30 volumio volumio[998]: info: CoreCommandRouter::volumioGetState May 11 18:10:30 volumio volumio[998]: info: CorePlayQueue::getTrack 0 May 11 18:10:30 volumio volumio[998]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 May 11 18:10:30 volumio volumio[998]: info: [ASDebug] CurState: stop PrevState: na May 11 18:10:30 volumio volumio[998]: info: [ASDebug] InitTimeout - Amp off in: 720 ms May 11 18:10:30 volumio volumio[998]: info: [ASDebug] CurState: stop PrevState: na May 11 18:10:30 volumio volumio[998]: info: [ASDebug] InitTimeout - Amp off in: 720 ms May 11 18:10:30 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 18:10:30 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 18:10:30 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 18:10:30 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 18:10:30 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 18:10:30 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 18:10:30 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 18:10:30 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 18:10:30 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 11 18:10:30 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 18:10:30 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 18:10:30 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 18:10:30 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 18:10:30 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 18:10:30 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 18:10:30 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 18:10:30 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 18:10:30 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 18:10:30 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 11 18:10:30 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 18:10:30 volumio volumio[998]: info: [ASDebug] CurState: stop PrevState: na May 11 18:10:30 volumio volumio[998]: info: [ASDebug] InitTimeout - Amp off in: 720 ms May 11 18:10:30 volumio volumio[998]: info: Starting Shairport Sync May 11 18:10:30 volumio volumio[998]: info: Starting Shairport Sync May 11 18:10:30 volumio volumio[998]: info: Starting Shairport Sync May 11 18:10:30 volumio sudo[1345]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 11 18:10:30 volumio sudo[1345]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 18:10:30 volumio sudo[1347]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 11 18:10:31 volumio sudo[1347]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 18:10:31 volumio sudo[1350]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 11 18:10:31 volumio sudo[1350]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 18:10:31 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... May 11 18:10:31 volumio systemd[1]: shairport-sync.service: Succeeded. May 11 18:10:31 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. May 11 18:10:31 volumio volumio[998]: info: CoreCommandRouter::volumioGetState May 11 18:10:31 volumio volumio[998]: info: CorePlayQueue::getTrack 0 May 11 18:10:31 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. May 11 18:10:31 volumio sudo[1345]: pam_unix(sudo:session): session closed for user root May 11 18:10:31 volumio sudo[1347]: pam_unix(sudo:session): session closed for user root May 11 18:10:31 volumio sudo[1350]: pam_unix(sudo:session): session closed for user root May 11 18:10:31 volumio volumio[998]: info: Shairport-Sync Started May 11 18:10:31 volumio volumio[998]: Error adding Membership: Error: addMembership EINVAL May 11 18:10:31 volumio volumio[998]: info: Shairport-Sync Started May 11 18:10:31 volumio volumio[998]: info: Shairport-Sync Started May 11 18:10:31 volumio sudo[1152]: pam_unix(sudo:session): session closed for user root May 11 18:10:31 volumio volumio[998]: info: Volumio called home May 11 18:10:31 volumio mpd[1335]: May 11 18:10 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg May 11 18:10:31 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 11 18:10:31 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 11 18:10:31 volumio volumio[998]: info: Discovery: Getting this device information May 11 18:10:31 volumio volumio[998]: info: CoreCommandRouter::volumioGetState May 11 18:10:31 volumio volumio[998]: info: CorePlayQueue::getTrack 0 May 11 18:10:31 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 11 18:10:31 volumio systemd[1]: Started Music Player Daemon. May 11 18:10:31 volumio sudo[1311]: pam_unix(sudo:session): session closed for user root May 11 18:10:31 volumio sudo[1291]: pam_unix(sudo:session): session closed for user root May 11 18:10:31 volumio volumio[998]: info: Completed starting Core Plugins May 11 18:10:31 volumio volumio[998]: info: ------------------------------------------- May 11 18:10:31 volumio volumio[998]: info: ----- MyVolumio plugins startup ---- May 11 18:10:31 volumio volumio[998]: info: ------------------------------------------- May 11 18:10:31 volumio volumio[998]: info: [MyVolumio PluginManager] Fetching plans data.... May 11 18:10:31 volumio volumio[998]: info: MPD running with PID1335 May 11 18:10:31 volumio volumio[998]: ,establishing connection May 11 18:10:31 volumio volumio[998]: error: MPD error: The expression evaluated to a falsy value: May 11 18:10:31 volumio volumio[998]: assert.ok(self.idling) May 11 18:10:31 volumio volumio[998]: error: The expression evaluated to a falsy value: May 11 18:10:31 volumio volumio[998]: assert.ok(self.idling) May 11 18:10:31 volumio volumio[998]: error: MPD error: The expression evaluated to a falsy value: May 11 18:10:31 volumio volumio[998]: assert.ok(self.idling) May 11 18:10:31 volumio volumio[998]: error: The expression evaluated to a falsy value: May 11 18:10:31 volumio volumio[998]: assert.ok(self.idling) May 11 18:10:31 volumio volumio[998]: verbose: New Socket.io Connection to 192.168.1.106:3000 from 192.168.1.138 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 4 May 11 18:10:31 volumio volumio[998]: error: updateQueue error: null May 11 18:10:31 volumio volumio[998]: info: [ASDebug] Togle GPIO: OFF May 11 18:10:31 volumio volumio[998]: info: CoreCommandRouter::volumioGetState May 11 18:10:31 volumio volumio[998]: info: CorePlayQueue::getTrack 0 May 11 18:10:31 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 11 18:10:31 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 11 18:10:34 volumio systemd[1]: systemd-fsckd.service: Succeeded. May 11 18:10:34 volumio sudo[1362]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 11 18:10:34 volumio sudo[1362]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 18:10:34 volumio sudo[1362]: pam_unix(sudo:session): session closed for user root May 11 18:10:34 volumio sudo[1364]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 11 18:10:34 volumio sudo[1364]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 18:10:34 volumio sudo[1364]: pam_unix(sudo:session): session closed for user root May 11 18:10:34 volumio volumio[998]: verbose: New Socket.io Connection to 192.168.1.106 from 192.168.1.138 UA: Mozilla/5.0 (Linux; Android 14; motorola edge 30 fusion Build/U1SJS34.2-92-10-6; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/135.0.7049.113 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 May 11 18:10:34 volumio sudo[1368]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 11 18:10:34 volumio sudo[1368]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 18:10:34 volumio sudo[1368]: pam_unix(sudo:session): session closed for user root May 11 18:10:34 volumio sudo[1370]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 11 18:10:34 volumio sudo[1370]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 18:10:34 volumio sudo[1370]: pam_unix(sudo:session): session closed for user root May 11 18:10:34 volumio sh[532]: timed out May 11 18:10:34 volumio dhcpcd[586]: timed out May 11 18:10:34 volumio sh[532]: dhcpcd exited May 11 18:10:34 volumio dhcpcd[586]: dhcpcd exited May 11 18:10:34 volumio sh[532]: ifup: failed to bring up eth0 May 11 18:10:34 volumio systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE May 11 18:10:34 volumio systemd[1]: ifup@eth0.service: Failed with result 'exit-code'. May 11 18:10:34 volumio volumio[998]: verbose: New Socket.io Connection to 192.168.1.106 from 192.168.1.138 UA: Mozilla/5.0 (Linux; Android 14; motorola edge 30 fusion Build/U1SJS34.2-92-10-6; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/135.0.7049.113 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 May 11 18:10:34 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 11 18:10:34 volumio volumio[998]: info: CoreCommandRouter::volumioGetVisibleSources May 11 18:10:34 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 11 18:10:34 volumio volumio[998]: info: CoreCommandRouter::volumioGetState May 11 18:10:34 volumio volumio[998]: info: CorePlayQueue::getTrack 0 May 11 18:10:34 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 11 18:10:34 volumio volumio[998]: info: CoreCommandRouter::volumioGetQueue May 11 18:10:34 volumio volumio[998]: info: CoreStateMachine::getQueue May 11 18:10:34 volumio volumio[998]: info: CorePlayQueue::getQueue May 11 18:10:34 volumio volumio[998]: info: Listing playlists May 11 18:10:34 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 11 18:10:34 volumio volumio[998]: info: Received Get System Info May 11 18:10:34 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 11 18:10:34 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 11 18:10:34 volumio volumio[998]: info: Discovery: Getting this device information May 11 18:10:34 volumio volumio[998]: info: CoreCommandRouter::volumioGetState May 11 18:10:34 volumio volumio[998]: info: CorePlayQueue::getTrack 0 May 11 18:10:34 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 11 18:10:34 volumio volumio[998]: info: CoreCommandRouter::volumioGetState May 11 18:10:34 volumio volumio[998]: info: CorePlayQueue::getTrack 0 May 11 18:10:34 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 11 18:10:34 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 11 18:10:35 volumio volumio[998]: info: CoreCommandRouter::volumioGetState May 11 18:10:35 volumio volumio[998]: info: CorePlayQueue::getTrack 0 May 11 18:10:36 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard May 11 18:10:36 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 11 18:10:36 volumio volumio[998]: info: Received Get System Info May 11 18:10:36 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 11 18:10:36 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 11 18:10:36 volumio volumio[998]: info: Discovery: Getting this device information May 11 18:10:36 volumio volumio[998]: info: CoreCommandRouter::volumioGetState May 11 18:10:36 volumio volumio[998]: info: CorePlayQueue::getTrack 0 May 11 18:10:36 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 11 18:10:36 volumio systemd[1]: systemd-hostnamed.service: Succeeded. May 11 18:10:36 volumio volumio[998]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory May 11 18:10:37 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken May 11 18:10:37 volumio sudo[1392]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 11 18:10:37 volumio sudo[1392]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 18:10:37 volumio sudo[1392]: pam_unix(sudo:session): session closed for user root May 11 18:10:37 volumio sudo[1394]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 11 18:10:37 volumio sudo[1394]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 18:10:37 volumio sudo[1394]: pam_unix(sudo:session): session closed for user root May 11 18:10:37 volumio sudo[1398]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service May 11 18:10:37 volumio sudo[1398]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 18:10:37 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 11 18:10:37 volumio volumio[998]: info: Received Get System Info May 11 18:10:37 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 11 18:10:37 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 11 18:10:37 volumio volumio[998]: info: Discovery: Getting this device information May 11 18:10:37 volumio volumio[998]: info: CoreCommandRouter::volumioGetState May 11 18:10:37 volumio volumio[998]: info: CorePlayQueue::getTrack 0 May 11 18:10:37 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 11 18:10:38 volumio systemd[1]: Started UPnP Renderer front-end to MPD. May 11 18:10:38 volumio sudo[1398]: pam_unix(sudo:session): session closed for user root May 11 18:10:38 volumio volumio[998]: info: Upmpdcli Daemon Started May 11 18:10:38 volumio volumio[1400]: Generating RSA private key, 4096 bit long modulus (2 primes) May 11 18:10:39 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 11 18:10:39 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken May 11 18:10:39 volumio volumio[998]: info: Preload queue cleared May 11 18:10:39 volumio volumio[998]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium May 11 18:10:39 volumio volumio[998]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium May 11 18:10:39 volumio volumio[998]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium May 11 18:10:39 volumio volumio[998]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium May 11 18:10:39 volumio volumio[998]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium May 11 18:10:39 volumio volumio[998]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium May 11 18:10:39 volumio volumio[998]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium May 11 18:10:39 volumio volumio[998]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium May 11 18:10:39 volumio volumio[998]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium May 11 18:10:39 volumio volumio[998]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium May 11 18:10:39 volumio volumio[998]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium May 11 18:10:39 volumio volumio[998]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar May 11 18:10:39 volumio volumio[998]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar May 11 18:10:39 volumio volumio[998]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar May 11 18:10:39 volumio volumio[998]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar May 11 18:10:39 volumio volumio[998]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar May 11 18:10:39 volumio volumio[998]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar May 11 18:10:39 volumio volumio[998]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar May 11 18:10:39 volumio volumio[998]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar May 11 18:10:39 volumio volumio[998]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar May 11 18:10:39 volumio volumio[998]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar May 11 18:10:39 volumio volumio[998]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar May 11 18:10:39 volumio volumio[998]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso May 11 18:10:39 volumio volumio[998]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso May 11 18:10:39 volumio volumio[998]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso May 11 18:10:39 volumio volumio[998]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso May 11 18:10:39 volumio volumio[998]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso May 11 18:10:39 volumio volumio[998]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso May 11 18:10:39 volumio volumio[998]: info: Adding plugin bluetooth to MyMusic Plugins May 11 18:10:39 volumio volumio[998]: info: Adding plugin multiroom to MyMusic Plugins May 11 18:10:39 volumio volumio[998]: info: Adding plugin metavolumio to MyMusic Plugins May 11 18:10:40 volumio volumio[998]: info: Adding plugin cd_controller to MyMusic Plugins May 11 18:10:40 volumio volumio[998]: info: Adding plugin smart_inputs to MyMusic Plugins May 11 18:10:40 volumio volumio[998]: info: Adding plugin tidalconnect to MyMusic Plugins May 11 18:10:40 volumio volumio[998]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... May 11 18:10:40 volumio volumio[998]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded May 11 18:10:40 volumio volumio[998]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio May 11 18:10:40 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 11 18:10:40 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 11 18:10:40 volumio volumio[998]: info: Starting MyVolumio Remote Streaming Endpoints May 11 18:10:40 volumio volumio[998]: info: MyVolumio login type: Token May 11 18:10:40 volumio volumio[998]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started May 11 18:10:40 volumio volumio[998]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... May 11 18:10:41 volumio volumio[998]: info: Starting Streaming Service Transparent Proxy May 11 18:10:41 volumio volumio[998]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded May 11 18:10:41 volumio volumio[998]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services May 11 18:10:41 volumio volumio[998]: info: Streaming services startup May 11 18:10:41 volumio volumio[998]: info: Starting Streaming Daemon May 11 18:10:41 volumio sudo[1423]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service May 11 18:10:41 volumio sudo[1423]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 18:10:41 volumio volumio[998]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started May 11 18:10:41 volumio sudo[1423]: pam_unix(sudo:session): session closed for user root May 11 18:10:41 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 11 18:10:41 volumio volumio[998]: error: Cannot start Volumio Streaming Daemon May 11 18:10:41 volumio volumio[998]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service May 11 18:10:41 volumio volumio[998]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. May 11 18:10:42 volumio volumio[998]: info: Preload queue cleared May 11 18:10:42 volumio volumio[998]: error: MyVolumio Custom Token format not valid, refreshing it May 11 18:10:42 volumio volumio[1400]: .............................................++++ May 11 18:10:42 volumio volumio[998]: STREAMING PROXY: Starting server on port 3245 May 11 18:10:42 volumio volumio[998]: Node JS runtime: 14 May 11 18:10:42 volumio volumio[998]: info: MyVolumio login type: Token May 11 18:10:43 volumio volumio[998]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN May 11 18:10:44 volumio volumio[998]: info: MyVolumio token set successfully May 11 18:10:44 volumio volumio[998]: info: MYVOLUMIO: Adding device May 11 18:10:44 volumio volumio[998]: info: MYVOLUMIO: Evaluating Server May 11 18:10:44 volumio volumio[998]: info: MyVolumio status changed May 11 18:10:44 volumio volumio[998]: info: Streaming services startup May 11 18:10:44 volumio volumio[998]: info: Starting Streaming Daemon May 11 18:10:44 volumio volumio[998]: info: Removing browser output: myVolumio user plan is not superstar May 11 18:10:44 volumio volumio[998]: info: Removing audio output: May 11 18:10:44 volumio volumio[998]: info: Stoppping Tunnel 1 May 11 18:10:44 volumio sudo[1448]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service May 11 18:10:44 volumio sudo[1448]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 18:10:44 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 11 18:10:44 volumio sudo[1451]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service May 11 18:10:44 volumio sudo[1451]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 18:10:44 volumio sudo[1448]: pam_unix(sudo:session): session closed for user root May 11 18:10:44 volumio volumio[998]: error: Cannot start Volumio Streaming Daemon May 11 18:10:44 volumio volumio[998]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service May 11 18:10:44 volumio volumio[998]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. May 11 18:10:44 volumio sudo[1451]: pam_unix(sudo:session): session closed for user root May 11 18:10:44 volumio volumio[998]: info: Remote SSH Stopped May 11 18:10:44 volumio volumio[998]: info: Preload queue cleared May 11 18:10:44 volumio volumio[998]: info: Setting Geolocation for MyVolumio to eu7 May 11 18:10:44 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 11 18:10:44 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 11 18:10:45 volumio volumio[998]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} May 11 18:10:45 volumio volumio[998]: info: CoreCommandRouter::volumioGetState May 11 18:10:45 volumio volumio[998]: info: CorePlayQueue::getTrack 0 May 11 18:10:45 volumio volumio[998]: info: Listing playlists May 11 18:10:45 volumio volumio[998]: info: Listing playlists May 11 18:10:45 volumio volumio[998]: info: Updating MyVolumio device info May 11 18:10:45 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 11 18:10:46 volumio volumio[998]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} May 11 18:10:46 volumio volumio[998]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 11 18:10:46 volumio volumio[998]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 11 18:10:46 volumio volumio[998]: TypeError: Cannot read property 'length' of undefined May 11 18:10:46 volumio volumio[998]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25 May 11 18:10:46 volumio volumio[998]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13 May 11 18:10:46 volumio volumio[998]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18) May 11 18:10:46 volumio volumio[998]: at Parser.emit (events.js:315:20) May 11 18:10:46 volumio volumio[998]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26) May 11 18:10:46 volumio volumio[998]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) May 11 18:10:46 volumio volumio[998]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) May 11 18:10:46 volumio volumio[998]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) May 11 18:10:46 volumio volumio[998]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) May 11 18:10:46 volumio volumio[998]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31) May 11 18:10:46 volumio volumio[998]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) May 11 18:10:46 volumio volumio[998]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19) May 11 18:10:46 volumio volumio[998]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15) May 11 18:10:46 volumio volumio[998]: at IncomingMessage.emit (events.js:327:22) May 11 18:10:46 volumio volumio[998]: at endReadableNT (internal/streams/readable.js:1327:12) May 11 18:10:46 volumio volumio[998]: at processTicksAndRejections (internal/process/task_queues.js:80:21) May 11 18:10:46 volumio volumio[998]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 11 18:10:47 volumio sudo[1462]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-11 18:09 May 11 18:10:47 volumio sudo[1462]: 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="e32c2c71ae78852844c70357816bdd871c155ab8" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 31 Mar 2025 06:54:47 PM CEST" VOLUMIO_VERSION="3.799" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="436f3f84f6d0b4ffc344f0bc132a32e8"