-- Logs begin at Wed 2024-11-27 10:06:45 CET, end at Wed 2024-11-27 18:05:31 CET. -- Nov 27 18:04:00 moode volumio[854]: info: CoreCommandRouter::volumioRandom Nov 27 18:04:00 moode volumio[854]: info: CoreCommandRouter::writePlayerControls Nov 27 18:04:00 moode volumio[854]: info: CorePlayQueue::getTrack 0 Nov 27 18:04:00 moode volumio[854]: info: CoreStateMachine::setRepeat true single false Nov 27 18:04:00 moode volumio[854]: info: CoreStateMachine::pushState Nov 27 18:04:00 moode volumio[854]: info: CorePlayQueue::getTrack 0 Nov 27 18:04:00 moode volumio[854]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 27 18:04:00 moode volumio[854]: info: CoreCommandRouter::volumioPushState Nov 27 18:04:00 moode volumio[854]: SPOTIFY: RECEIVED VOLUMIO VOLUME 66 Nov 27 18:04:02 moode volumio[854]: info: CoreCommandRouter::volumioRandom Nov 27 18:04:02 moode volumio[854]: info: CoreCommandRouter::writePlayerControls Nov 27 18:04:02 moode volumio[854]: info: CorePlayQueue::getTrack 0 Nov 27 18:04:02 moode volumio[854]: info: CoreStateMachine::setRepeat true single true Nov 27 18:04:02 moode volumio[854]: info: CoreStateMachine::pushState Nov 27 18:04:02 moode volumio[854]: info: CorePlayQueue::getTrack 0 Nov 27 18:04:02 moode volumio[854]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 27 18:04:02 moode volumio[854]: info: CoreCommandRouter::volumioPushState Nov 27 18:04:02 moode volumio[854]: SPOTIFY: RECEIVED VOLUMIO VOLUME 66 Nov 27 18:04:02 moode volumio[854]: info: CoreCommandRouter::volumioGetState Nov 27 18:04:02 moode volumio[854]: info: CorePlayQueue::getTrack 0 Nov 27 18:04:02 moode volumio[854]: info: Listing playlists Nov 27 18:04:02 moode volumio[854]: info: Listing playlists Nov 27 18:04:04 moode volumio[854]: info: CoreCommandRouter::volumioRandom Nov 27 18:04:04 moode volumio[854]: info: CoreCommandRouter::writePlayerControls Nov 27 18:04:04 moode volumio[854]: info: CorePlayQueue::getTrack 0 Nov 27 18:04:04 moode volumio[854]: info: CoreStateMachine::setRepeat false single false Nov 27 18:04:04 moode volumio[854]: info: CoreStateMachine::pushState Nov 27 18:04:04 moode volumio[854]: info: CorePlayQueue::getTrack 0 Nov 27 18:04:04 moode volumio[854]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 27 18:04:04 moode volumio[854]: info: CoreCommandRouter::volumioPushState Nov 27 18:04:04 moode volumio[854]: SPOTIFY: RECEIVED VOLUMIO VOLUME 66 Nov 27 18:04:06 moode volumio[854]: info: CoreCommandRouter::volumioPlay Nov 27 18:04:06 moode volumio[854]: info: CoreStateMachine::play index undefined Nov 27 18:04:06 moode volumio[854]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 27 18:04:06 moode volumio[854]: info: CorePlayQueue::getTrack 0 Nov 27 18:04:06 moode volumio[854]: info: CoreStateMachine::startPlaybackTimer Nov 27 18:04:06 moode volumio[854]: info: CorePlayQueue::getTrack 0 Nov 27 18:04:06 moode volumio[854]: info: [1732727046628] ControllerWebradio::clearAddPlayTrack Nov 27 18:04:06 moode volumio[854]: verbose: ControllerMpd::sendMpdCommand stop Nov 27 18:04:12 moode volumio[854]: info: CoreCommandRouter::volumioGetState Nov 27 18:04:12 moode volumio[854]: info: CorePlayQueue::getTrack 0 Nov 27 18:04:22 moode volumio[854]: info: CoreCommandRouter::volumioGetState Nov 27 18:04:22 moode volumio[854]: info: CorePlayQueue::getTrack 0 Nov 27 18:04:22 moode volumio[854]: info: Listing playlists Nov 27 18:04:22 moode volumio[854]: info: Listing playlists Nov 27 18:04:32 moode volumio[854]: info: CoreCommandRouter::volumioGetState Nov 27 18:04:32 moode volumio[854]: info: CorePlayQueue::getTrack 0 Nov 27 18:04:40 moode volumio[854]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 27 18:04:40 moode volumio[854]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 27 18:04:40 moode volumio[854]: info: Retrieving Cloud Streaming UI Nov 27 18:04:40 moode volumio[854]: info: Getting Tidal Cloud Configuration Nov 27 18:04:40 moode volumio[854]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 27 18:04:40 moode volumio[854]: info: Getting Qobuz Cloud Configuration Nov 27 18:04:40 moode volumio[854]: info: Asking plugin for UI Config Nov 27 18:04:40 moode volumio[854]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 27 18:04:40 moode volumio[854]: info: Getting Spotify Cloud Configuration Nov 27 18:04:40 moode volumio[854]: info: Asking plugin for UI Config Nov 27 18:04:40 moode volumio[854]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 27 18:04:40 moode volumio[854]: info: Saving Spotify Acccount Nov 27 18:04:40 moode volumio[854]: info: Got Tidal Cloud Configuration Nov 27 18:04:40 moode volumio[854]: info: Got it Nov 27 18:04:40 moode volumio[854]: info: Got it Nov 27 18:04:40 moode volumio[854]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Nov 27 18:04:40 moode volumio[854]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 27 18:04:40 moode volumio[854]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Nov 27 18:04:40 moode volumio[854]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Nov 27 18:04:40 moode volumio[854]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Nov 27 18:04:40 moode volumio[854]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Nov 27 18:04:40 moode volumio[854]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Nov 27 18:04:40 moode volumio[854]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 27 18:04:40 moode volumio[854]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 27 18:04:40 moode volumio[854]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 27 18:04:40 moode volumio[854]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 27 18:04:40 moode volumio[854]: info: CoreCommandRouter::volumioGetBrowseSources Nov 27 18:04:40 moode volumio[854]: info: CoreCommandRouter::volumioGetBrowseSources Nov 27 18:04:40 moode volumio[854]: info: CoreCommandRouter::volumioGetBrowseSources Nov 27 18:04:41 moode volumio[854]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 27 18:04:41 moode volumio[854]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Nov 27 18:04:42 moode volumio[854]: info: CoreCommandRouter::volumioGetState Nov 27 18:04:42 moode volumio[854]: info: CorePlayQueue::getTrack 0 Nov 27 18:04:42 moode volumio[854]: info: Listing playlists Nov 27 18:04:42 moode volumio[854]: info: Listing playlists Nov 27 18:04:45 moode volumio[854]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 27 18:04:46 moode volumio[854]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Nov 27 18:04:46 moode volumio[854]: verbose: ControllerMpd::sendMpdCommand update Nov 27 18:04:49 moode volumio[854]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 27 18:04:51 moode volumio[854]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Nov 27 18:04:51 moode volumio[854]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Nov 27 18:04:52 moode volumio[854]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 27 18:04:52 moode volumio[854]: Error: dns service error: unknown Nov 27 18:04:52 moode volumio[854]: at MDNSService.on_resolver_done (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:19:30) Nov 27 18:04:52 moode volumio[854]: at SocketWatcher.MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { Nov 27 18:04:52 moode volumio[854]: errorCode: -65537 Nov 27 18:04:52 moode volumio[854]: } Nov 27 18:04:52 moode volumio[854]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 27 18:04:52 moode sudo[5790]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-27 18:03 Nov 27 18:04:52 moode sudo[5790]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 27 18:04:52 moode sudo[5790]: pam_unix(sudo:session): session closed for user root Nov 27 18:04:52 moode volumio-remote-updater[541]: [2024-11-27 18:04:52] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Nov 27 18:04:52 moode volumio-remote-updater[541]: [2024-11-27 18:04:52] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Nov 27 18:04:52 moode go-librespot[1043]: time="2024-11-27T18:04:52+01:00" level=error msg="websocket connection errored" error="failed to get reader: failed to read frame header: EOF" Nov 27 18:04:52 moode systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Nov 27 18:04:52 moode systemd[1]: volumio.service: Failed with result 'exit-code'. Nov 27 18:04:52 moode systemd[1]: Started dynamicswap service. Nov 27 18:04:52 moode systemd[1]: dynamicswap.service: Succeeded. Nov 27 18:04:53 moode systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Nov 27 18:04:53 moode systemd[1]: volumio.service: Scheduled restart job, restart counter is at 1. Nov 27 18:04:53 moode systemd[1]: Stopped Volumio Backend Module. Nov 27 18:04:53 moode systemd[1]: Started Volumio Backend Module. Nov 27 18:04:53 moode systemd[1]: Started dynamicswap service. Nov 27 18:04:53 moode systemd[1]: dynamicswap.service: Succeeded. Nov 27 18:04:54 moode volumio[5804]: info: ------------------------------------------- Nov 27 18:04:54 moode volumio[5804]: info: ----- Volumio3 ---- Nov 27 18:04:54 moode volumio[5804]: info: ------------------------------------------- Nov 27 18:04:54 moode volumio[5804]: info: ----- System startup ---- Nov 27 18:04:54 moode volumio[5804]: info: ------------------------------------------- Nov 27 18:04:55 moode volumio[5804]: info: MYVOLUMIO Environment detected Nov 27 18:04:55 moode volumio[5804]: info: Plugin folders cleanup Nov 27 18:04:55 moode volumio[5804]: info: Scanning into folder /volumio/app/plugins/ Nov 27 18:04:55 moode volumio[5804]: info: Scanning category audio_interface Nov 27 18:04:55 moode volumio[5804]: info: Scanning category miscellanea Nov 27 18:04:55 moode volumio[5804]: info: Scanning category music_service Nov 27 18:04:55 moode volumio[5804]: info: Scanning category plugins.json Nov 27 18:04:55 moode volumio[5804]: info: Scanning category system_controller Nov 27 18:04:55 moode volumio[5804]: info: Scanning category user_interface Nov 27 18:04:55 moode volumio[5804]: info: Scanning into folder /data/plugins/ Nov 27 18:04:55 moode volumio[5804]: info: Scanning category music_service Nov 27 18:04:55 moode volumio[5804]: info: Scanning category user_interface Nov 27 18:04:55 moode volumio[5804]: info: Plugin folders cleanup completed Nov 27 18:04:55 moode volumio[5804]: info: ------------------------------------------- Nov 27 18:04:55 moode volumio[5804]: info: ----- Core plugins startup ---- Nov 27 18:04:55 moode volumio[5804]: info: ------------------------------------------- Nov 27 18:04:55 moode volumio[5804]: info: Loading plugins from folder /volumio/app/plugins/ Nov 27 18:04:55 moode volumio[5804]: info: Adding plugin upnp to MyMusic Plugins Nov 27 18:04:55 moode volumio[5804]: info: Adding plugin airplay_emulation to MyMusic Plugins Nov 27 18:04:55 moode volumio[5804]: info: Adding plugin upnp_browser to MyMusic Plugins Nov 27 18:04:55 moode volumio[5804]: info: Loading plugins from folder /data/plugins/ Nov 27 18:04:55 moode volumio[5804]: info: Loading plugin "system"... Nov 27 18:04:55 moode volumio[5804]: info: Loading plugin "appearance"... Nov 27 18:04:56 moode volumio[5804]: info: Loading plugin "network"... Nov 27 18:04:56 moode volumio[5804]: info: Refreshing Cached IP Addresses Nov 27 18:04:56 moode volumio[5804]: info: Loading plugin "services"... Nov 27 18:04:56 moode sudo[5831]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 27 18:04:56 moode sudo[5831]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 27 18:04:56 moode volumio[5804]: info: Loading plugin "alsa_controller"... Nov 27 18:04:56 moode sudo[5831]: pam_unix(sudo:session): session closed for user root Nov 27 18:04:56 moode sudo[5833]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 27 18:04:56 moode sudo[5833]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 27 18:04:56 moode sudo[5833]: pam_unix(sudo:session): session closed for user root Nov 27 18:04:56 moode volumio[5804]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 27 18:04:56 moode volumio[5804]: info: Loading plugin "wizard"... Nov 27 18:04:56 moode volumio[5804]: info: Loading plugin "networkfs"... Nov 27 18:04:56 moode volumio[5804]: info: Starting Udev Watcher for removable devices Nov 27 18:04:56 moode volumio[5804]: info: Ignoring mount for partition: boot Nov 27 18:04:56 moode volumio[5804]: info: Ignoring mount for partition: volumio Nov 27 18:04:56 moode volumio[5804]: info: Ignoring mount for partition: volumio_data Nov 27 18:04:56 moode volumio[5804]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 27 18:04:56 moode volumio[5804]: info: Loading plugin "volumio_command_line_client"... Nov 27 18:04:56 moode volumio[5804]: info: Loading plugin "upnp"... Nov 27 18:04:56 moode volumio[5804]: info: [1732727096818] Starting Upmpd Daemon Nov 27 18:04:56 moode volumio[5804]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 27 18:04:56 moode volumio[5804]: info: Loading plugin "my_music"... Nov 27 18:04:56 moode volumio[5804]: info: Loading plugin "mpd"... Nov 27 18:04:57 moode volumio[5804]: info: Loading plugin "upnp_browser"... Nov 27 18:04:57 moode volumio[5804]: info: Loading plugin "alarm-clock"... Nov 27 18:04:57 moode volumio[5804]: info: Loading plugin "airplay_emulation"... Nov 27 18:04:57 moode volumio[5804]: info: Starting Shairport Sync Nov 27 18:04:57 moode volumio[5804]: info: Loading plugin "last_100"... Nov 27 18:04:57 moode volumio[5804]: info: Loading plugin "webradio"... Nov 27 18:04:57 moode volumio[5804]: info: Loading plugin "i2s_dacs"... Nov 27 18:04:57 moode volumio[5804]: info: Loading plugin "volumiodiscovery"... Nov 27 18:04:57 moode volumio[5804]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 27 18:04:57 moode volumio[5804]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 27 18:04:57 moode volumio[5804]: *** WARNING *** For more information see Nov 27 18:04:57 moode volumio[5804]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 27 18:04:57 moode node[5804]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 27 18:04:57 moode volumio[5804]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 27 18:04:57 moode volumio[5804]: *** WARNING *** For more information see Nov 27 18:04:57 moode node[5804]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 27 18:04:57 moode node[5804]: *** WARNING *** For more information see Nov 27 18:04:57 moode node[5804]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 27 18:04:57 moode node[5804]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 27 18:04:57 moode node[5804]: *** WARNING *** For more information see Nov 27 18:04:57 moode volumio[5804]: info: Applying required configuration parameters for plugin volumiodiscovery Nov 27 18:04:57 moode volumio[5804]: info: Discovery: Started advertising with name: moode Nov 27 18:04:57 moode volumio[5804]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 27 18:04:57 moode volumio[5804]: info: Loading plugin "spop"... Nov 27 18:04:57 moode volumio-remote-updater[541]: [2024-11-27 18:04:57] [connect] Successful connection Nov 27 18:04:58 moode volumio[5804]: info: Loading plugin "outputs"... Nov 27 18:04:58 moode volumio[5804]: info: Loading plugin "albumart"... Nov 27 18:04:58 moode volumio[5804]: info: Plugin example_plugin is not enabled Nov 27 18:04:58 moode volumio[5804]: info: Loading plugin "inputs"... Nov 27 18:04:58 moode volumio[5804]: info: Loading plugin "updater_comm"... Nov 27 18:04:59 moode volumio[5804]: info: Plugin mpdemulation is not enabled Nov 27 18:04:59 moode volumio[5804]: info: Loading plugin "rest_api"... Nov 27 18:04:59 moode volumio[5804]: info: Loading plugin "websocket"... Nov 27 18:04:59 moode volumio[5804]: info: Starting Socket.io Server version 2.3.0 Nov 27 18:04:59 moode volumio[5804]: info: Loading plugin "podcast"... Nov 27 18:04:59 moode volumio[5804]: Forking 3 albumart workers Nov 27 18:04:59 moode volumio[5804]: info: ControllerPodcast::constructor Nov 27 18:04:59 moode volumio[5804]: info: Loading plugin "Systeminfo"... Nov 27 18:04:59 moode volumio[5804]: info: Loading i18n strings for locale de Nov 27 18:04:59 moode volumio[5804]: Updating browse sources language Nov 27 18:04:59 moode volumio[5804]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 27 18:05:00 moode volumio[5804]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 27 18:05:00 moode volumio[5804]: info: CoreCommandRouter::initPlayerControls Nov 27 18:05:00 moode volumio[5804]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 27 18:05:00 moode volumio[5804]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 27 18:05:00 moode volumio[5804]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 27 18:05:00 moode volumio[5804]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 27 18:05:00 moode volumio[5804]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 27 18:05:00 moode volumio[5804]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 27 18:05:00 moode volumio[5804]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 27 18:05:00 moode volumio[5804]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 27 18:05:00 moode volumio[5804]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 27 18:05:00 moode volumio[5804]: Express server listening on port 3000 Nov 27 18:05:00 moode volumio[5804]: [Metrics] WebUI: 5s 727.50ms Nov 27 18:05:00 moode volumio[5804]: Starting albumart workers Nov 27 18:05:00 moode volumio[5804]: info: CoreStateMachine::resetVolumioState Nov 27 18:05:00 moode volumio[5804]: info: CoreStateMachine::getcurrentVolume Nov 27 18:05:00 moode volumio[5804]: info: CoreCommandRouter::volumioRetrievevolume Nov 27 18:05:00 moode volumio[5804]: Starting albumart workers Nov 27 18:05:00 moode volumio[5804]: Starting albumart workers Nov 27 18:05:00 moode volumio[5804]: verbose: New Socket.io Connection to 192.168.178.15 from 192.168.178.20 UA: Mozilla/5.0 (Android 13; Mobile; rv:132.0) Gecko/132.0 Firefox/132.0 Engine version: 3 Transport: polling Total Clients: 1 Nov 27 18:05:00 moode volumio[5804]: verbose: New Socket.io Connection to 192.168.178.15 from 192.168.178.20 UA: Mozilla/5.0 (Android 13; Mobile; rv:132.0) Gecko/132.0 Firefox/132.0 Engine version: 3 Transport: polling Total Clients: 2 Nov 27 18:05:00 moode volumio-remote-updater[541]: [2024-11-27 18:05:00] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1732727097 101 Nov 27 18:05:00 moode volumio[5804]: 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: 3 Nov 27 18:05:00 moode volumio[5804]: verbose: New Socket.io Connection to 192.168.178.15:3000 from 192.168.178.57 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Nov 27 18:05:00 moode volumio[5804]: verbose: New Socket.io Connection to 192.168.178.15 from 192.168.178.20 UA: Mozilla/5.0 (Android 13; Mobile; rv:132.0) Gecko/132.0 Firefox/132.0 Engine version: 3 Transport: polling Total Clients: 5 Nov 27 18:05:00 moode volumio[5804]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 27 18:05:00 moode volumio[5804]: info: Reloading queue from file Nov 27 18:05:00 moode volumio[5804]: info: Setting Device type: Raspberry PI Nov 27 18:05:00 moode volumio[5804]: info: CoreStateMachine::setRepeat false single undefined Nov 27 18:05:00 moode volumio[5804]: info: CoreStateMachine::pushState Nov 27 18:05:00 moode volumio[5804]: info: CorePlayQueue::getTrack 0 Nov 27 18:05:00 moode volumio[5804]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 27 18:05:00 moode volumio[5804]: info: CoreCommandRouter::volumioPushState Nov 27 18:05:00 moode volumio[5804]: info: CoreStateMachine::setRandom false Nov 27 18:05:00 moode volumio[5804]: info: CoreStateMachine::pushState Nov 27 18:05:00 moode volumio[5804]: info: CorePlayQueue::getTrack 0 Nov 27 18:05:00 moode volumio[5804]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 27 18:05:00 moode volumio[5804]: info: CoreCommandRouter::volumioPushState Nov 27 18:05:00 moode volumio[5804]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Nov 27 18:05:00 moode volumio[5804]: info: VolumeController:: Volume=66 Mute =false Nov 27 18:05:00 moode volumio[5804]: info: CoreStateMachine::pushState Nov 27 18:05:00 moode volumio[5804]: info: CorePlayQueue::getTrack 0 Nov 27 18:05:00 moode volumio[5804]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 27 18:05:00 moode volumio[5804]: info: CoreCommandRouter::volumioPushState Nov 27 18:05:00 moode volumio[5804]: info: CoreStateMachine::updateTrackBlock Nov 27 18:05:00 moode volumio[5804]: info: CorePlayQueue::getTrackBlock Nov 27 18:05:00 moode volumio[5804]: info: CoreCommandRouter::volumioRetrievevolume Nov 27 18:05:00 moode volumio[5804]: info: Completed loading Core Plugins Nov 27 18:05:00 moode volumio[5804]: info: Preparing to generate the ALSA configuration file Nov 27 18:05:00 moode volumio[5804]: info: CoreCommandRouter::volumioGetState Nov 27 18:05:00 moode volumio[5804]: info: CorePlayQueue::getTrack 0 Nov 27 18:05:00 moode volumio[5804]: info: Asound.conf file unchanged, so no further update is needed Nov 27 18:05:00 moode volumio[5804]: info: Output device has changed, restarting MPD Nov 27 18:05:00 moode volumio[5804]: info: Output device has changed, restarting Shairport Sync Nov 27 18:05:00 moode volumio[5804]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 27 18:05:00 moode volumio[5804]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 27 18:05:00 moode sudo[5901]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 27 18:05:00 moode sudo[5901]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 27 18:05:00 moode sudo[5901]: pam_unix(sudo:session): session closed for user root Nov 27 18:05:00 moode sudo[5902]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 27 18:05:00 moode sudo[5902]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 27 18:05:00 moode systemd[1]: Stopping Music Player Daemon... Nov 27 18:05:00 moode volumio[5804]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 27 18:05:00 moode volumio[5804]: info: ___________ START PLUGINS ___________ Nov 27 18:05:00 moode volumio[5804]: info: ControllerMpd::onStart: Initializing MPD Nov 27 18:05:00 moode volumio[5804]: info: Creating MPD Configuration file Nov 27 18:05:01 moode sudo[5909]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 27 18:05:01 moode sudo[5909]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 27 18:05:01 moode volumio[5804]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 27 18:05:01 moode sudo[5909]: pam_unix(sudo:session): session closed for user root Nov 27 18:05:01 moode volumio[5804]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 27 18:05:01 moode volumio[5804]: info: [1732727101042] CoreMusicLibrary::Adding element Medienserver Nov 27 18:05:01 moode volumio[5804]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 27 18:05:01 moode sudo[5915]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 27 18:05:01 moode sudo[5915]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 27 18:05:01 moode volumio[5804]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 27 18:05:01 moode volumio[5804]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 27 18:05:01 moode volumio[5804]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 27 18:05:01 moode volumio[5804]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 27 18:05:01 moode volumio[5804]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 27 18:05:01 moode volumio[5804]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 27 18:05:01 moode volumio[5804]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 27 18:05:01 moode volumio[5804]: info: [1732727101182] CoreMusicLibrary::Adding element Last_100 Nov 27 18:05:01 moode volumio[5804]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 27 18:05:01 moode volumio[5804]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 27 18:05:01 moode volumio[5804]: info: [1732727101186] CoreMusicLibrary::Adding element Webradio Nov 27 18:05:01 moode volumio[5804]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 27 18:05:01 moode volumio[5804]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 27 18:05:01 moode volumio[5804]: info: Initializing BBC Radios Nov 27 18:05:01 moode volumio[5804]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 27 18:05:01 moode volumio[5804]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 27 18:05:01 moode volumio[5804]: info: Creating Spotify config file Nov 27 18:05:01 moode volumio[5804]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 27 18:05:01 moode volumio[5804]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 27 18:05:01 moode volumio[5804]: info: [1732727101285] CoreMusicLibrary::Adding element Podcast Nov 27 18:05:01 moode volumio[5804]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 27 18:05:01 moode volumio[5804]: Cannot find translation for source Podcast Nov 27 18:05:01 moode volumio[5804]: info: Volumio Calling Home Nov 27 18:05:01 moode volumio[5804]: info: Discovery: adding c663f02a-bb3c-40ba-9785-bcfbb19398c2 Nov 27 18:05:01 moode volumio[5804]: info: Discovery: Found device moode Nov 27 18:05:01 moode volumio[5804]: info: CoreCommandRouter::volumioGetState Nov 27 18:05:01 moode volumio[5804]: info: CorePlayQueue::getTrack 0 Nov 27 18:05:01 moode volumio[5804]: info: Discovery: adding faad02ef-3e4f-4c49-9497-408796a7c5d6 Nov 27 18:05:01 moode volumio[5804]: info: Discovery: Found device keller Nov 27 18:05:01 moode volumio[5804]: info: Discovery: Connecting to remote: 192.168.178.57 Nov 27 18:05:01 moode volumio[5804]: info: MPD Permissions set Nov 27 18:05:01 moode volumio[5804]: info: MPD Permissions set Nov 27 18:05:01 moode volumio[5804]: info: VolumeController:: Volume=66 Mute =false Nov 27 18:05:01 moode volumio[5804]: info: CoreStateMachine::pushState Nov 27 18:05:01 moode volumio[5804]: info: CorePlayQueue::getTrack 0 Nov 27 18:05:01 moode volumio[5804]: info: CoreCommandRouter::volumioPushState Nov 27 18:05:01 moode volumio[5804]: info: Spotify config file written Nov 27 18:05:01 moode volumio[5804]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Nov 27 18:05:01 moode volumio[5804]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 27 18:05:01 moode volumio[5804]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 27 18:05:01 moode volumio[5804]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 27 18:05:01 moode volumio[5804]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 27 18:05:01 moode volumio[5804]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 27 18:05:01 moode volumio[5804]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 27 18:05:01 moode volumio[5804]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 27 18:05:01 moode volumio[5804]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 27 18:05:01 moode sudo[5942]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Nov 27 18:05:01 moode sudo[5942]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 27 18:05:01 moode systemd[1]: Stopping go-librespot Daemon... Nov 27 18:05:01 moode systemd[1]: go-librespot-daemon.service: Main process exited, code=killed, status=15/TERM Nov 27 18:05:01 moode volumio[5804]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 27 18:05:01 moode systemd[1]: go-librespot-daemon.service: Succeeded. Nov 27 18:05:01 moode systemd[1]: Stopped go-librespot Daemon. Nov 27 18:05:01 moode volumio[5804]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 27 18:05:01 moode volumio[5804]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 27 18:05:01 moode volumio[5804]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 27 18:05:01 moode volumio[5804]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 27 18:05:01 moode volumio[5804]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 27 18:05:01 moode volumio[5804]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 27 18:05:01 moode volumio[5804]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 27 18:05:01 moode volumio[5804]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 27 18:05:01 moode volumio[5804]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 27 18:05:01 moode volumio[5804]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 27 18:05:01 moode volumio[5804]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 27 18:05:01 moode volumio[5804]: info: No need to fix Spotify hosts Nov 27 18:05:01 moode systemd[1]: Started go-librespot Daemon. Nov 27 18:05:01 moode go-librespot[5949]: Librespot-go daemon starting... Nov 27 18:05:01 moode sudo[5942]: pam_unix(sudo:session): session closed for user root Nov 27 18:05:01 moode go-librespot[5949]: time="2024-11-27T18:05:01+01:00" level=info msg="generated new device id: d2372aad308cbf5107f4014af47eed221365642a" Nov 27 18:05:01 moode volumio[5804]: info: Volumio called home Nov 27 18:05:01 moode volumio[5804]: info: Starting Shairport Sync Nov 27 18:05:01 moode volumio[5804]: info: Starting Shairport Sync Nov 27 18:05:01 moode sudo[5964]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 27 18:05:01 moode volumio[5804]: info: Starting Shairport Sync Nov 27 18:05:01 moode sudo[5964]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 27 18:05:01 moode sudo[5966]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 27 18:05:01 moode sudo[5966]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 27 18:05:01 moode go-librespot[5949]: time="2024-11-27T18:05:01+01:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Nov 27 18:05:01 moode go-librespot[5949]: time="2024-11-27T18:05:01+01:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Nov 27 18:05:01 moode go-librespot[5949]: time="2024-11-27T18:05:01+01:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Nov 27 18:05:01 moode systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Nov 27 18:05:01 moode systemd[1]: shairport-sync.service: Succeeded. Nov 27 18:05:01 moode systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Nov 27 18:05:01 moode volumio[5804]: info: CoreCommandRouter::volumioGetState Nov 27 18:05:01 moode volumio[5804]: info: CorePlayQueue::getTrack 0 Nov 27 18:05:01 moode go-librespot[5949]: time="2024-11-27T18:05:01+01:00" level=debug msg="zeroconf server listening on port 45345" Nov 27 18:05:01 moode sudo[5971]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Nov 27 18:05:01 moode sudo[5971]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 27 18:05:01 moode volumio[5804]: info: Discovery: Connected to remote: 192.168.178.57 Nov 27 18:05:01 moode systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Nov 27 18:05:02 moode sudo[5964]: pam_unix(sudo:session): session closed for user root Nov 27 18:05:02 moode systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Nov 27 18:05:02 moode volumio[5804]: info: Shairport-Sync Started Nov 27 18:05:02 moode systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Nov 27 18:05:02 moode systemd[1]: shairport-sync.service: Succeeded. Nov 27 18:05:02 moode volumio[5804]: Error adding Membership: Error: addMembership EINVAL Nov 27 18:05:02 moode systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Nov 27 18:05:02 moode systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Nov 27 18:05:02 moode sudo[5971]: pam_unix(sudo:session): session closed for user root Nov 27 18:05:02 moode sudo[5966]: pam_unix(sudo:session): session closed for user root Nov 27 18:05:02 moode volumio[5804]: info: Shairport-Sync Started Nov 27 18:05:02 moode volumio[5804]: info: Shairport-Sync Started Nov 27 18:05:02 moode volumio[5804]: info: CoreCommandRouter::volumioGetState Nov 27 18:05:02 moode volumio[5804]: info: CorePlayQueue::getTrack 0 Nov 27 18:05:02 moode volumio[5804]: info: Listing playlists Nov 27 18:05:02 moode volumio[5804]: info: Listing playlists Nov 27 18:05:04 moode volumio[5804]: info: go-librespot daemon successfully initialized Nov 27 18:05:05 moode volumio[5804]: verbose: New Socket.io Connection to 192.168.178.15 from 192.168.178.20 UA: Mozilla/5.0 (Android 13; Mobile; rv:132.0) Gecko/132.0 Firefox/132.0 Engine version: 3 Transport: polling Total Clients: 7 Nov 27 18:05:05 moode volumio[5804]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 27 18:05:05 moode volumio[5804]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 27 18:05:05 moode volumio[5804]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 27 18:05:05 moode volumio[5804]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 27 18:05:05 moode volumio[5804]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Nov 27 18:05:05 moode volumio[5804]: info: CoreCommandRouter::volumioGetVisibleSources Nov 27 18:05:05 moode volumio[5804]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 27 18:05:05 moode volumio[5804]: info: CoreCommandRouter::volumioGetState Nov 27 18:05:05 moode volumio[5804]: info: CorePlayQueue::getTrack 0 Nov 27 18:05:05 moode volumio[5804]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Nov 27 18:05:05 moode volumio[5804]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 27 18:05:05 moode volumio[5804]: info: Received Get System Info Nov 27 18:05:05 moode volumio[5804]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 27 18:05:05 moode volumio[5804]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 27 18:05:05 moode volumio[5804]: info: Discovery: Getting this device information Nov 27 18:05:05 moode volumio[5804]: info: CoreCommandRouter::volumioGetState Nov 27 18:05:05 moode volumio[5804]: info: CorePlayQueue::getTrack 0 Nov 27 18:05:05 moode volumio[5804]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 27 18:05:05 moode volumio[5804]: info: CoreCommandRouter::volumioGetState Nov 27 18:05:05 moode volumio[5804]: info: CorePlayQueue::getTrack 0 Nov 27 18:05:05 moode volumio[5804]: info: Listing playlists Nov 27 18:05:05 moode volumio[5804]: info: CoreCommandRouter::volumioGetQueue Nov 27 18:05:05 moode volumio[5804]: info: CoreStateMachine::getQueue Nov 27 18:05:05 moode volumio[5804]: info: CorePlayQueue::getQueue Nov 27 18:05:06 moode sudo[5980]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 27 18:05:06 moode sudo[5980]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 27 18:05:06 moode sudo[5980]: pam_unix(sudo:session): session closed for user root Nov 27 18:05:06 moode sudo[5982]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 27 18:05:06 moode sudo[5982]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 27 18:05:06 moode sudo[5982]: pam_unix(sudo:session): session closed for user root Nov 27 18:05:06 moode sudo[5986]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Nov 27 18:05:06 moode sudo[5986]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 27 18:05:06 moode sudo[5986]: pam_unix(sudo:session): session closed for user root Nov 27 18:05:06 moode volumio[5804]: info: Upmpdcli Daemon Started Nov 27 18:05:07 moode volumio[5804]: info: Initializing connection to go-librespot Websocket Nov 27 18:05:07 moode go-librespot[5949]: time="2024-11-27T18:05:07+01:00" level=debug msg="new websocket client" Nov 27 18:05:07 moode volumio[5804]: info: Connection to go-librespot Websocket established Nov 27 18:05:09 moode volumio[5804]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 27 18:05:10 moode volumio[5804]: info: Getting Spotify volume Nov 27 18:05:10 moode volumio[5804]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Nov 27 18:05:10 moode volumio[5804]: info: CoreCommandRouter::volumioGetState Nov 27 18:05:10 moode volumio[5804]: info: CorePlayQueue::getTrack 0 Nov 27 18:05:10 moode volumio[5804]: SPOTIFY: RECEIVED VOLUMIO VOLUME 66 Nov 27 18:05:10 moode volumio[5804]: SPOTIFY: SPOTIFY VOLUME undefined Nov 27 18:05:10 moode volumio[5804]: SPOTIFY: VOLUMIO VOLUME 66 Nov 27 18:05:10 moode volumio[5804]: info: Aligning Spotify Volume to Volumio Volume Nov 27 18:05:10 moode volumio[5804]: info: CoreCommandRouter::volumioGetState Nov 27 18:05:10 moode volumio[5804]: info: CorePlayQueue::getTrack 0 Nov 27 18:05:10 moode volumio[5804]: info: Setting Spotify Volume from Volumio: 66 Nov 27 18:05:12 moode volumio[5804]: SPOTIFY: SETTING SPOTIFY VOLUME 66 Nov 27 18:05:12 moode volumio[5804]: info: Sending Spotify command with payload to local API: /player/volume Nov 27 18:05:12 moode volumio[5804]: info: CoreCommandRouter::volumioGetState Nov 27 18:05:12 moode volumio[5804]: info: CorePlayQueue::getTrack 0 Nov 27 18:05:13 moode volumio[5804]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 27 18:05:17 moode volumio[5804]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 27 18:05:21 moode volumio[5804]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 27 18:05:22 moode volumio[5804]: info: CoreCommandRouter::volumioGetState Nov 27 18:05:22 moode volumio[5804]: info: CorePlayQueue::getTrack 0 Nov 27 18:05:22 moode volumio[5804]: info: Listing playlists Nov 27 18:05:22 moode volumio[5804]: info: Listing playlists Nov 27 18:05:25 moode volumio[5804]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 27 18:05:29 moode volumio[5804]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 27 18:05:30 moode volumio[5804]: info: Enabling MyMusic plugin bluetooth Nov 27 18:05:30 moode volumio[5804]: info: [MyVolumio PluginManager] Enabling and starting plugin audio_interface bluetooth Nov 27 18:05:30 moode volumio[5804]: info: [MyVolumio PluginManager] Plugin audio_interface bluetooth not in user plan, not enabling Nov 27 18:05:30 moode volumio[5804]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 27 18:05:30 moode volumio[5804]: TypeError: Cannot read property 'toUpperCase' of undefined Nov 27 18:05:30 moode volumio[5804]: at MyVolumioPluginManager.pushMyVolumioRequiredAccountModal (/myvolumio/app/myvolumio-pluginmanager/myvolumio_pluginmanager_real:1:19516) Nov 27 18:05:30 moode volumio[5804]: at MyVolumioPluginManager.enablePlugin (/myvolumio/app/myvolumio-pluginmanager/myvolumio_pluginmanager_real:1:18418) Nov 27 18:05:30 moode volumio[5804]: at MyVolumioPluginManager.enableAndStartPlugin (/myvolumio/app/myvolumio-pluginmanager/myvolumio_pluginmanager_real:1:17039) Nov 27 18:05:30 moode volumio[5804]: at PluginManager.enableDisableMyMusicPlugin (/volumio/app/pluginmanager.js:2024:48) Nov 27 18:05:30 moode volumio[5804]: at CoreCommandRouter.enableDisableMyMusicPlugin (/volumio/app/index.js:2088:29) Nov 27 18:05:30 moode volumio[5804]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1921:59) Nov 27 18:05:30 moode volumio[5804]: at Socket.emit (events.js:315:20) Nov 27 18:05:30 moode volumio[5804]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Nov 27 18:05:30 moode volumio[5804]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Nov 27 18:05:30 moode volumio[5804]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 27 18:05:31 moode sudo[5998]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-27 18:04 Nov 27 18:05:31 moode sudo[5998]: 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="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 17 Sep 2024 05:01:09 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="e0a6dc7e914e3fb93cbf2123f2f73eac"