-- Logs begin at Fri 2024-04-05 15:49:37 CEST, end at Thu 2024-04-11 16:07:57 CEST. -- Apr 11 16:07:13 tempozag ntpd[480]: receive: Unexpected origin timestamp 0xe9ba8059.6b724ce4 does not match aorg 0000000000.00000000 from server@162.159.200.1 xmt 0xe9c26d11.d5dfc69c Apr 11 16:07:13 tempozag ntpd[480]: receive: Unexpected origin timestamp 0xe9ba8059.6b8abf37 does not match aorg 0000000000.00000000 from server@95.81.173.74 xmt 0xe9c26d11.d7915afc Apr 11 16:07:13 tempozag ntpd[480]: receive: Unexpected origin timestamp 0xe9ba8059.6bacbbc7 does not match aorg 0000000000.00000000 from server@129.250.35.251 xmt 0xe9c26d11.d6c68371 Apr 11 16:07:13 tempozag ntpd[480]: receive: Unexpected origin timestamp 0xe9ba8059.6b98823b does not match aorg 0000000000.00000000 from server@91.224.149.41 xmt 0xe9c26d11.d7e7f6ca Apr 11 16:07:13 tempozag ntpd[480]: receive: Unexpected origin timestamp 0xe9ba8059.6ba675d6 does not match aorg 0000000000.00000000 from server@129.151.225.244 xmt 0xe9c26d11.d93549e4 Apr 11 16:07:13 tempozag ntpd[480]: Soliciting pool server 212.83.158.83 Apr 11 16:07:13 tempozag systemd[1]: Starting Daily apt download activities... Apr 11 16:07:16 tempozag volumio[725]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 16:07:16 tempozag volumio[725]: info: CoreCommandRouter::initPlayerControls Apr 11 16:07:16 tempozag volumio[725]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:07:16 tempozag volumio[725]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:07:16 tempozag volumio[725]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:07:16 tempozag volumio[725]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:07:16 tempozag volumio[725]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:07:16 tempozag volumio[725]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:07:16 tempozag volumio[725]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:07:16 tempozag volumio[725]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:07:16 tempozag volumio[725]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 16:07:17 tempozag volumio[725]: Express server listening on port 3000 Apr 11 16:07:17 tempozag volumio[725]: [Metrics] WebUI: 44s 865.21ms Apr 11 16:07:17 tempozag volumio-remote-updater[291]: [2024-04-11 16:07:17] [connect] Successful connection Apr 11 16:07:17 tempozag volumio[725]: info: CoreStateMachine::resetVolumioState Apr 11 16:07:17 tempozag volumio[725]: info: CoreStateMachine::getcurrentVolume Apr 11 16:07:17 tempozag volumio[725]: info: CoreCommandRouter::volumioRetrievevolume Apr 11 16:07:18 tempozag sudo[876]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 11 16:07:18 tempozag sudo[876]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:07:18 tempozag sudo[880]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 11 16:07:18 tempozag sudo[880]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:07:19 tempozag sudo[876]: pam_unix(sudo:session): session closed for user root Apr 11 16:07:19 tempozag sudo[880]: pam_unix(sudo:session): session closed for user root Apr 11 16:07:19 tempozag systemd[1]: apt-daily.service: Succeeded. Apr 11 16:07:19 tempozag systemd[1]: Started Daily apt download activities. Apr 11 16:07:19 tempozag systemd[1]: Starting Daily apt upgrade and clean activities... Apr 11 16:07:19 tempozag volumio[725]: Unable to parse: Apr 11 16:07:19 tempozag volumio[725]: Simple mixer control 'Master',0 Apr 11 16:07:19 tempozag volumio[725]: Capabilities: volume volume-joined Apr 11 16:07:19 tempozag volumio[725]: Playback channels: Mono Apr 11 16:07:19 tempozag volumio[725]: Capture channels: Mono Apr 11 16:07:19 tempozag volumio[725]: Limits: 0 - 248 Apr 11 16:07:19 tempozag volumio[725]: Mono: 42 [17%] Apr 11 16:07:19 tempozag volumio[725]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Apr 11 16:07:22 tempozag volumio-remote-updater[291]: [2024-04-11 16:07:22] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1712844437 101 Apr 11 16:07:22 tempozag volumio[725]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 1 Apr 11 16:07:22 tempozag volumio[725]: Unable to parse: Apr 11 16:07:22 tempozag volumio[725]: Simple mixer control 'Master',0 Apr 11 16:07:22 tempozag volumio[725]: Capabilities: volume volume-joined Apr 11 16:07:22 tempozag volumio[725]: Playback channels: Mono Apr 11 16:07:22 tempozag volumio[725]: Capture channels: Mono Apr 11 16:07:22 tempozag volumio[725]: Limits: 0 - 248 Apr 11 16:07:22 tempozag volumio[725]: Mono: 42 [17%] Apr 11 16:07:22 tempozag volumio[725]: info: VolumeController:: Volume=undefined Mute =false Apr 11 16:07:22 tempozag volumio[725]: info: CoreStateMachine::pushState Apr 11 16:07:22 tempozag volumio[725]: info: CorePlayQueue::getTrack 0 Apr 11 16:07:22 tempozag volumio[725]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 11 16:07:22 tempozag volumio[725]: info: CoreCommandRouter::volumioPushState Apr 11 16:07:22 tempozag volumio[725]: info: CoreStateMachine::updateTrackBlock Apr 11 16:07:22 tempozag volumio[725]: info: CorePlayQueue::getTrackBlock Apr 11 16:07:22 tempozag volumio[725]: info: CoreCommandRouter::volumioRetrievevolume Apr 11 16:07:23 tempozag volumio[725]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 16:07:23 tempozag volumio[725]: info: Reloading queue from file Apr 11 16:07:23 tempozag volumio[725]: Starting albumart workers Apr 11 16:07:23 tempozag volumio[725]: info: CoreStateMachine::setRepeat null single undefined Apr 11 16:07:23 tempozag volumio[725]: info: CoreStateMachine::pushState Apr 11 16:07:23 tempozag volumio[725]: info: CorePlayQueue::getTrack 0 Apr 11 16:07:23 tempozag volumio[725]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 11 16:07:23 tempozag volumio[725]: info: CoreCommandRouter::volumioPushState Apr 11 16:07:23 tempozag volumio[725]: info: CoreStateMachine::setRandom null Apr 11 16:07:23 tempozag systemd[1]: apt-daily-upgrade.service: Succeeded. Apr 11 16:07:23 tempozag systemd[1]: Started Daily apt upgrade and clean activities. Apr 11 16:07:23 tempozag volumio[725]: info: CoreStateMachine::pushState Apr 11 16:07:23 tempozag volumio[725]: info: CorePlayQueue::getTrack 0 Apr 11 16:07:23 tempozag volumio[725]: info: CoreCommandRouter::volumioPushState Apr 11 16:07:24 tempozag volumio[725]: info: Setting Device type: Raspberry PI Apr 11 16:07:24 tempozag volumio[725]: Unable to parse: Apr 11 16:07:24 tempozag volumio[725]: Simple mixer control 'Master',0 Apr 11 16:07:24 tempozag volumio[725]: Capabilities: volume volume-joined Apr 11 16:07:24 tempozag volumio[725]: Playback channels: Mono Apr 11 16:07:24 tempozag volumio[725]: Capture channels: Mono Apr 11 16:07:24 tempozag volumio[725]: Limits: 0 - 248 Apr 11 16:07:24 tempozag volumio[725]: Mono: 42 [17%] Apr 11 16:07:24 tempozag volumio[725]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output Apr 11 16:07:24 tempozag volumio[725]: info: Discovery: A device disappeared from network Apr 11 16:07:24 tempozag volumio[725]: info: Discovery: Browse raised the following error TypeError: Cannot read property 'toLowerCase' of undefined Apr 11 16:07:24 tempozag volumio[725]: info: Discovery: adding f191a91a-6f68-4c49-a5f9-9558c5df7460 Apr 11 16:07:24 tempozag volumio[725]: info: Discovery: Found device TempoZag Apr 11 16:07:24 tempozag volumio[725]: info: CoreCommandRouter::volumioGetState Apr 11 16:07:24 tempozag volumio[725]: info: CorePlayQueue::getTrack 0 Apr 11 16:07:24 tempozag sudo[952]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Apr 11 16:07:24 tempozag sudo[952]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:07:24 tempozag volumio[725]: Unable to parse: Apr 11 16:07:24 tempozag volumio[725]: Simple mixer control 'Master',0 Apr 11 16:07:24 tempozag volumio[725]: Capabilities: volume volume-joined Apr 11 16:07:24 tempozag volumio[725]: Playback channels: Mono Apr 11 16:07:24 tempozag volumio[725]: Capture channels: Mono Apr 11 16:07:24 tempozag volumio[725]: Limits: 0 - 248 Apr 11 16:07:24 tempozag volumio[725]: Mono: 42 [17%] Apr 11 16:07:24 tempozag volumio[725]: info: VolumeController:: Volume=undefined Mute =false Apr 11 16:07:24 tempozag volumio[725]: info: CoreStateMachine::pushState Apr 11 16:07:24 tempozag volumio[725]: info: CorePlayQueue::getTrack 0 Apr 11 16:07:24 tempozag volumio[725]: info: CoreCommandRouter::volumioPushState Apr 11 16:07:24 tempozag systemd[1]: Started UPnP Renderer front-end to MPD. Apr 11 16:07:24 tempozag sudo[952]: pam_unix(sudo:session): session closed for user root Apr 11 16:07:24 tempozag volumio[725]: info: Discovery: this is already registered, f191a91a-6f68-4c49-a5f9-9558c5df7460 Apr 11 16:07:24 tempozag volumio[725]: info: Discovery: Found device TempoZag Apr 11 16:07:24 tempozag volumio[725]: info: CoreCommandRouter::volumioGetState Apr 11 16:07:24 tempozag volumio[725]: info: CorePlayQueue::getTrack 0 Apr 11 16:07:25 tempozag volumio[725]: info: Upmpdcli Daemon Started Apr 11 16:07:25 tempozag volumio[725]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 Apr 11 16:07:29 tempozag volumio[725]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 Apr 11 16:07:30 tempozag sudo[965]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 11 16:07:30 tempozag sudo[965]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:07:30 tempozag sudo[967]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 11 16:07:30 tempozag sudo[967]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:07:30 tempozag sudo[967]: pam_unix(sudo:session): session closed for user root Apr 11 16:07:30 tempozag sudo[965]: pam_unix(sudo:session): session closed for user root Apr 11 16:07:30 tempozag volumio[725]: verbose: New Socket.io Connection to 192.168.30.42 from 192.168.30.56 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/123.0.0.0 Safari/537.36 Total Clients: 2 Apr 11 16:07:30 tempozag volumio[725]: info: CoreCommandRouter::volumioGetVisibleSources Apr 11 16:07:30 tempozag volumio[725]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 11 16:07:30 tempozag volumio[725]: info: CoreCommandRouter::volumioGetState Apr 11 16:07:30 tempozag volumio[725]: info: CorePlayQueue::getTrack 0 Apr 11 16:07:30 tempozag volumio[725]: info: CoreCommandRouter::volumioGetQueue Apr 11 16:07:30 tempozag volumio[725]: info: CoreStateMachine::getQueue Apr 11 16:07:30 tempozag volumio[725]: info: CorePlayQueue::getQueue Apr 11 16:07:30 tempozag volumio[725]: info: Listing playlists Apr 11 16:07:30 tempozag volumio[725]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 11 16:07:30 tempozag volumio[725]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Apr 11 16:07:30 tempozag volumio[725]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 11 16:07:30 tempozag volumio[725]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 11 16:07:30 tempozag volumio[725]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 11 16:07:33 tempozag volumio[725]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 11 16:07:33 tempozag volumio[725]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Apr 11 16:07:35 tempozag volumio[725]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 Apr 11 16:07:43 tempozag volumio[725]: error: Plugin system_controller system failed to complete 'onVolumioStart' in a timely fashion Apr 11 16:07:43 tempozag volumio[725]: info: Preparing to generate the ALSA configuration file Apr 11 16:07:43 tempozag volumio[725]: info: Asound.conf file unchanged, so no further update is needed Apr 11 16:07:43 tempozag volumio[725]: info: Output device has changed, restarting MPD Apr 11 16:07:43 tempozag volumio[725]: info: Output device has changed, restarting Shairport Sync Apr 11 16:07:43 tempozag volumio[725]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:07:43 tempozag volumio[725]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 16:07:43 tempozag sudo[973]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 11 16:07:43 tempozag sudo[973]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:07:43 tempozag sudo[973]: pam_unix(sudo:session): session closed for user root Apr 11 16:07:43 tempozag sudo[975]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 11 16:07:43 tempozag sudo[975]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:07:43 tempozag volumio[725]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 11 16:07:43 tempozag volumio[725]: info: ___________ START PLUGINS ___________ Apr 11 16:07:43 tempozag systemd[1]: Listening on mpd.socket. Apr 11 16:07:43 tempozag systemd[1]: Starting Music Player Daemon... Apr 11 16:07:43 tempozag volumio[725]: info: ControllerMpd::onStart: Initializing MPD Apr 11 16:07:43 tempozag volumio[725]: info: Creating MPD Configuration file Apr 11 16:07:44 tempozag volumio[725]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 16:07:44 tempozag volumio[725]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 11 16:07:44 tempozag volumio[725]: info: [1712844464295] CoreMusicLibrary::Adding element Serveurs Média Apr 11 16:07:44 tempozag sudo[984]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 11 16:07:44 tempozag volumio[725]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 11 16:07:44 tempozag sudo[984]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:07:44 tempozag sudo[984]: pam_unix(sudo:session): session closed for user root Apr 11 16:07:44 tempozag sudo[986]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 11 16:07:44 tempozag sudo[986]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:07:44 tempozag systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Apr 11 16:07:44 tempozag systemd[1]: mpd.service: Succeeded. Apr 11 16:07:44 tempozag volumio[725]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:07:44 tempozag systemd[1]: Stopped Music Player Daemon. Apr 11 16:07:44 tempozag volumio[725]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 16:07:44 tempozag systemd[1]: Starting Music Player Daemon... Apr 11 16:07:45 tempozag volumio[725]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 11 16:07:45 tempozag volumio[725]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:07:45 tempozag volumio[725]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 16:07:45 tempozag volumio[725]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 11 16:07:45 tempozag volumio[725]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 11 16:07:45 tempozag volumio[725]: info: [1712844465517] CoreMusicLibrary::Adding element Last_100 Apr 11 16:07:45 tempozag volumio[725]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 11 16:07:45 tempozag volumio[725]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 11 16:07:45 tempozag volumio[725]: info: [1712844465547] CoreMusicLibrary::Adding element Webradio Apr 11 16:07:45 tempozag volumio[725]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 11 16:07:45 tempozag volumio[725]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 11 16:07:45 tempozag volumio[725]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 11 16:07:45 tempozag volumio[725]: info: [1712844465696] CoreMusicLibrary::Adding element SoundCloud Apr 11 16:07:45 tempozag volumio[725]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 11 16:07:45 tempozag volumio[725]: Cannot find translation for source SoundCloud Apr 11 16:07:45 tempozag volumio[725]: info: Creating Spotify config file Apr 11 16:07:45 tempozag volumio[725]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:07:46 tempozag volumio[725]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 11 16:07:46 tempozag volumio[725]: info: [1712844466533] CoreMusicLibrary::Adding element YouTube2 Apr 11 16:07:46 tempozag volumio[725]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 11 16:07:46 tempozag volumio[725]: Cannot find translation for source SoundCloud Apr 11 16:07:46 tempozag volumio[725]: Cannot find translation for source YouTube2 Apr 11 16:07:46 tempozag volumio[725]: info: Volumio Calling Home Apr 11 16:07:47 tempozag volumio[725]: info: MPD Permissions set Apr 11 16:07:47 tempozag volumio[725]: info: MPD Permissions set Apr 11 16:07:48 tempozag volumio[725]: info: Spotify config file written Apr 11 16:07:48 tempozag volumio[725]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 3 Apr 11 16:07:48 tempozag volumio[725]: info: Volumio called home Apr 11 16:07:48 tempozag sudo[1000]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Apr 11 16:07:48 tempozag volumio[725]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:07:48 tempozag volumio[725]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:07:48 tempozag volumio[725]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:07:48 tempozag volumio[725]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:07:48 tempozag sudo[1000]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:07:48 tempozag volumio[725]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:07:48 tempozag volumio[725]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:07:48 tempozag volumio[725]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:07:48 tempozag volumio[725]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:07:48 tempozag volumio[725]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 16:07:48 tempozag volumio[725]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:07:48 tempozag systemd[1]: Started go-librespot Daemon. Apr 11 16:07:48 tempozag volumio[725]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:07:48 tempozag go-librespot[1006]: Librespot-go daemon starting... Apr 11 16:07:48 tempozag volumio[725]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:07:48 tempozag volumio[725]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:07:48 tempozag volumio[725]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:07:48 tempozag volumio[725]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:07:48 tempozag volumio[725]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:07:48 tempozag volumio[725]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:07:48 tempozag volumio[725]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:07:49 tempozag sudo[1000]: pam_unix(sudo:session): session closed for user root Apr 11 16:07:49 tempozag volumio[725]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 16:07:49 tempozag volumio[725]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:07:49 tempozag volumio[725]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 11 16:07:49 tempozag volumio[725]: info: CURURI: albums:// Apr 11 16:07:49 tempozag volumio[725]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 11 16:07:49 tempozag volumio[725]: TypeError: Cannot read property 'sendCommand' of undefined Apr 11 16:07:49 tempozag volumio[725]: at /volumio/app/plugins/music_service/mpd/index.js:2986:22 Apr 11 16:07:49 tempozag volumio[725]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Apr 11 16:07:49 tempozag volumio[725]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 11 16:07:50 tempozag go-librespot[1006]: time="2024-04-11T16:07:50+02:00" level=info msg="generated new device id: 1d251c0200f4ca07358b41af18eab08688bc4b03" Apr 11 16:07:50 tempozag go-librespot[1006]: time="2024-04-11T16:07:50+02:00" level=debug msg="stored credentials found for 31mtipjily44x7ukb3zpxevpidui" Apr 11 16:07:54 tempozag go-librespot[1006]: time="2024-04-11T16:07:54+02:00" level=debug msg="obtained new client token: AAA18zQiTO8TBecrAAjxbyAne0z6ffCHd3sojsnpIv8SY4Q75HEV3mTMwJSNki9pQ4ZwZ4uI2lkH3CS0KaU6+ibBuGZZyGUV13tEJbPB4Ckks6hSWOrW6LemscGbjFbpU8rzlWu5rRWL3lCRNaGZ9V4qXnQD58MC2q0ynnjo7AH0AADiVbvU7Mu6Glb1HcS7B+L7Q42rQJ3Z4AF8MVEqL1gWZs5zevfCESmIeyAvRzE1NBGaKQXIYPUkIEB+gjEt" Apr 11 16:07:54 tempozag go-librespot[1006]: time="2024-04-11T16:07:54+02:00" level=debug msg="fetched new accesspoints: [ap-gew1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Apr 11 16:07:55 tempozag go-librespot[1006]: time="2024-04-11T16:07:55+02:00" level=debug msg="completed keyexchange" Apr 11 16:07:55 tempozag go-librespot[1006]: time="2024-04-11T16:07:55+02:00" level=debug msg="completed challenge" Apr 11 16:07:55 tempozag go-librespot[1006]: time="2024-04-11T16:07:55+02:00" level=debug msg="authenticated as 31mtipjily44x7ukb3zpxevpidui" Apr 11 16:07:56 tempozag go-librespot[1006]: time="2024-04-11T16:07:56+02:00" level=debug msg="authenticated as 31mtipjily44x7ukb3zpxevpidui" Apr 11 16:07:56 tempozag go-librespot[1006]: time="2024-04-11T16:07:56+02:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Apr 11 16:07:56 tempozag go-librespot[1006]: time="2024-04-11T16:07:56+02:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Apr 11 16:07:56 tempozag sudo[1061]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-11 16:06 Apr 11 16:07:56 tempozag sudo[1061]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:07:57 tempozag go-librespot[1006]: time="2024-04-11T16:07:57+02:00" level=debug msg="dealer connection opened" Apr 11 16:07:57 tempozag go-librespot[1006]: time="2024-04-11T16:07:57+02:00" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336" Apr 11 16:07:57 tempozag go-librespot[1006]: time="2024-04-11T16:07:57+02:00" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2" Apr 11 16:07:57 tempozag go-librespot[1006]: time="2024-04-11T16:07:57+02:00" level=debug msg="received connection id: OGM0NTNmODgtODJjMS00ZGU4LWEyNDMtMjdkZDljMWVlMWJkK2RlYWxlcit0Y3A6Ly9nZXcxLWRlYWxlci1hLXMzNnIuZ2V3MS5zcG90aWZ5Lm5ldDo1NzAwKzRFMzFCNDQ1NkJBQkRBOTY2OTIzOUY2Nzc5OTQ2QkVENkE1RUE5NDI4Q0VCRUE0MEI5RjRBRkVDODcxMTZBNDQ=" 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="7f9f1bf001add7a8b19a4516e3c74ef598b2730d" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="512433c3e91cdaed7ecd2808b21adeffc2137d7f" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 21 Feb 2024 09:37:22 PM CET" VOLUMIO_VERSION="3.631" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fdd9dd1169c06c1ad0a30ddd24c91b6b"