-- Logs begin at Thu 2019-02-14 11:12:07 CET, end at Sat 2024-08-31 11:01:13 CEST. -- Aug 31 11:00:31 volumiozero volumio[823]: info: Loading plugin "backup_restore"... Aug 31 11:00:31 volumiozero volumio-remote-updater[569]: [2024-08-31 11:00:31] [connect] Successful connection Aug 31 11:00:33 volumiozero volumio[823]: info: Applying required configuration parameters for plugin backup_restore Aug 31 11:00:33 volumiozero volumio[823]: info: Loading i18n strings for locale nl Aug 31 11:00:33 volumiozero volumio[823]: error: minidlna: Fetching language file: Error: i18n file complementing the system language not found. Aug 31 11:00:33 volumiozero volumio[823]: Updating browse sources language Aug 31 11:00:33 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 31 11:00:34 volumiozero volumio[823]: Starting albumart workers Aug 31 11:00:35 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 31 11:00:35 volumiozero volumio[823]: info: CoreCommandRouter::initPlayerControls Aug 31 11:00:35 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 11:00:35 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 11:00:35 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 11:00:35 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 11:00:35 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 11:00:35 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 11:00:35 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 11:00:35 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 11:00:35 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 31 11:00:35 volumiozero volumio[823]: Express server listening on port 3000 Aug 31 11:00:35 volumiozero volumio[823]: [Metrics] WebUI: 42s 416.93ms Aug 31 11:00:36 volumiozero volumio[823]: info: CoreStateMachine::resetVolumioState Aug 31 11:00:36 volumiozero volumio[823]: info: CoreStateMachine::getcurrentVolume Aug 31 11:00:36 volumiozero volumio[823]: info: CoreCommandRouter::volumioRetrievevolume Aug 31 11:00:36 volumiozero sudo[945]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 31 11:00:36 volumiozero sudo[945]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 11:00:37 volumiozero sudo[947]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 31 11:00:37 volumiozero sudo[947]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 11:00:37 volumiozero sudo[945]: pam_unix(sudo:session): session closed for user root Aug 31 11:00:37 volumiozero sudo[947]: pam_unix(sudo:session): session closed for user root Aug 31 11:00:37 volumiozero volumio[823]: info: CoreStateMachine::pushState Aug 31 11:00:37 volumiozero volumio[823]: info: CorePlayQueue::getTrack 0 Aug 31 11:00:37 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 11:00:37 volumiozero volumio[823]: info: CoreCommandRouter::volumioPushState Aug 31 11:00:37 volumiozero volumio[823]: info: CoreStateMachine::updateTrackBlock Aug 31 11:00:37 volumiozero volumio[823]: info: CorePlayQueue::getTrackBlock Aug 31 11:00:37 volumiozero volumio[823]: info: CoreCommandRouter::volumioRetrievevolume Aug 31 11:00:39 volumiozero volumio[823]: verbose: New Socket.io Connection to 192.168.2.136:3000 from 192.168.2.220 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1 Aug 31 11:00:39 volumiozero volumio[823]: verbose: New Socket.io Connection to 192.168.2.136:3000 from 192.168.2.220 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Aug 31 11:00:39 volumiozero volumio[823]: verbose: New Socket.io Connection to 192.168.2.136:3000 from 192.168.2.220 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Aug 31 11:00:39 volumiozero volumio[823]: info: CoreCommandRouter::volumioGetState Aug 31 11:00:39 volumiozero volumio[823]: info: CorePlayQueue::getTrack 0 Aug 31 11:00:39 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 31 11:00:39 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 31 11:00:39 volumiozero volumio[823]: info: Discovery: Getting this device information Aug 31 11:00:39 volumiozero volumio[823]: info: CoreCommandRouter::volumioGetState Aug 31 11:00:39 volumiozero volumio[823]: info: CorePlayQueue::getTrack 0 Aug 31 11:00:39 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 31 11:00:40 volumiozero volumio[823]: info: CoreStateMachine::pushState Aug 31 11:00:40 volumiozero volumio[823]: info: CorePlayQueue::getTrack 0 Aug 31 11:00:40 volumiozero volumio[823]: info: CoreCommandRouter::volumioPushState Aug 31 11:00:40 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 31 11:00:40 volumiozero volumio[823]: info: Reloading queue from file Aug 31 11:00:41 volumiozero volumio[823]: verbose: New Socket.io Connection to 192.168.2.136:3000 from 192.168.2.220 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Aug 31 11:00:41 volumiozero volumio[823]: info: CoreStateMachine::setRepeat null single undefined Aug 31 11:00:41 volumiozero volumio[823]: info: CoreStateMachine::pushState Aug 31 11:00:41 volumiozero volumio[823]: info: CorePlayQueue::getTrack 0 Aug 31 11:00:41 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 31 11:00:41 volumiozero volumio[823]: info: CoreCommandRouter::volumioPushState Aug 31 11:00:41 volumiozero volumio[823]: info: CoreStateMachine::setRandom null Aug 31 11:00:41 volumiozero volumio[823]: info: CoreStateMachine::pushState Aug 31 11:00:41 volumiozero volumio[823]: info: CorePlayQueue::getTrack 0 Aug 31 11:00:41 volumiozero volumio[823]: info: CoreCommandRouter::volumioPushState Aug 31 11:00:41 volumiozero volumio[823]: info: Setting Device type: Raspberry PI Aug 31 11:00:41 volumiozero volumio[823]: info: Listing playlists Aug 31 11:00:41 volumiozero volumio[823]: info: Listing playlists Aug 31 11:00:41 volumiozero volumio[823]: info: Completed loading Core Plugins Aug 31 11:00:41 volumiozero volumio[823]: info: Preparing to generate the ALSA configuration file Aug 31 11:00:41 volumiozero volumio[823]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Aug 31 11:00:41 volumiozero volumio[823]: info: Reading ALSA contributions from plugins. Aug 31 11:00:42 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Aug 31 11:00:42 volumiozero sudo[973]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Aug 31 11:00:42 volumiozero sudo[973]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 11:00:42 volumiozero volumio[823]: info: Discovery: adding d890ed54-fa66-4ef8-add1-28f626ec4f9a Aug 31 11:00:42 volumiozero volumio[823]: info: Discovery: Found device Volumiozero Aug 31 11:00:42 volumiozero volumio[823]: info: CoreCommandRouter::volumioGetState Aug 31 11:00:42 volumiozero systemd[1]: Started UPnP Renderer front-end to MPD. Aug 31 11:00:42 volumiozero volumio[823]: info: CorePlayQueue::getTrack 0 Aug 31 11:00:42 volumiozero sudo[973]: pam_unix(sudo:session): session closed for user root Aug 31 11:00:42 volumiozero volumio[823]: info: CoreCommandRouter::volumioGetState Aug 31 11:00:42 volumiozero volumio[823]: info: CorePlayQueue::getTrack 0 Aug 31 11:00:42 volumiozero volumio[823]: info: Discovery: adding a17ff625-265c-4ea4-8262-f63b4c21429d Aug 31 11:00:42 volumiozero volumio[823]: info: Discovery: Found device Volumiorange Aug 31 11:00:43 volumiozero volumio[823]: info: Discovery: Connecting to remote: 192.168.2.220 Aug 31 11:00:43 volumiozero volumio[823]: info: Upmpdcli Daemon Started Aug 31 11:00:43 volumiozero volumio[823]: info: CoreCommandRouter::volumioGetState Aug 31 11:00:43 volumiozero volumio[823]: info: CorePlayQueue::getTrack 0 Aug 31 11:00:43 volumiozero volumio[823]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 Aug 31 11:00:43 volumiozero sudo[977]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 31 11:00:43 volumiozero sudo[977]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 11:00:43 volumiozero sudo[979]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 31 11:00:43 volumiozero sudo[977]: pam_unix(sudo:session): session closed for user root Aug 31 11:00:43 volumiozero sudo[979]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 11:00:43 volumiozero sudo[979]: pam_unix(sudo:session): session closed for user root Aug 31 11:00:43 volumiozero volumio[823]: info: Discovery: Connected to remote: 192.168.2.220 Aug 31 11:00:43 volumiozero volumio[823]: info: Asound.conf file unchanged, so no further update is needed Aug 31 11:00:43 volumiozero volumio[823]: info: Output device has changed, restarting MPD Aug 31 11:00:44 volumiozero volumio[823]: info: Output device has changed, restarting Shairport Sync Aug 31 11:00:44 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 11:00:44 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 31 11:00:44 volumiozero sudo[985]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 31 11:00:44 volumiozero sudo[985]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 11:00:44 volumiozero sudo[985]: pam_unix(sudo:session): session closed for user root Aug 31 11:00:44 volumiozero sudo[987]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 31 11:00:44 volumiozero sudo[987]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 11:00:44 volumiozero volumio[823]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 31 11:00:44 volumiozero volumio[823]: info: ___________ START PLUGINS ___________ Aug 31 11:00:44 volumiozero systemd[1]: Listening on mpd.socket. Aug 31 11:00:44 volumiozero volumio[823]: info: ControllerMpd::onStart: Initializing MPD Aug 31 11:00:44 volumiozero systemd[1]: Starting Music Player Daemon... Aug 31 11:00:44 volumiozero volumio[823]: info: Creating MPD Configuration file Aug 31 11:00:44 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 31 11:00:44 volumiozero volumio[823]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 31 11:00:44 volumiozero volumio[823]: info: [1725094844990] CoreMusicLibrary::Adding element Media Servers Aug 31 11:00:44 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 31 11:00:45 volumiozero sudo[996]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 31 11:00:45 volumiozero sudo[996]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 11:00:45 volumiozero sudo[996]: pam_unix(sudo:session): session closed for user root Aug 31 11:00:45 volumiozero sudo[998]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 31 11:00:45 volumiozero sudo[998]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 11:00:45 volumiozero sudo[994]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 31 11:00:45 volumiozero sudo[994]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 11:00:45 volumiozero sudo[994]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Aug 31 11:00:45 volumiozero sudo[994]: pam_unix(sudo:session): session closed for user root Aug 31 11:00:45 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 11:00:45 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 31 11:00:45 volumiozero systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Aug 31 11:00:45 volumiozero systemd[1]: mpd.service: Succeeded. Aug 31 11:00:45 volumiozero systemd[1]: Stopped Music Player Daemon. Aug 31 11:00:45 volumiozero systemd[1]: Starting Music Player Daemon... Aug 31 11:00:46 volumiozero volumio[823]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 31 11:00:46 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 11:00:46 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 31 11:00:46 volumiozero volumio[823]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 31 11:00:46 volumiozero volumio[823]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 31 11:00:46 volumiozero volumio[823]: info: [1725094846388] CoreMusicLibrary::Adding element Last_100 Aug 31 11:00:46 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 31 11:00:46 volumiozero volumio[823]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 31 11:00:46 volumiozero volumio[823]: info: [1725094846418] CoreMusicLibrary::Adding element Webradio Aug 31 11:00:46 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 31 11:00:46 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 31 11:00:46 volumiozero sudo[1006]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 31 11:00:46 volumiozero sudo[1006]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 11:00:46 volumiozero volumio[823]: info: Initializing BBC Radios Aug 31 11:00:46 volumiozero sudo[1006]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Aug 31 11:00:46 volumiozero sudo[1006]: pam_unix(sudo:session): session closed for user root Aug 31 11:00:46 volumiozero volumio[823]: /usr/bin/md5sum: /sys/class/net/eth0/address: No such file or directory Aug 31 11:00:46 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 31 11:00:46 volumiozero volumio-remote-updater[569]: [2024-08-31 11:00:46] [connect] Successful connection Aug 31 11:00:47 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 31 11:00:47 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 31 11:00:47 volumiozero volumio[823]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 31 11:00:47 volumiozero volumio[823]: info: [1725094847124] CoreMusicLibrary::Adding element YouTube Music Aug 31 11:00:47 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 31 11:00:47 volumiozero volumio[823]: Cannot find translation for source YouTube Music Aug 31 11:00:47 volumiozero volumio[823]: info: Loading i18n strings for locale nl Aug 31 11:00:47 volumiozero volumio[823]: error: minidlna: Fetching language file: Error: i18n file complementing the system language not found. Aug 31 11:00:47 volumiozero volumio[823]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 31 11:00:47 volumiozero volumio[823]: info: [1725094847555] CoreMusicLibrary::Adding element Podcast Aug 31 11:00:47 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 31 11:00:47 volumiozero volumio[823]: Cannot find translation for source YouTube Music Aug 31 11:00:47 volumiozero volumio[823]: Cannot find translation for source Podcast Aug 31 11:00:47 volumiozero volumio[823]: info: Volumio Calling Home Aug 31 11:00:51 volumiozero volumio[823]: info: MPD Permissions set Aug 31 11:00:51 volumiozero volumio[823]: info: MPD Permissions set Aug 31 11:00:52 volumiozero volumio[823]: verbose: New Socket.io Connection to 192.168.2.136 from 192.168.2.150 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/128.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Aug 31 11:00:52 volumiozero volumio[823]: info: Volumio called home Aug 31 11:00:53 volumiozero volumio[823]: verbose: New Socket.io Connection to 192.168.2.136 from 192.168.2.150 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/128.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Aug 31 11:00:53 volumiozero volumio[823]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Aug 31 11:00:53 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 11:00:53 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 11:00:53 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 11:00:53 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 11:00:53 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 11:00:53 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 11:00:53 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 11:00:53 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 11:00:54 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 31 11:00:54 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 11:00:54 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 11:00:54 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 11:00:54 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 11:00:54 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 11:00:54 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 11:00:54 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 11:00:54 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 11:00:54 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 11:00:54 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 31 11:00:54 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 31 11:00:55 volumiozero volumio[823]: verbose: New Socket.io Connection to 192.168.2.136 from 192.168.2.150 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/128.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Aug 31 11:00:55 volumiozero volumio[823]: verbose: New Socket.io Connection to 192.168.2.136 from 192.168.2.150 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/128.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Aug 31 11:00:56 volumiozero volumio[823]: verbose: New Socket.io Connection to 192.168.2.136 from 192.168.2.150 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/128.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10 Aug 31 11:00:56 volumiozero volumio[823]: info: minidlna: Found miniDLNA version 1.2.1 Aug 31 11:00:56 volumiozero volumio[823]: info: minidlna: Starting minidlna.service Aug 31 11:00:56 volumiozero volumio[823]: info: CoreCommandRouter::volumioGetState Aug 31 11:00:56 volumiozero volumio[823]: info: CorePlayQueue::getTrack 0 Aug 31 11:00:56 volumiozero sudo[1037]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start minidlna.service Aug 31 11:00:56 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 31 11:00:56 volumiozero sudo[1037]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 11:00:56 volumiozero volumio[823]: info: Starting Shairport Sync Aug 31 11:00:56 volumiozero volumio[823]: info: Starting Shairport Sync Aug 31 11:00:56 volumiozero systemd[1]: Started MiniDLNA lightweight DLNA/UPnP-AV server. Aug 31 11:00:57 volumiozero volumio[823]: info: Starting Shairport Sync Aug 31 11:00:57 volumiozero sudo[1037]: pam_unix(sudo:session): session closed for user root Aug 31 11:00:57 volumiozero sudo[1040]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 31 11:00:57 volumiozero sudo[1040]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 11:00:57 volumiozero sudo[1043]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 31 11:00:58 volumiozero volumio[823]: info: CoreCommandRouter::volumioGetState Aug 31 11:00:58 volumiozero volumio[823]: info: CorePlayQueue::getTrack 0 Aug 31 11:00:58 volumiozero sudo[1043]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 11:00:58 volumiozero systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 31 11:00:58 volumiozero systemd[1]: shairport-sync.service: Succeeded. Aug 31 11:00:58 volumiozero systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Aug 31 11:00:58 volumiozero systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 31 11:00:58 volumiozero sudo[1045]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 31 11:00:58 volumiozero sudo[1040]: pam_unix(sudo:session): session closed for user root Aug 31 11:00:58 volumiozero sudo[1045]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 31 11:00:58 volumiozero volumio[823]: info: Listing playlists Aug 31 11:00:58 volumiozero volumio[823]: info: Listing playlists Aug 31 11:00:58 volumiozero systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 31 11:00:58 volumiozero systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Aug 31 11:00:58 volumiozero systemd[1]: shairport-sync.service: Succeeded. Aug 31 11:00:58 volumiozero systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Aug 31 11:00:59 volumiozero systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 31 11:00:59 volumiozero sudo[1043]: pam_unix(sudo:session): session closed for user root Aug 31 11:00:59 volumiozero volumio[823]: info: CoreCommandRouter::volumioGetVisibleSources Aug 31 11:00:59 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 31 11:00:59 volumiozero volumio[823]: info: CoreCommandRouter::volumioGetState Aug 31 11:00:59 volumiozero volumio[823]: info: CorePlayQueue::getTrack 0 Aug 31 11:00:59 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Aug 31 11:00:59 volumiozero systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 31 11:00:59 volumiozero systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Aug 31 11:00:59 volumiozero systemd[1]: shairport-sync.service: Succeeded. Aug 31 11:00:59 volumiozero systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Aug 31 11:00:59 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 31 11:00:59 volumiozero volumio[823]: info: Received Get System Info Aug 31 11:00:59 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 31 11:00:59 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 31 11:00:59 volumiozero volumio[823]: info: Discovery: Getting this device information Aug 31 11:00:59 volumiozero volumio[823]: info: CoreCommandRouter::volumioGetState Aug 31 11:00:59 volumiozero volumio[823]: info: CorePlayQueue::getTrack 0 Aug 31 11:00:59 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 31 11:00:59 volumiozero volumio[823]: info: CoreCommandRouter::volumioGetState Aug 31 11:00:59 volumiozero systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 31 11:00:59 volumiozero volumio[823]: info: CorePlayQueue::getTrack 0 Aug 31 11:01:00 volumiozero sudo[1045]: pam_unix(sudo:session): session closed for user root Aug 31 11:01:00 volumiozero volumio[823]: info: Listing playlists Aug 31 11:01:00 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 31 11:01:00 volumiozero volumio[823]: info: Received Get System Info Aug 31 11:01:00 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 31 11:01:00 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 31 11:01:00 volumiozero volumio[823]: info: Discovery: Getting this device information Aug 31 11:01:00 volumiozero volumio[823]: info: CoreCommandRouter::volumioGetState Aug 31 11:01:00 volumiozero volumio[823]: info: CorePlayQueue::getTrack 0 Aug 31 11:01:00 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 31 11:01:00 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 31 11:01:00 volumiozero volumio[823]: info: Received Get System Info Aug 31 11:01:00 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 31 11:01:00 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 31 11:01:00 volumiozero volumio[823]: info: Discovery: Getting this device information Aug 31 11:01:00 volumiozero volumio[823]: info: CoreCommandRouter::volumioGetState Aug 31 11:01:00 volumiozero volumio[823]: info: CorePlayQueue::getTrack 0 Aug 31 11:01:00 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 31 11:01:00 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 31 11:01:00 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 31 11:01:00 volumiozero volumio[823]: info: CoreCommandRouter::volumioGetVisibleSources Aug 31 11:01:00 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 31 11:01:00 volumiozero volumio[823]: info: CoreCommandRouter::volumioGetState Aug 31 11:01:00 volumiozero volumio[823]: info: CorePlayQueue::getTrack 0 Aug 31 11:01:00 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Aug 31 11:01:00 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 31 11:01:00 volumiozero volumio[823]: info: Received Get System Info Aug 31 11:01:00 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 31 11:01:00 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 31 11:01:00 volumiozero volumio[823]: info: Discovery: Getting this device information Aug 31 11:01:00 volumiozero volumio[823]: info: CoreCommandRouter::volumioGetState Aug 31 11:01:00 volumiozero volumio[823]: info: CorePlayQueue::getTrack 0 Aug 31 11:01:00 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 31 11:01:00 volumiozero volumio[823]: info: CoreCommandRouter::volumioGetState Aug 31 11:01:00 volumiozero volumio[823]: info: CorePlayQueue::getTrack 0 Aug 31 11:01:00 volumiozero volumio[823]: info: Listing playlists Aug 31 11:01:00 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Aug 31 11:01:00 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 31 11:01:01 volumiozero volumio[823]: info: Shairport-Sync Started Aug 31 11:01:01 volumiozero volumio-remote-updater[569]: [2024-08-31 11:01:01] [connect] Successful connection Aug 31 11:01:01 volumiozero volumio[823]: Error adding Membership: Error: addMembership EINVAL Aug 31 11:01:01 volumiozero volumio[823]: info: minidlna: systemctl start minidlna.service succeeded. Aug 31 11:01:02 volumiozero volumio[823]: info: Shairport-Sync Started Aug 31 11:01:02 volumiozero volumio[823]: info: Shairport-Sync Started Aug 31 11:01:02 volumiozero volumio-remote-updater[569]: [2024-08-31 11:01:02] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1725094861 101 Aug 31 11:01:02 volumiozero volumio[823]: 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: 11 Aug 31 11:01:02 volumiozero volumio[823]: info: CoreCommandRouter::volumioGetQueue Aug 31 11:01:02 volumiozero volumio[823]: info: CoreStateMachine::getQueue Aug 31 11:01:02 volumiozero volumio[823]: info: CorePlayQueue::getQueue Aug 31 11:01:02 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 31 11:01:02 volumiozero volumio[823]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Aug 31 11:01:02 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Aug 31 11:01:02 volumiozero volumio[823]: info: Received Get System Version Aug 31 11:01:02 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 31 11:01:02 volumiozero volumio[823]: info: Received Get System Info Aug 31 11:01:02 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 31 11:01:02 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 31 11:01:02 volumiozero volumio[823]: info: Discovery: Getting this device information Aug 31 11:01:02 volumiozero volumio[823]: info: CoreCommandRouter::volumioGetState Aug 31 11:01:02 volumiozero volumio[823]: info: CorePlayQueue::getTrack 0 Aug 31 11:01:02 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 31 11:01:03 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Aug 31 11:01:03 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Aug 31 11:01:03 volumiozero volumio[823]: info: CoreCommandRouter::volumioGetState Aug 31 11:01:03 volumiozero volumio[823]: info: CorePlayQueue::getTrack 0 Aug 31 11:01:03 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Aug 31 11:01:07 volumiozero volumio[823]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Aug 31 11:01:07 volumiozero mpd[1013]: Aug 31 11:01 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Aug 31 11:01:08 volumiozero systemd[1]: Started Music Player Daemon. Aug 31 11:01:08 volumiozero sudo[998]: pam_unix(sudo:session): session closed for user root Aug 31 11:01:08 volumiozero sudo[987]: pam_unix(sudo:session): session closed for user root Aug 31 11:01:08 volumiozero volumio[823]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 31 11:01:08 volumiozero volumio[823]: TypeError: Cannot read property 'length' of undefined Aug 31 11:01:08 volumiozero volumio[823]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25 Aug 31 11:01:08 volumiozero volumio[823]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13 Aug 31 11:01:08 volumiozero volumio[823]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18) Aug 31 11:01:08 volumiozero volumio[823]: at Parser.emit (events.js:315:20) Aug 31 11:01:08 volumiozero volumio[823]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26) Aug 31 11:01:08 volumiozero volumio[823]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) Aug 31 11:01:08 volumiozero volumio[823]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) Aug 31 11:01:08 volumiozero volumio[823]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) Aug 31 11:01:08 volumiozero volumio[823]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) Aug 31 11:01:08 volumiozero volumio[823]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31) Aug 31 11:01:08 volumiozero volumio[823]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) Aug 31 11:01:08 volumiozero volumio[823]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19) Aug 31 11:01:08 volumiozero volumio[823]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15) Aug 31 11:01:08 volumiozero volumio[823]: at IncomingMessage.emit (events.js:327:22) Aug 31 11:01:08 volumiozero volumio[823]: at endReadableNT (internal/streams/readable.js:1327:12) Aug 31 11:01:08 volumiozero volumio[823]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Aug 31 11:01:08 volumiozero volumio[823]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 31 11:01:13 volumiozero sudo[1105]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-08-31 11:00 Aug 31 11:01:13 volumiozero sudo[1105]: 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="5fd3886148e72a9cecd88a772d1f6079fb64d11a" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8bb23b009e91ae4c7ecd678f193e7d3b281fca0c" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 22 Jul 2024 07:17:01 PM CEST" VOLUMIO_VERSION="3.742" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="2782e52360f70dfab079c82951ebbbb1"