-- Logs begin at Thu 2019-02-14 11:12:00 CET, end at Sun 2025-05-18 12:03:12 CEST. -- May 18 12:02:00 volumio-rpi3b ntpd[751]: Soliciting pool server 185.157.13.96 May 18 12:02:00 volumio-rpi3b ntpd[751]: Soliciting pool server 51.68.141.5 May 18 12:02:01 volumio-rpi3b volumio[1010]: error: Plugin system_controller networkfs failed to complete 'onVolumioStart' in a timely fashion May 18 12:02:01 volumio-rpi3b volumio[1010]: info: Preparing to generate the ALSA configuration file May 18 12:02:01 volumio-rpi3b volumio[1010]: info: Asound.conf file unchanged, so no further update is needed May 18 12:02:01 volumio-rpi3b volumio[1010]: info: Output device has changed, restarting MPD May 18 12:02:01 volumio-rpi3b volumio[1010]: info: Output device has changed, restarting Shairport Sync May 18 12:02:01 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 12:02:01 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 18 12:02:01 volumio-rpi3b sudo[1289]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 18 12:02:01 volumio-rpi3b sudo[1289]: pam_unix(sudo:session): session opened for user root by (uid=0) May 18 12:02:01 volumio-rpi3b sudo[1289]: pam_unix(sudo:session): session closed for user root May 18 12:02:01 volumio-rpi3b sudo[1291]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 18 12:02:01 volumio-rpi3b sudo[1291]: pam_unix(sudo:session): session opened for user root by (uid=0) May 18 12:02:01 volumio-rpi3b systemd[1]: Stopping Music Player Daemon... May 18 12:02:01 volumio-rpi3b volumio[1010]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 18 12:02:01 volumio-rpi3b volumio[1010]: info: ___________ START PLUGINS ___________ May 18 12:02:01 volumio-rpi3b volumio[1010]: info: ControllerMpd::onStart: Initializing MPD May 18 12:02:01 volumio-rpi3b volumio[1010]: info: Creating MPD Configuration file May 18 12:02:01 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 18 12:02:01 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 18 12:02:01 volumio-rpi3b volumio[1010]: info: [1747562521722] CoreMusicLibrary::Adding element Serwery Mediów May 18 12:02:01 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 18 12:02:01 volumio-rpi3b sudo[1298]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 18 12:02:01 volumio-rpi3b sudo[1298]: pam_unix(sudo:session): session opened for user root by (uid=0) May 18 12:02:01 volumio-rpi3b sudo[1298]: pam_unix(sudo:session): session closed for user root May 18 12:02:01 volumio-rpi3b sudo[1300]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 18 12:02:01 volumio-rpi3b sudo[1300]: pam_unix(sudo:session): session opened for user root by (uid=0) May 18 12:02:01 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 12:02:01 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 18 12:02:01 volumio-rpi3b systemd[1]: mpd.service: Succeeded. May 18 12:02:01 volumio-rpi3b systemd[1]: Stopped Music Player Daemon. May 18 12:02:01 volumio-rpi3b volumio[1010]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 18 12:02:01 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 12:02:01 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 18 12:02:01 volumio-rpi3b systemd[1]: Starting Music Player Daemon... May 18 12:02:02 volumio-rpi3b volumio[1010]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 18 12:02:02 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 18 12:02:02 volumio-rpi3b volumio[1010]: info: [1747562522018] CoreMusicLibrary::Adding element Last_100 May 18 12:02:02 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 18 12:02:02 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 18 12:02:02 volumio-rpi3b volumio[1010]: info: [1747562522027] CoreMusicLibrary::Adding element Webradio May 18 12:02:02 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 18 12:02:02 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 18 12:02:02 volumio-rpi3b volumio[1010]: info: Initializing BBC Radios May 18 12:02:02 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 18 12:02:02 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 18 12:02:02 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 18 12:02:02 volumio-rpi3b volumio[1010]: info: [1747562522171] CoreMusicLibrary::Adding element Radio Paradise May 18 12:02:02 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 18 12:02:02 volumio-rpi3b volumio[1010]: Cannot find translation for source Radio Paradise May 18 12:02:02 volumio-rpi3b volumio[1010]: info: Volumio Calling Home May 18 12:02:02 volumio-rpi3b sudo[1306]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log May 18 12:02:02 volumio-rpi3b sudo[1306]: pam_unix(sudo:session): session opened for user root by (uid=0) May 18 12:02:02 volumio-rpi3b sudo[1306]: pam_unix(sudo:session): session closed for user root May 18 12:02:02 volumio-rpi3b volumio[1010]: info: MPD Permissions set May 18 12:02:02 volumio-rpi3b volumio[1010]: info: MPD Permissions set May 18 12:02:02 volumio-rpi3b volumio[1010]: info: Volumio called home May 18 12:02:02 volumio-rpi3b kernel: lan78xx 1-1.1.1:1.0 eth0: Failed to write register index 0x00000120. ret = -71 May 18 12:02:02 volumio-rpi3b volumio[1010]: 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 18 12:02:02 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 12:02:02 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 12:02:02 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 12:02:02 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 12:02:02 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 12:02:02 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 12:02:02 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 12:02:02 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 12:02:02 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 18 12:02:02 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 12:02:02 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 12:02:02 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 12:02:02 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 12:02:02 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 12:02:02 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 12:02:02 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 12:02:02 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 12:02:02 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 12:02:02 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 18 12:02:02 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 12:02:03 volumio-rpi3b volumio[1010]: info: Starting Shairport Sync May 18 12:02:03 volumio-rpi3b volumio[1010]: info: Starting Shairport Sync May 18 12:02:03 volumio-rpi3b volumio[1010]: info: Starting Shairport Sync May 18 12:02:03 volumio-rpi3b sudo[1334]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 18 12:02:03 volumio-rpi3b sudo[1334]: pam_unix(sudo:session): session opened for user root by (uid=0) May 18 12:02:03 volumio-rpi3b sudo[1336]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 18 12:02:03 volumio-rpi3b sudo[1336]: pam_unix(sudo:session): session opened for user root by (uid=0) May 18 12:02:03 volumio-rpi3b sudo[1340]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 18 12:02:03 volumio-rpi3b sudo[1340]: pam_unix(sudo:session): session opened for user root by (uid=0) May 18 12:02:03 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::volumioGetState May 18 12:02:03 volumio-rpi3b volumio[1010]: info: CorePlayQueue::getTrack 0 May 18 12:02:03 volumio-rpi3b systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... May 18 12:02:03 volumio-rpi3b systemd[1]: shairport-sync.service: Succeeded. May 18 12:02:03 volumio-rpi3b systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. May 18 12:02:03 volumio-rpi3b systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. May 18 12:02:03 volumio-rpi3b sudo[1336]: pam_unix(sudo:session): session closed for user root May 18 12:02:03 volumio-rpi3b sudo[1334]: pam_unix(sudo:session): session closed for user root May 18 12:02:03 volumio-rpi3b sudo[1340]: pam_unix(sudo:session): session closed for user root May 18 12:02:03 volumio-rpi3b volumio[1010]: info: Shairport-Sync Started May 18 12:02:05 volumio-rpi3b volumio[1010]: Error adding Membership: Error: addMembership EINVAL May 18 12:02:05 volumio-rpi3b ntpd[751]: receive: Unexpected origin timestamp 0xebd42e9b.6f892896 does not match aorg 0000000000.00000000 from server@156.17.20.254 xmt 0xebd42e9d.033c86c3 May 18 12:02:05 volumio-rpi3b ntpd[751]: receive: Unexpected origin timestamp 0xebd42e9b.6fae7aab does not match aorg 0000000000.00000000 from server@193.59.134.156 xmt 0xebd42e9d.03ac6bae May 18 12:02:05 volumio-rpi3b volumio[1010]: info: Shairport-Sync Started May 18 12:02:05 volumio-rpi3b volumio[1010]: info: Shairport-Sync Started May 18 12:02:05 volumio-rpi3b ntpd[751]: receive: Unexpected origin timestamp 0xebd42e9b.6fa61c91 does not match aorg 0000000000.00000000 from server@178.215.228.24 xmt 0xebd42e9d.046079f6 May 18 12:02:06 volumio-rpi3b mpd[1323]: May 18 12:02 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg May 18 12:02:06 volumio-rpi3b systemd[1]: Started Music Player Daemon. May 18 12:02:06 volumio-rpi3b sudo[1291]: pam_unix(sudo:session): session closed for user root May 18 12:02:06 volumio-rpi3b sudo[1300]: pam_unix(sudo:session): session closed for user root May 18 12:02:06 volumio-rpi3b volumio[1010]: info: Completed starting Core Plugins May 18 12:02:06 volumio-rpi3b volumio[1010]: info: ------------------------------------------- May 18 12:02:06 volumio-rpi3b volumio[1010]: info: ----- MyVolumio plugins startup ---- May 18 12:02:06 volumio-rpi3b volumio[1010]: info: ------------------------------------------- May 18 12:02:06 volumio-rpi3b volumio[1010]: info: [MyVolumio PluginManager] Fetching plans data.... May 18 12:02:06 volumio-rpi3b volumio[1010]: error: MPD error: The expression evaluated to a falsy value: May 18 12:02:06 volumio-rpi3b volumio[1010]: assert.ok(self.idling) May 18 12:02:06 volumio-rpi3b volumio[1010]: error: The expression evaluated to a falsy value: May 18 12:02:06 volumio-rpi3b volumio[1010]: assert.ok(self.idling) May 18 12:02:06 volumio-rpi3b volumio[1010]: info: MPD running with PID1323 May 18 12:02:06 volumio-rpi3b volumio[1010]: ,establishing connection May 18 12:02:06 volumio-rpi3b volumio[1010]: error: updateQueue error: null May 18 12:02:06 volumio-rpi3b volumio[1010]: error: updateQueue error: null May 18 12:02:11 volumio-rpi3b volumio[1010]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory May 18 12:02:13 volumio-rpi3b sudo[1098]: pam_unix(sudo:session): session closed for user root May 18 12:02:13 volumio-rpi3b volumio[1010]: info: Cannot mount NAS QMUZYKA at system boot, trial number 1 ,retrying in 5 seconds May 18 12:02:13 volumio-rpi3b kernel: lan78xx 1-1.1.1:1.0 eth0: Failed to read register index 0x00000120. ret = -71 May 18 12:02:15 volumio-rpi3b volumio[1010]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium May 18 12:02:15 volumio-rpi3b volumio[1010]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium May 18 12:02:15 volumio-rpi3b volumio[1010]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium May 18 12:02:15 volumio-rpi3b volumio[1010]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium May 18 12:02:15 volumio-rpi3b volumio[1010]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium May 18 12:02:15 volumio-rpi3b volumio[1010]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium May 18 12:02:15 volumio-rpi3b volumio[1010]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium May 18 12:02:15 volumio-rpi3b volumio[1010]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium May 18 12:02:15 volumio-rpi3b volumio[1010]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium May 18 12:02:15 volumio-rpi3b volumio[1010]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium May 18 12:02:15 volumio-rpi3b volumio[1010]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium May 18 12:02:15 volumio-rpi3b volumio[1010]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar May 18 12:02:15 volumio-rpi3b volumio[1010]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar May 18 12:02:15 volumio-rpi3b volumio[1010]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar May 18 12:02:15 volumio-rpi3b volumio[1010]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar May 18 12:02:15 volumio-rpi3b volumio[1010]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar May 18 12:02:15 volumio-rpi3b volumio[1010]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar May 18 12:02:15 volumio-rpi3b volumio[1010]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar May 18 12:02:15 volumio-rpi3b volumio[1010]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar May 18 12:02:15 volumio-rpi3b volumio[1010]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar May 18 12:02:15 volumio-rpi3b volumio[1010]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar May 18 12:02:15 volumio-rpi3b volumio[1010]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar May 18 12:02:15 volumio-rpi3b volumio[1010]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso May 18 12:02:15 volumio-rpi3b volumio[1010]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso May 18 12:02:15 volumio-rpi3b volumio[1010]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso May 18 12:02:15 volumio-rpi3b volumio[1010]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso May 18 12:02:15 volumio-rpi3b volumio[1010]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso May 18 12:02:15 volumio-rpi3b volumio[1010]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso May 18 12:02:15 volumio-rpi3b volumio[1010]: info: Adding plugin bluetooth to MyMusic Plugins May 18 12:02:15 volumio-rpi3b volumio[1010]: info: Adding plugin multiroom to MyMusic Plugins May 18 12:02:15 volumio-rpi3b volumio[1010]: info: Adding plugin metavolumio to MyMusic Plugins May 18 12:02:15 volumio-rpi3b volumio[1010]: info: Adding plugin cd_controller to MyMusic Plugins May 18 12:02:15 volumio-rpi3b volumio[1010]: info: Adding plugin qobuzconnect to MyMusic Plugins May 18 12:02:15 volumio-rpi3b volumio[1010]: info: Adding plugin smart_inputs to MyMusic Plugins May 18 12:02:15 volumio-rpi3b volumio[1010]: info: Adding plugin tidalconnect to MyMusic Plugins May 18 12:02:15 volumio-rpi3b volumio[1010]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... May 18 12:02:17 volumio-rpi3b volumio[1010]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded May 18 12:02:17 volumio-rpi3b volumio[1010]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio May 18 12:02:17 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 18 12:02:17 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 18 12:02:17 volumio-rpi3b volumio[1010]: info: Starting MyVolumio Remote Streaming Endpoints May 18 12:02:17 volumio-rpi3b volumio[1010]: info: MyVolumio login type: Token May 18 12:02:18 volumio-rpi3b volumio[1010]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started May 18 12:02:18 volumio-rpi3b volumio[1010]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... May 18 12:02:20 volumio-rpi3b volumio[1010]: info: Starting Streaming Service Transparent Proxy May 18 12:02:20 volumio-rpi3b volumio[1010]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded May 18 12:02:20 volumio-rpi3b volumio[1010]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services May 18 12:02:20 volumio-rpi3b volumio[1010]: info: Streaming services startup May 18 12:02:20 volumio-rpi3b volumio[1010]: info: Starting Streaming Daemon May 18 12:02:20 volumio-rpi3b sudo[1388]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service May 18 12:02:20 volumio-rpi3b sudo[1388]: pam_unix(sudo:session): session opened for user root by (uid=0) May 18 12:02:20 volumio-rpi3b volumio[1010]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started May 18 12:02:20 volumio-rpi3b sudo[1388]: pam_unix(sudo:session): session closed for user root May 18 12:02:21 volumio-rpi3b sudo[1396]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t nfs -o ro,soft,noauto,vers=2.1 192.168.1.201:Multimedia\\Muzyka /mnt/NAS/QMUZYKA May 18 12:02:21 volumio-rpi3b sudo[1396]: pam_unix(sudo:session): session opened for user root by (uid=0) May 18 12:02:21 volumio-rpi3b volumio[1010]: error: Cannot start Volumio Streaming Daemon May 18 12:02:21 volumio-rpi3b volumio[1010]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service May 18 12:02:21 volumio-rpi3b volumio[1010]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. May 18 12:02:21 volumio-rpi3b volumio[1010]: error: MyVolumio Custom Token format not valid, refreshing it May 18 12:02:22 volumio-rpi3b volumio[1010]: info: MyVolumio login type: Token May 18 12:02:22 volumio-rpi3b volumio[1010]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN May 18 12:02:23 volumio-rpi3b volumio[1010]: STREAMING PROXY: Starting server on port 3245 May 18 12:02:23 volumio-rpi3b volumio[1010]: Node JS runtime: 14 May 18 12:02:23 volumio-rpi3b volumio[1010]: info: MyVolumio token set successfully May 18 12:02:23 volumio-rpi3b volumio[1010]: info: MYVOLUMIO: Adding device May 18 12:02:23 volumio-rpi3b volumio[1010]: info: MYVOLUMIO: Evaluating Server May 18 12:02:24 volumio-rpi3b volumio[1010]: info: MyVolumio status changed May 18 12:02:24 volumio-rpi3b volumio[1010]: info: Streaming services startup May 18 12:02:24 volumio-rpi3b volumio[1010]: info: Starting Streaming Daemon May 18 12:02:24 volumio-rpi3b volumio[1010]: info: Removing browser output: myVolumio user plan is not superstar May 18 12:02:24 volumio-rpi3b volumio[1010]: info: Removing audio output: May 18 12:02:24 volumio-rpi3b volumio[1010]: info: Stoppping Tunnel 1 May 18 12:02:24 volumio-rpi3b sudo[1417]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service May 18 12:02:24 volumio-rpi3b sudo[1417]: pam_unix(sudo:session): session opened for user root by (uid=0) May 18 12:02:24 volumio-rpi3b sudo[1419]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service May 18 12:02:24 volumio-rpi3b sudo[1419]: pam_unix(sudo:session): session opened for user root by (uid=0) May 18 12:02:24 volumio-rpi3b volumio[1010]: info: Preload queue cleared May 18 12:02:24 volumio-rpi3b sudo[1417]: pam_unix(sudo:session): session closed for user root May 18 12:02:24 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::volumioReplaceandPlayItems May 18 12:02:24 volumio-rpi3b volumio[1010]: info: CoreStateMachine::ClearQueue May 18 12:02:24 volumio-rpi3b volumio[1010]: info: CoreStateMachine::stop May 18 12:02:24 volumio-rpi3b volumio[1010]: info: CoreStateMachine::setConsumeUpdateService undefined May 18 12:02:24 volumio-rpi3b volumio[1010]: info: CorePlayQueue::clearPlayQueue May 18 12:02:24 volumio-rpi3b volumio[1010]: info: CorePlayQueue::saveQueue May 18 12:02:24 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::volumioPushQueue May 18 12:02:24 volumio-rpi3b volumio[1010]: info: CoreStateMachine::addQueueItems May 18 12:02:24 volumio-rpi3b volumio[1010]: info: CorePlayQueue::addQueueItems May 18 12:02:24 volumio-rpi3b volumio[1010]: info: Preload queue cleared May 18 12:02:24 volumio-rpi3b volumio[1010]: info: Adding Item to queue: webrp/0 May 18 12:02:24 volumio-rpi3b volumio[1010]: info: Exploding uri webrp/0 in service radio_paradise May 18 12:02:24 volumio-rpi3b sudo[1419]: pam_unix(sudo:session): session closed for user root May 18 12:02:24 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::volumioPushQueue May 18 12:02:24 volumio-rpi3b volumio[1010]: info: CorePlayQueue::saveQueue May 18 12:02:24 volumio-rpi3b volumio[1010]: info: CoreStateMachine::updateTrackBlock May 18 12:02:24 volumio-rpi3b volumio[1010]: info: CorePlayQueue::getTrackBlock May 18 12:02:24 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::volumioPlay May 18 12:02:24 volumio-rpi3b volumio[1010]: info: CoreStateMachine::play index 0 May 18 12:02:24 volumio-rpi3b volumio[1010]: info: CoreStateMachine::setConsumeUpdateService undefined May 18 12:02:24 volumio-rpi3b volumio[1010]: info: CoreStateMachine::stop May 18 12:02:24 volumio-rpi3b volumio[1010]: info: CoreStateMachine::setConsumeUpdateService undefined May 18 12:02:24 volumio-rpi3b volumio[1010]: info: CoreStateMachine::play index undefined May 18 12:02:24 volumio-rpi3b volumio[1010]: info: CoreStateMachine::setConsumeUpdateService undefined May 18 12:02:24 volumio-rpi3b volumio[1010]: info: CorePlayQueue::getTrack 0 May 18 12:02:24 volumio-rpi3b volumio[1010]: info: CoreStateMachine::startPlaybackTimer May 18 12:02:24 volumio-rpi3b volumio[1010]: info: CorePlayQueue::getTrack 0 May 18 12:02:24 volumio-rpi3b volumio[1010]: verbose: ControllerMpd::sendMpdCommand stop May 18 12:02:24 volumio-rpi3b volumio[1010]: info: sendMpdCommand stop took 22 milliseconds May 18 12:02:24 volumio-rpi3b volumio[1010]: verbose: ControllerMpd::sendMpdCommand clear May 18 12:02:24 volumio-rpi3b volumio[1010]: info: Remote SSH Stopped May 18 12:02:24 volumio-rpi3b volumio[1010]: error: Cannot start Volumio Streaming Daemon May 18 12:02:24 volumio-rpi3b volumio[1010]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service May 18 12:02:24 volumio-rpi3b volumio[1010]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. May 18 12:02:24 volumio-rpi3b volumio[1010]: info: May 18 12:02:24 volumio-rpi3b volumio[1010]: ---------------------------- MPD announces system playlist update May 18 12:02:24 volumio-rpi3b volumio[1010]: info: Ignoring MPD Status Update May 18 12:02:24 volumio-rpi3b volumio[1010]: info: sendMpdCommand clear took 24 milliseconds May 18 12:02:24 volumio-rpi3b volumio[1010]: verbose: ControllerMpd::sendMpdCommand consume 1 May 18 12:02:24 volumio-rpi3b volumio[1010]: info: May 18 12:02:24 volumio-rpi3b volumio[1010]: ---------------------------- MPD announces system playlist update May 18 12:02:24 volumio-rpi3b volumio[1010]: info: Ignoring MPD Status Update May 18 12:02:24 volumio-rpi3b volumio[1010]: info: May 18 12:02:24 volumio-rpi3b volumio[1010]: ---------------------------- MPD announces system playlist update May 18 12:02:24 volumio-rpi3b volumio[1010]: info: Ignoring MPD Status Update May 18 12:02:24 volumio-rpi3b volumio[1010]: error: updateQueue error: null May 18 12:02:24 volumio-rpi3b volumio[1010]: info: May 18 12:02:24 volumio-rpi3b volumio[1010]: ---------------------------- MPD announces state update: options May 18 12:02:24 volumio-rpi3b volumio[1010]: error: updateQueue error: null May 18 12:02:24 volumio-rpi3b volumio[1010]: error: updateQueue error: null May 18 12:02:24 volumio-rpi3b volumio[1010]: info: ------------------------------ 33ms May 18 12:02:24 volumio-rpi3b volumio[1010]: info: sendMpdCommand consume 1 took 28 milliseconds May 18 12:02:24 volumio-rpi3b volumio[1010]: info: ControllerMpd::getState May 18 12:02:24 volumio-rpi3b volumio[1010]: verbose: ControllerMpd::sendMpdCommand status May 18 12:02:24 volumio-rpi3b volumio[1010]: info: ------------------------------ 29ms May 18 12:02:24 volumio-rpi3b volumio[1010]: info: ------------------------------ 27ms May 18 12:02:24 volumio-rpi3b volumio[1010]: info: [1747562544884] [RadioParadise] set to consume mode, adding url: https://stream.radioparadise.com/flac May 18 12:02:24 volumio-rpi3b volumio[1010]: verbose: ControllerMpd::sendMpdCommand add "https://stream.radioparadise.com/flac" May 18 12:02:24 volumio-rpi3b volumio[1010]: info: May 18 12:02:24 volumio-rpi3b volumio[1010]: ---------------------------- MPD announces state update: options May 18 12:02:24 volumio-rpi3b volumio[1010]: info: ControllerMpd::getState May 18 12:02:24 volumio-rpi3b volumio[1010]: verbose: ControllerMpd::sendMpdCommand status May 18 12:02:24 volumio-rpi3b volumio[1010]: info: May 18 12:02:24 volumio-rpi3b volumio[1010]: ---------------------------- MPD announces state update: options May 18 12:02:24 volumio-rpi3b volumio[1010]: info: ControllerMpd::getState May 18 12:02:24 volumio-rpi3b volumio[1010]: verbose: ControllerMpd::sendMpdCommand status May 18 12:02:24 volumio-rpi3b volumio[1010]: info: May 18 12:02:24 volumio-rpi3b volumio[1010]: ---------------------------- MPD announces system playlist update May 18 12:02:24 volumio-rpi3b volumio[1010]: info: Ignoring MPD Status Update May 18 12:02:24 volumio-rpi3b volumio[1010]: info: sendMpdCommand status took 22 milliseconds May 18 12:02:24 volumio-rpi3b volumio[1010]: info: sendMpdCommand add "https://stream.radioparadise.com/flac" took 19 milliseconds May 18 12:02:24 volumio-rpi3b volumio[1010]: info: sendMpdCommand status took 15 milliseconds May 18 12:02:24 volumio-rpi3b volumio[1010]: info: sendMpdCommand status took 12 milliseconds May 18 12:02:24 volumio-rpi3b volumio[1010]: verbose: ControllerMpd::parseState May 18 12:02:24 volumio-rpi3b volumio[1010]: verbose: ControllerMpd::sendMpdCommand play May 18 12:02:24 volumio-rpi3b volumio[1010]: verbose: ControllerMpd::parseState May 18 12:02:24 volumio-rpi3b volumio[1010]: verbose: ControllerMpd::parseState May 18 12:02:24 volumio-rpi3b volumio[1010]: info: ControllerMpd::pushState May 18 12:02:24 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::servicePushState May 18 12:02:24 volumio-rpi3b volumio[1010]: info: CoreStateMachine::pushState May 18 12:02:24 volumio-rpi3b volumio[1010]: info: CorePlayQueue::getTrack 0 May 18 12:02:24 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::volumioPushState May 18 12:02:24 volumio-rpi3b volumio[1010]: info: CorePlayQueue::getTrack 0 May 18 12:02:24 volumio-rpi3b volumio[1010]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd May 18 12:02:24 volumio-rpi3b volumio[1010]: info: ControllerMpd::pushState May 18 12:02:24 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::servicePushState May 18 12:02:24 volumio-rpi3b volumio[1010]: info: CoreStateMachine::pushState May 18 12:02:24 volumio-rpi3b volumio[1010]: info: CorePlayQueue::getTrack 0 May 18 12:02:24 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::volumioPushState May 18 12:02:24 volumio-rpi3b volumio[1010]: info: CorePlayQueue::getTrack 0 May 18 12:02:24 volumio-rpi3b volumio[1010]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd May 18 12:02:24 volumio-rpi3b volumio[1010]: info: ControllerMpd::pushState May 18 12:02:24 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::servicePushState May 18 12:02:24 volumio-rpi3b volumio[1010]: info: CoreStateMachine::pushState May 18 12:02:24 volumio-rpi3b volumio[1010]: info: CorePlayQueue::getTrack 0 May 18 12:02:24 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::volumioPushState May 18 12:02:24 volumio-rpi3b volumio[1010]: info: CorePlayQueue::getTrack 0 May 18 12:02:24 volumio-rpi3b volumio[1010]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd May 18 12:02:24 volumio-rpi3b volumio[1010]: info: ------------------------------ 99ms May 18 12:02:24 volumio-rpi3b volumio[1010]: info: ------------------------------ 91ms May 18 12:02:24 volumio-rpi3b volumio[1010]: info: ------------------------------ 88ms May 18 12:02:24 volumio-rpi3b volumio[1010]: info: May 18 12:02:24 volumio-rpi3b volumio[1010]: ---------------------------- MPD announces system playlist update May 18 12:02:24 volumio-rpi3b volumio[1010]: info: Ignoring MPD Status Update May 18 12:02:24 volumio-rpi3b volumio[1010]: info: May 18 12:02:24 volumio-rpi3b volumio[1010]: ---------------------------- MPD announces system playlist update May 18 12:02:24 volumio-rpi3b volumio[1010]: info: Ignoring MPD Status Update May 18 12:02:24 volumio-rpi3b volumio[1010]: info: ------------------------------ 95ms May 18 12:02:24 volumio-rpi3b volumio[1010]: info: sendMpdCommand play took 75 milliseconds May 18 12:02:24 volumio-rpi3b volumio[1010]: info: ------------------------------ 13ms May 18 12:02:24 volumio-rpi3b volumio[1010]: info: ------------------------------ 11ms May 18 12:02:24 volumio-rpi3b volumio[1010]: info: [1747562544999] [RadioParadise] getMetadata started with url https://api.radioparadise.com/api/now_playing?chan=0 May 18 12:02:25 volumio-rpi3b volumio[1010]: info: Setting Geolocation for MyVolumio to eu7 May 18 12:02:25 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 18 12:02:25 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 18 12:02:25 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 18 12:02:25 volumio-rpi3b volumio[1010]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} May 18 12:02:25 volumio-rpi3b volumio[1010]: info: [1747562545655] [RadioParadise] received new metadata: {"time":91,"artist":"Medeski Martin & Wood","title":"Mami Gato","album":"End of the World Party (Just in Case)","year":"2004","cover":"https://img.radioparadise.com/covers/l/B0002QO4B8.jpg","cover_med":"https://img.radioparadise.com/covers/m/B0002QO4B8.jpg","cover_small":"https://img.radioparadise.com/covers/s/B0002QO4B8.jpg"} May 18 12:02:25 volumio-rpi3b volumio[1010]: info: CorePlayQueue::getTrack 0 May 18 12:02:25 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::servicePushState May 18 12:02:25 volumio-rpi3b volumio[1010]: info: CorePlayQueue::getTrack 0 May 18 12:02:25 volumio-rpi3b volumio[1010]: verbose: STATE SERVICE {"status":"play","service":"radio_paradise","type":"webradio","trackType":"flac","radioType":"rparadise","albumart":"https://img.radioparadise.com/covers/l/B0002QO4B8.jpg","uri":"https://stream.radioparadise.com/flac","name":"Mami Gato","title":"Mami Gato","artist":"Medeski Martin & Wood","album":"End of the World Party (Just in Case)","streaming":true,"disableUiControls":true,"duration":96,"seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} May 18 12:02:25 volumio-rpi3b volumio[1010]: verbose: CURRENT POSITION 0 May 18 12:02:25 volumio-rpi3b volumio[1010]: info: CoreStateMachine::syncState stateService play May 18 12:02:25 volumio-rpi3b volumio[1010]: info: CoreStateMachine::syncState currentStatus stop May 18 12:02:25 volumio-rpi3b volumio[1010]: info: [1747562545667] [RadioParadise] setting new timer with duration of 96000 seconds. May 18 12:02:26 volumio-rpi3b volumio[1010]: info: Updating MyVolumio device info May 18 12:02:26 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 18 12:02:26 volumio-rpi3b volumio[1010]: info: May 18 12:02:26 volumio-rpi3b volumio[1010]: ---------------------------- MPD announces state update: player May 18 12:02:26 volumio-rpi3b volumio[1010]: info: ControllerMpd::getState May 18 12:02:26 volumio-rpi3b volumio[1010]: verbose: ControllerMpd::sendMpdCommand status May 18 12:02:26 volumio-rpi3b volumio[1010]: info: May 18 12:02:26 volumio-rpi3b volumio[1010]: ---------------------------- MPD announces state update: player May 18 12:02:26 volumio-rpi3b volumio[1010]: info: ControllerMpd::getState May 18 12:02:26 volumio-rpi3b volumio[1010]: verbose: ControllerMpd::sendMpdCommand status May 18 12:02:26 volumio-rpi3b volumio[1010]: info: May 18 12:02:26 volumio-rpi3b volumio[1010]: ---------------------------- MPD announces state update: player May 18 12:02:26 volumio-rpi3b volumio[1010]: info: ControllerMpd::getState May 18 12:02:26 volumio-rpi3b volumio[1010]: verbose: ControllerMpd::sendMpdCommand status May 18 12:02:26 volumio-rpi3b volumio[1010]: info: sendMpdCommand status took 66 milliseconds May 18 12:02:26 volumio-rpi3b volumio[1010]: verbose: ControllerMpd::parseState May 18 12:02:26 volumio-rpi3b volumio[1010]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 18 12:02:26 volumio-rpi3b volumio[1010]: info: May 18 12:02:26 volumio-rpi3b volumio[1010]: ---------------------------- MPD announces system playlist update May 18 12:02:26 volumio-rpi3b volumio[1010]: info: Ignoring MPD Status Update May 18 12:02:26 volumio-rpi3b volumio[1010]: info: May 18 12:02:26 volumio-rpi3b volumio[1010]: ---------------------------- MPD announces state update: player May 18 12:02:26 volumio-rpi3b volumio[1010]: info: ControllerMpd::getState May 18 12:02:26 volumio-rpi3b volumio[1010]: verbose: ControllerMpd::sendMpdCommand status May 18 12:02:26 volumio-rpi3b volumio[1010]: info: sendMpdCommand status took 72 milliseconds May 18 12:02:26 volumio-rpi3b volumio[1010]: info: sendMpdCommand status took 67 milliseconds May 18 12:02:26 volumio-rpi3b volumio[1010]: info: sendMpdCommand playlistinfo took 9 milliseconds May 18 12:02:26 volumio-rpi3b volumio[1010]: verbose: ControllerMpd::parseState May 18 12:02:26 volumio-rpi3b volumio[1010]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 18 12:02:26 volumio-rpi3b volumio[1010]: verbose: ControllerMpd::parseState May 18 12:02:26 volumio-rpi3b volumio[1010]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 18 12:02:26 volumio-rpi3b volumio[1010]: verbose: ControllerMpd::parseTrackInfo May 18 12:02:26 volumio-rpi3b volumio[1010]: info: ControllerMpd::pushState May 18 12:02:26 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::servicePushState May 18 12:02:26 volumio-rpi3b volumio[1010]: info: CorePlayQueue::getTrack 0 May 18 12:02:26 volumio-rpi3b volumio[1010]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd May 18 12:02:26 volumio-rpi3b volumio[1010]: info: ------------------------------ 96ms May 18 12:02:26 volumio-rpi3b volumio[1010]: info: May 18 12:02:26 volumio-rpi3b volumio[1010]: ---------------------------- MPD announces system playlist update May 18 12:02:26 volumio-rpi3b volumio[1010]: info: Ignoring MPD Status Update May 18 12:02:26 volumio-rpi3b volumio[1010]: info: May 18 12:02:26 volumio-rpi3b volumio[1010]: ---------------------------- MPD announces state update: player May 18 12:02:26 volumio-rpi3b volumio[1010]: info: ControllerMpd::getState May 18 12:02:26 volumio-rpi3b volumio[1010]: verbose: ControllerMpd::sendMpdCommand status May 18 12:02:26 volumio-rpi3b volumio[1010]: info: May 18 12:02:26 volumio-rpi3b volumio[1010]: ---------------------------- MPD announces system playlist update May 18 12:02:26 volumio-rpi3b volumio[1010]: info: Ignoring MPD Status Update May 18 12:02:26 volumio-rpi3b volumio[1010]: info: May 18 12:02:26 volumio-rpi3b volumio[1010]: ---------------------------- MPD announces state update: player May 18 12:02:26 volumio-rpi3b volumio[1010]: info: ControllerMpd::getState May 18 12:02:26 volumio-rpi3b volumio[1010]: verbose: ControllerMpd::sendMpdCommand status May 18 12:02:26 volumio-rpi3b volumio[1010]: info: ------------------------------ 41ms May 18 12:02:26 volumio-rpi3b volumio[1010]: info: sendMpdCommand status took 38 milliseconds May 18 12:02:26 volumio-rpi3b volumio[1010]: info: sendMpdCommand playlistinfo took 31 milliseconds May 18 12:02:26 volumio-rpi3b volumio[1010]: info: sendMpdCommand playlistinfo took 30 milliseconds May 18 12:02:26 volumio-rpi3b volumio[1010]: info: ------------------------------ 20ms May 18 12:02:26 volumio-rpi3b volumio[1010]: info: sendMpdCommand status took 15 milliseconds May 18 12:02:26 volumio-rpi3b volumio[1010]: info: ------------------------------ 14ms May 18 12:02:26 volumio-rpi3b volumio[1010]: info: sendMpdCommand status took 11 milliseconds May 18 12:02:26 volumio-rpi3b volumio[1010]: verbose: ControllerMpd::parseState May 18 12:02:26 volumio-rpi3b volumio[1010]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 18 12:02:26 volumio-rpi3b volumio[1010]: verbose: ControllerMpd::parseTrackInfo May 18 12:02:26 volumio-rpi3b volumio[1010]: verbose: ControllerMpd::parseTrackInfo May 18 12:02:26 volumio-rpi3b volumio[1010]: verbose: ControllerMpd::parseState May 18 12:02:26 volumio-rpi3b volumio[1010]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 18 12:02:26 volumio-rpi3b volumio[1010]: verbose: ControllerMpd::parseState May 18 12:02:26 volumio-rpi3b volumio[1010]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 18 12:02:26 volumio-rpi3b volumio[1010]: info: ControllerMpd::pushState May 18 12:02:26 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::servicePushState May 18 12:02:26 volumio-rpi3b volumio[1010]: info: CorePlayQueue::getTrack 0 May 18 12:02:26 volumio-rpi3b volumio[1010]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd May 18 12:02:26 volumio-rpi3b volumio[1010]: info: ControllerMpd::pushState May 18 12:02:26 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::servicePushState May 18 12:02:26 volumio-rpi3b volumio[1010]: info: CorePlayQueue::getTrack 0 May 18 12:02:26 volumio-rpi3b volumio[1010]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd May 18 12:02:26 volumio-rpi3b volumio[1010]: info: ------------------------------ 131ms May 18 12:02:26 volumio-rpi3b volumio[1010]: info: ------------------------------ 126ms May 18 12:02:26 volumio-rpi3b volumio[1010]: info: sendMpdCommand playlistinfo took 18 milliseconds May 18 12:02:26 volumio-rpi3b volumio[1010]: info: sendMpdCommand playlistinfo took 16 milliseconds May 18 12:02:26 volumio-rpi3b volumio[1010]: info: sendMpdCommand playlistinfo took 15 milliseconds May 18 12:02:26 volumio-rpi3b volumio[1010]: verbose: ControllerMpd::parseTrackInfo May 18 12:02:26 volumio-rpi3b volumio[1010]: verbose: ControllerMpd::parseTrackInfo May 18 12:02:26 volumio-rpi3b volumio[1010]: verbose: ControllerMpd::parseTrackInfo May 18 12:02:26 volumio-rpi3b volumio[1010]: info: ControllerMpd::pushState May 18 12:02:26 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::servicePushState May 18 12:02:26 volumio-rpi3b volumio[1010]: info: CorePlayQueue::getTrack 0 May 18 12:02:26 volumio-rpi3b volumio[1010]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd May 18 12:02:26 volumio-rpi3b volumio[1010]: info: ControllerMpd::pushState May 18 12:02:26 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::servicePushState May 18 12:02:26 volumio-rpi3b volumio[1010]: info: CorePlayQueue::getTrack 0 May 18 12:02:26 volumio-rpi3b volumio[1010]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd May 18 12:02:26 volumio-rpi3b volumio[1010]: info: ControllerMpd::pushState May 18 12:02:26 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::servicePushState May 18 12:02:26 volumio-rpi3b volumio[1010]: info: CorePlayQueue::getTrack 0 May 18 12:02:26 volumio-rpi3b volumio[1010]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd May 18 12:02:26 volumio-rpi3b volumio[1010]: info: ------------------------------ 80ms May 18 12:02:26 volumio-rpi3b volumio[1010]: info: ------------------------------ 56ms May 18 12:02:26 volumio-rpi3b volumio[1010]: info: ------------------------------ 51ms May 18 12:02:26 volumio-rpi3b volumio[1010]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} May 18 12:02:27 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::volumioGetState May 18 12:02:27 volumio-rpi3b volumio[1010]: info: CorePlayQueue::getTrack 0 May 18 12:02:29 volumio-rpi3b volumio[1010]: info: MYVOLUMIO: Adding device May 18 12:02:29 volumio-rpi3b volumio[1010]: info: MYVOLUMIO: Evaluating Server May 18 12:02:30 volumio-rpi3b volumio[1010]: info: Setting Geolocation for MyVolumio to eu6 May 18 12:02:30 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 18 12:02:30 volumio-rpi3b volumio[1010]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} May 18 12:02:31 volumio-rpi3b volumio[1010]: info: Updating MyVolumio device info May 18 12:02:31 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 18 12:02:31 volumio-rpi3b volumio[1010]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} May 18 12:02:31 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::getUIConfigOnPlugin May 18 12:02:31 volumio-rpi3b volumio[1010]: info: Retrieving Cloud Streaming UI May 18 12:02:31 volumio-rpi3b volumio[1010]: info: Getting Tidal Cloud Configuration May 18 12:02:31 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::getUIConfigOnPlugin May 18 12:02:31 volumio-rpi3b volumio[1010]: info: Getting Qobuz Cloud Configuration May 18 12:02:31 volumio-rpi3b volumio[1010]: info: Asking plugin for UI Config May 18 12:02:31 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::getUIConfigOnPlugin May 18 12:02:31 volumio-rpi3b volumio[1010]: info: Getting Spotify Cloud Configuration May 18 12:02:31 volumio-rpi3b volumio[1010]: info: Asking plugin for UI Config May 18 12:02:31 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::getUIConfigOnPlugin May 18 12:02:31 volumio-rpi3b volumio[1010]: info: Saving Spotify Acccount May 18 12:02:31 volumio-rpi3b volumio[1010]: info: Got Tidal Cloud Configuration May 18 12:02:31 volumio-rpi3b volumio[1010]: info: Got it May 18 12:02:31 volumio-rpi3b volumio[1010]: info: Got it May 18 12:02:31 volumio-rpi3b volumio[1010]: error: Could not retrieve Spotify Config from plugin Spotify: no section found May 18 12:02:31 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::getUIConfigOnPlugin May 18 12:02:31 volumio-rpi3b volumio[1010]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined May 18 12:02:32 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 18 12:02:32 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 18 12:02:32 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 18 12:02:32 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 18 12:02:32 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 18 12:02:32 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 18 12:02:32 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 18 12:02:32 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 18 12:02:32 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::volumioGetBrowseSources May 18 12:02:32 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::volumioGetBrowseSources May 18 12:02:32 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::volumioGetBrowseSources May 18 12:02:32 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 18 12:02:32 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares May 18 12:02:32 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 18 12:02:32 volumio-rpi3b volumio[1010]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 May 18 12:02:33 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::volumioGetState May 18 12:02:33 volumio-rpi3b volumio[1010]: info: CorePlayQueue::getTrack 0 May 18 12:02:33 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 18 12:02:33 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 18 12:02:33 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 18 12:02:34 volumio-rpi3b volumio-remote-updater[567]: No test mode May 18 12:02:34 volumio-rpi3b volumio-remote-updater[567]: No alpha test mode May 18 12:02:34 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled May 18 12:02:34 volumio-rpi3b volumio[1010]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} May 18 12:02:34 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache May 18 12:02:36 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 18 12:02:37 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: networkfs , deleteShare May 18 12:02:37 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 12:02:37 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam May 18 12:02:37 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam May 18 12:02:37 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject May 18 12:02:37 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::volumioGetBrowseSources May 18 12:02:37 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 18 12:02:38 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares May 18 12:02:40 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares May 18 12:02:40 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService May 18 12:02:40 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 18 12:02:40 volumio-rpi3b volumio[1010]: error: MyVolumio Plugin failed to authenticate in a timely fashion May 18 12:02:40 volumio-rpi3b volumio[1010]: info: Completed starting MyVolumio Plugin May 18 12:02:40 volumio-rpi3b volumio[1010]: [Metrics] CommandRouter: 79s 560.14ms May 18 12:02:40 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::volumiosetStartupVolume May 18 12:02:40 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 12:02:40 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 18 12:02:40 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::Close All Modals sent May 18 12:02:41 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::Close All Modals sent May 18 12:02:41 volumio-rpi3b volumio[1010]: info: Cannot play startup sound: Error: Command failed: /usr/bin/aplay -D volumio /volumio/app/startup.wav May 18 12:02:41 volumio-rpi3b volumio[1010]: aplay: main:828: audio open error: Device or resource busy May 18 12:02:41 volumio-rpi3b volumio[1010]: info: Executing SMB command: smbclient --no-pass --debuglevel=0 -L QNAS.local. May 18 12:02:42 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable May 18 12:02:42 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 18 12:02:42 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect May 18 12:02:42 volumio-rpi3b volumio[1010]: info: Version has changed, forcing UI Reload May 18 12:02:42 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::Reload Ui May 18 12:02:42 volumio-rpi3b volumio[1201]: .......................................................................................................................................................................................................................................++++ May 18 12:02:43 volumio-rpi3b sudo[1491]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 18 12:02:43 volumio-rpi3b sudo[1491]: pam_unix(sudo:session): session opened for user root by (uid=0) May 18 12:02:43 volumio-rpi3b sudo[1493]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 18 12:02:43 volumio-rpi3b sudo[1493]: pam_unix(sudo:session): session opened for user root by (uid=0) May 18 12:02:43 volumio-rpi3b sudo[1493]: pam_unix(sudo:session): session closed for user root May 18 12:02:43 volumio-rpi3b sudo[1491]: pam_unix(sudo:session): session closed for user root May 18 12:02:43 volumio-rpi3b volumio[1010]: verbose: New Socket.io Connection to 192.168.1.252 from 192.168.1.169 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/133.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 May 18 12:02:43 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 18 12:02:44 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::volumioGetVisibleSources May 18 12:02:44 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 18 12:02:44 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::volumioGetState May 18 12:02:44 volumio-rpi3b volumio[1010]: info: CorePlayQueue::getTrack 0 May 18 12:02:44 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 18 12:02:44 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::getUIConfigOnPlugin May 18 12:02:44 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::getUIConfigOnPlugin May 18 12:02:44 volumio-rpi3b volumio[1010]: info: Retrieving Cloud Streaming UI May 18 12:02:44 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 18 12:02:44 volumio-rpi3b volumio[1010]: info: Received Get System Info May 18 12:02:44 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 18 12:02:44 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 18 12:02:44 volumio-rpi3b volumio[1010]: info: Discovery: Getting this device information May 18 12:02:44 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::volumioGetState May 18 12:02:44 volumio-rpi3b volumio[1010]: info: CorePlayQueue::getTrack 0 May 18 12:02:44 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 18 12:02:44 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::volumioGetState May 18 12:02:44 volumio-rpi3b volumio[1010]: info: CorePlayQueue::getTrack 0 May 18 12:02:44 volumio-rpi3b volumio[1010]: info: Listing playlists May 18 12:02:44 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 18 12:02:44 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 18 12:02:44 volumio-rpi3b volumio[1010]: info: Getting Tidal Cloud Configuration May 18 12:02:44 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::getUIConfigOnPlugin May 18 12:02:44 volumio-rpi3b volumio[1010]: info: Getting Qobuz Cloud Configuration May 18 12:02:44 volumio-rpi3b volumio[1010]: info: Asking plugin for UI Config May 18 12:02:44 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::getUIConfigOnPlugin May 18 12:02:44 volumio-rpi3b volumio[1010]: info: Getting Spotify Cloud Configuration May 18 12:02:44 volumio-rpi3b volumio[1010]: info: Asking plugin for UI Config May 18 12:02:44 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::getUIConfigOnPlugin May 18 12:02:44 volumio-rpi3b volumio[1010]: info: Saving Spotify Acccount May 18 12:02:44 volumio-rpi3b volumio[1010]: info: Got Tidal Cloud Configuration May 18 12:02:44 volumio-rpi3b volumio[1010]: info: Got it May 18 12:02:44 volumio-rpi3b volumio[1010]: info: Got it May 18 12:02:44 volumio-rpi3b volumio[1010]: error: Could not retrieve Spotify Config from plugin Spotify: no section found May 18 12:02:44 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache May 18 12:02:44 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::getUIConfigOnPlugin May 18 12:02:44 volumio-rpi3b volumio[1010]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined May 18 12:02:44 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 18 12:02:44 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 18 12:02:44 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 18 12:02:44 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 18 12:02:44 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 18 12:02:44 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 18 12:02:44 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 18 12:02:44 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 18 12:02:44 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::volumioGetBrowseSources May 18 12:02:44 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::volumioGetBrowseSources May 18 12:02:44 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::volumioGetBrowseSources May 18 12:02:44 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 18 12:02:44 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares May 18 12:02:45 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 18 12:02:45 volumio-rpi3b volumio[1010]: info: Received Get System Info May 18 12:02:45 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 18 12:02:45 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 18 12:02:45 volumio-rpi3b volumio[1010]: info: Discovery: Getting this device information May 18 12:02:45 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::volumioGetState May 18 12:02:45 volumio-rpi3b volumio[1010]: info: CorePlayQueue::getTrack 0 May 18 12:02:45 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 18 12:02:45 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard May 18 12:02:46 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 18 12:02:46 volumio-rpi3b volumio[1010]: info: Received Get System Info May 18 12:02:46 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 18 12:02:46 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 18 12:02:46 volumio-rpi3b volumio[1010]: info: Discovery: Getting this device information May 18 12:02:46 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::volumioGetState May 18 12:02:46 volumio-rpi3b volumio[1010]: info: CorePlayQueue::getTrack 0 May 18 12:02:46 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 18 12:02:47 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares May 18 12:02:47 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService May 18 12:02:48 volumio-rpi3b volumio[1010]: info: BOOT COMPLETED May 18 12:02:48 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 18 12:02:49 volumio-rpi3b volumio[1010]: info: Executing SMB command: smbclient --no-pass --debuglevel=0 -L QNAS.local. May 18 12:02:52 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 18 12:02:53 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 18 12:02:56 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 18 12:03:00 volumio-rpi3b volumio[1201]: ..............................................................++++ May 18 12:03:00 volumio-rpi3b volumio[1201]: e is 65537 (0x010001) May 18 12:03:00 volumio-rpi3b volumio[1201]: writing RSA key May 18 12:03:00 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 18 12:03:01 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 18 12:03:01 volumio-rpi3b volumio[1010]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined May 18 12:03:01 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates May 18 12:03:01 volumio-rpi3b volumio[1010]: info: Received Get System Version May 18 12:03:01 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 18 12:03:01 volumio-rpi3b volumio[1010]: info: Received Get System Info May 18 12:03:01 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 18 12:03:01 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 18 12:03:01 volumio-rpi3b volumio[1010]: info: Discovery: Getting this device information May 18 12:03:01 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::volumioGetState May 18 12:03:01 volumio-rpi3b volumio[1010]: info: CorePlayQueue::getTrack 0 May 18 12:03:01 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 18 12:03:04 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 18 12:03:06 volumio-rpi3b sudo[1396]: pam_unix(sudo:session): session closed for user root May 18 12:03:06 volumio-rpi3b volumio[1010]: info: Cannot mount NAS QMUZYKA at system boot, trial number 2 ,retrying in 5 seconds May 18 12:03:08 volumio-rpi3b volumio[1010]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 18 12:03:11 volumio-rpi3b volumio[1010]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 18 12:03:11 volumio-rpi3b volumio[1010]: TypeError: Cannot read property 'replace' of undefined May 18 12:03:11 volumio-rpi3b volumio[1010]: at ControllerNetworkfs.mountShare (/volumio/app/plugins/system_controller/networkfs/index.js:202:28) May 18 12:03:11 volumio-rpi3b volumio[1010]: at Timeout._onTimeout (/volumio/app/plugins/system_controller/networkfs/index.js:255:20) May 18 12:03:11 volumio-rpi3b volumio[1010]: at listOnTimeout (internal/timers.js:554:17) May 18 12:03:11 volumio-rpi3b volumio[1010]: at processTimers (internal/timers.js:497:7) May 18 12:03:11 volumio-rpi3b volumio[1010]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 18 12:03:12 volumio-rpi3b sudo[1609]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-18 12:02 May 18 12:03:12 volumio-rpi3b sudo[1609]: 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="570c5791513f5bac7da274aba6690c1a961705de" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 13 May 2025 05:16:30 PM CEST" VOLUMIO_VERSION="3.812" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="3934ee440d5d3f0186049a23752ad680"