-- Logs begin at Mon 2024-10-07 17:42:07 CEST, end at Mon 2024-10-07 22:21:49 CEST. -- Oct 07 22:20:11 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 07 22:20:11 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 07 22:20:11 volumio volumio[902]: info: Discovery: Getting this device information Oct 07 22:20:11 volumio volumio[902]: info: CoreCommandRouter::volumioGetState Oct 07 22:20:11 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 07 22:20:12 volumio volumio[902]: verbose: New Socket.io Connection to 192.168.1.43:3000 from 192.168.1.20 UA: Dart/3.4 (dart:io) Engine version: 3 Transport: websocket Total Clients: 7 Oct 07 22:20:12 volumio volumio[902]: info: CoreCommandRouter::volumioGetState Oct 07 22:20:12 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 07 22:20:12 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 07 22:20:16 volumio sudo[16104]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 07 22:20:16 volumio sudo[16104]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 07 22:20:16 volumio sudo[16104]: pam_unix(sudo:session): session closed for user root Oct 07 22:20:16 volumio sudo[16107]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 07 22:20:16 volumio sudo[16107]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 07 22:20:16 volumio sudo[16107]: pam_unix(sudo:session): session closed for user root Oct 07 22:20:16 volumio volumio[902]: verbose: New Socket.io Connection to 192.168.1.43 from 192.168.1.20 UA: Mozilla/5.0 (Linux; Android 10; CLT-L29 Build/HUAWEICLT-L29; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/129.0.6668.71 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Oct 07 22:20:17 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 07 22:20:17 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 07 22:20:17 volumio volumio[902]: info: Discovery: Getting this device information Oct 07 22:20:17 volumio volumio[902]: info: CoreCommandRouter::volumioGetState Oct 07 22:20:17 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 07 22:20:17 volumio sudo[16112]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 07 22:20:17 volumio sudo[16112]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 07 22:20:17 volumio sudo[16112]: pam_unix(sudo:session): session closed for user root Oct 07 22:20:17 volumio sudo[16115]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 07 22:20:17 volumio sudo[16115]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 07 22:20:17 volumio sudo[16115]: pam_unix(sudo:session): session closed for user root Oct 07 22:20:17 volumio volumio[902]: verbose: New Socket.io Connection to 192.168.1.43 from 192.168.1.20 UA: Mozilla/5.0 (Linux; Android 10; CLT-L29 Build/HUAWEICLT-L29; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/129.0.6668.71 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Oct 07 22:20:18 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 07 22:20:18 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Oct 07 22:20:18 volumio volumio[902]: info: CoreCommandRouter::volumioGetVisibleSources Oct 07 22:20:18 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 07 22:20:18 volumio volumio[902]: info: CoreCommandRouter::volumioGetState Oct 07 22:20:18 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 07 22:20:18 volumio volumio[902]: info: CoreCommandRouter::volumioGetQueue Oct 07 22:20:18 volumio volumio[902]: info: CoreStateMachine::getQueue Oct 07 22:20:18 volumio volumio[902]: info: CorePlayQueue::getQueue Oct 07 22:20:18 volumio volumio[902]: info: Listing playlists Oct 07 22:20:18 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 07 22:20:18 volumio volumio[902]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Oct 07 22:20:18 volumio volumio[902]: info: Received Get System Info Oct 07 22:20:18 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 07 22:20:18 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 07 22:20:18 volumio volumio[902]: info: Discovery: Getting this device information Oct 07 22:20:18 volumio volumio[902]: info: CoreCommandRouter::volumioGetState Oct 07 22:20:18 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 07 22:20:18 volumio volumio[902]: info: CoreCommandRouter::volumioGetState Oct 07 22:20:18 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 07 22:20:18 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 07 22:20:19 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 07 22:20:19 volumio volumio[902]: info: Received Get System Info Oct 07 22:20:19 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 07 22:20:19 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 07 22:20:19 volumio volumio[902]: info: Discovery: Getting this device information Oct 07 22:20:19 volumio volumio[902]: info: CoreCommandRouter::volumioGetState Oct 07 22:20:19 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 07 22:20:19 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 07 22:20:20 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Oct 07 22:20:21 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 07 22:20:21 volumio volumio[902]: info: Received Get System Info Oct 07 22:20:21 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 07 22:20:21 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 07 22:20:21 volumio volumio[902]: info: Discovery: Getting this device information Oct 07 22:20:21 volumio volumio[902]: info: CoreCommandRouter::volumioGetState Oct 07 22:20:21 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 07 22:20:22 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 07 22:20:22 volumio volumio[902]: info: Received Get System Info Oct 07 22:20:22 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 07 22:20:22 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 07 22:20:22 volumio volumio[902]: info: Discovery: Getting this device information Oct 07 22:20:22 volumio volumio[902]: info: CoreCommandRouter::volumioGetState Oct 07 22:20:22 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 07 22:20:22 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 07 22:20:22 volumio volumio[902]: info: Received Get System Info Oct 07 22:20:22 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 07 22:20:22 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 07 22:20:22 volumio volumio[902]: info: Discovery: Getting this device information Oct 07 22:20:22 volumio volumio[902]: info: CoreCommandRouter::volumioGetState Oct 07 22:20:22 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 07 22:20:27 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 07 22:20:30 volumio sudo[16120]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 07 22:20:30 volumio sudo[16120]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 07 22:20:30 volumio sudo[16120]: pam_unix(sudo:session): session closed for user root Oct 07 22:20:30 volumio sudo[16123]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 07 22:20:30 volumio sudo[16123]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 07 22:20:30 volumio sudo[16123]: pam_unix(sudo:session): session closed for user root Oct 07 22:20:30 volumio volumio[902]: verbose: New Socket.io Connection to 192.168.1.43 from 192.168.1.20 UA: Mozilla/5.0 (Linux; Android 10; CLT-L29 Build/HUAWEICLT-L29; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/129.0.6668.71 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10 Oct 07 22:20:30 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 07 22:20:30 volumio sudo[16128]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 07 22:20:30 volumio sudo[16128]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 07 22:20:30 volumio sudo[16128]: pam_unix(sudo:session): session closed for user root Oct 07 22:20:30 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Oct 07 22:20:30 volumio sudo[16131]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 07 22:20:30 volumio sudo[16131]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 07 22:20:30 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 07 22:20:30 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 07 22:20:30 volumio volumio[902]: info: Discovery: Getting this device information Oct 07 22:20:30 volumio volumio[902]: info: CoreCommandRouter::volumioGetState Oct 07 22:20:30 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 07 22:20:30 volumio sudo[16131]: pam_unix(sudo:session): session closed for user root Oct 07 22:20:30 volumio volumio[902]: verbose: New Socket.io Connection to 192.168.1.43 from 192.168.1.20 UA: Mozilla/5.0 (Linux; Android 10; CLT-L29 Build/HUAWEICLT-L29; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/129.0.6668.71 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11 Oct 07 22:20:31 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 07 22:20:31 volumio volumio[902]: info: CoreCommandRouter::volumioGetVisibleSources Oct 07 22:20:31 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 07 22:20:31 volumio volumio[902]: info: CoreCommandRouter::volumioGetState Oct 07 22:20:31 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 07 22:20:31 volumio volumio[902]: info: CoreCommandRouter::volumioGetQueue Oct 07 22:20:31 volumio volumio[902]: info: CoreStateMachine::getQueue Oct 07 22:20:31 volumio volumio[902]: info: CorePlayQueue::getQueue Oct 07 22:20:31 volumio volumio[902]: info: Listing playlists Oct 07 22:20:31 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 07 22:20:31 volumio volumio[902]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Oct 07 22:20:31 volumio volumio[902]: info: Received Get System Info Oct 07 22:20:31 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 07 22:20:31 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 07 22:20:31 volumio volumio[902]: info: Discovery: Getting this device information Oct 07 22:20:31 volumio volumio[902]: info: CoreCommandRouter::volumioGetState Oct 07 22:20:31 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 07 22:20:31 volumio volumio[902]: info: CoreCommandRouter::volumioGetState Oct 07 22:20:31 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 07 22:20:31 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 07 22:20:31 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Oct 07 22:20:32 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 07 22:20:32 volumio volumio[902]: info: Received Get System Info Oct 07 22:20:32 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 07 22:20:32 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 07 22:20:32 volumio volumio[902]: info: Discovery: Getting this device information Oct 07 22:20:32 volumio volumio[902]: info: CoreCommandRouter::volumioGetState Oct 07 22:20:32 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 07 22:20:32 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Oct 07 22:20:33 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 07 22:20:33 volumio volumio[902]: info: Received Get System Info Oct 07 22:20:33 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 07 22:20:33 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 07 22:20:33 volumio volumio[902]: info: Discovery: Getting this device information Oct 07 22:20:33 volumio volumio[902]: info: CoreCommandRouter::volumioGetState Oct 07 22:20:33 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 07 22:20:36 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 07 22:20:36 volumio volumio[902]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Oct 07 22:20:36 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Oct 07 22:20:36 volumio volumio[902]: info: Received Get System Version Oct 07 22:20:36 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 07 22:20:36 volumio volumio[902]: info: Received Get System Info Oct 07 22:20:36 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 07 22:20:36 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 07 22:20:36 volumio volumio[902]: info: Discovery: Getting this device information Oct 07 22:20:36 volumio volumio[902]: info: CoreCommandRouter::volumioGetState Oct 07 22:20:36 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 07 22:20:40 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 07 22:20:41 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 07 22:20:41 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 07 22:20:41 volumio volumio[902]: info: Discovery: Getting this device information Oct 07 22:20:41 volumio volumio[902]: info: CoreCommandRouter::volumioGetState Oct 07 22:20:41 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 07 22:20:43 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 07 22:20:43 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 07 22:20:47 volumio volumio[902]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 07 22:20:48 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 07 22:20:48 volumio volumio[902]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Oct 07 22:20:48 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Oct 07 22:20:48 volumio volumio[902]: info: Received Get System Version Oct 07 22:20:48 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 07 22:20:48 volumio volumio[902]: info: Received Get System Info Oct 07 22:20:48 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 07 22:20:48 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 07 22:20:48 volumio volumio[902]: info: Discovery: Getting this device information Oct 07 22:20:48 volumio volumio[902]: info: CoreCommandRouter::volumioGetState Oct 07 22:20:48 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 07 22:20:53 volumio volumio[902]: info: Received OAUTH Data Oct 07 22:20:53 volumio volumio[902]: info: Executing Spotify Oauth Login Oct 07 22:20:53 volumio volumio[902]: info: Saving Spotify Refresh Token Oct 07 22:20:54 volumio sudo[16139]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 07 22:20:54 volumio sudo[16139]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 07 22:20:54 volumio sudo[16139]: pam_unix(sudo:session): session closed for user root Oct 07 22:20:54 volumio sudo[16142]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 07 22:20:54 volumio sudo[16142]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 07 22:20:54 volumio sudo[16142]: pam_unix(sudo:session): session closed for user root Oct 07 22:20:54 volumio volumio[902]: verbose: New Socket.io Connection to 192.168.1.43 from 192.168.1.20 UA: Mozilla/5.0 (Linux; Android 10; CLT-L29 Build/HUAWEICLT-L29; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/129.0.6668.71 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10 Oct 07 22:20:54 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 07 22:20:54 volumio volumio[902]: info: CoreCommandRouter::volumioGetVisibleSources Oct 07 22:20:54 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 07 22:20:54 volumio volumio[902]: info: CoreCommandRouter::volumioGetState Oct 07 22:20:54 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 07 22:20:54 volumio volumio[902]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 07 22:20:54 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 07 22:20:54 volumio volumio[902]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Oct 07 22:20:54 volumio volumio[902]: info: Received Get System Info Oct 07 22:20:54 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 07 22:20:54 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 07 22:20:54 volumio volumio[902]: info: Discovery: Getting this device information Oct 07 22:20:54 volumio volumio[902]: info: CoreCommandRouter::volumioGetState Oct 07 22:20:54 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 07 22:20:54 volumio volumio[902]: info: CoreCommandRouter::volumioGetState Oct 07 22:20:54 volumio volumio[902]: info: Listing playlists Oct 07 22:20:54 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 07 22:20:54 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 07 22:20:54 volumio volumio[902]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Oct 07 22:20:54 volumio volumio[902]: SPOTIFY: BQCkgB6kze41RgCN_kaxND073IiIJLCo0mBD9-AFc7lCfDOQZ4DzDuhLdv1TXrxbgpaSIRW78ZpoVxAy5IvrVq_2-yRdj3wCEN4aRYIXOL43cBQzV6hW8R4I96ViwVD1pKp2j05ZqshUYLDuJKIt6DMA0UbL616McPxBasUSIJnGl-j8H4ranYXKVKiawz03tZiTLdtXCOFN_JtQx36hZUnDmb07XZRbwQLl-Lg8oGYXD90GrjzbtQ Oct 07 22:20:54 volumio volumio[902]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Oct 07 22:20:54 volumio volumio[902]: info: New Spotify access token = BQCkgB6kze41RgCN_kaxND073IiIJLCo0mBD9-AFc7lCfDOQZ4DzDuhLdv1TXrxbgpaSIRW78ZpoVxAy5IvrVq_2-yRdj3wCEN4aRYIXOL43cBQzV6hW8R4I96ViwVD1pKp2j05ZqshUYLDuJKIt6DMA0UbL616McPxBasUSIJnGl-j8H4ranYXKVKiawz03tZiTLdtXCOFN_JtQx36hZUnDmb07XZRbwQLl-Lg8oGYXD90GrjzbtQ Oct 07 22:20:54 volumio volumio[902]: info: Spotify credentials grant success - running version from March 24, 2019 Oct 07 22:20:54 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Oct 07 22:20:54 volumio volumio[902]: SPOTIFY: User informations: {"display_name":"sloam8","external_urls":{"spotify":"https://open.spotify.com/user/sloam8"},"href":"https://api.spotify.com/v1/users/sloam8","id":"sloam8","images":[],"type":"user","uri":"spotify:user:sloam8","followers":{"href":null,"total":0},"country":"FR","product":"premium","explicit_content":{"filter_enabled":false,"filter_locked":false},"email":"sloam@orange.fr"} Oct 07 22:20:54 volumio volumio[902]: info: Creating Spotify config file Oct 07 22:20:54 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 07 22:20:54 volumio volumio[902]: info: Spotify config file written Oct 07 22:20:54 volumio sudo[16147]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Oct 07 22:20:54 volumio sudo[16147]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 07 22:20:54 volumio systemd[1]: Stopping go-librespot Daemon... Oct 07 22:20:54 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=killed, status=15/TERM Oct 07 22:20:54 volumio volumio[902]: ------------------------------------ BT MESSAGE: BT STATUS: running Oct 07 22:20:54 volumio volumio[902]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Oct 07 22:20:54 volumio volumio[902]: info: Connection to go-librespot Websocket closed Oct 07 22:20:54 volumio systemd[1]: go-librespot-daemon.service: Succeeded. Oct 07 22:20:54 volumio systemd[1]: Stopped go-librespot Daemon. Oct 07 22:20:54 volumio systemd[1]: Started go-librespot Daemon. Oct 07 22:20:54 volumio go-librespot[16149]: Librespot-go daemon starting... Oct 07 22:20:54 volumio sudo[16147]: pam_unix(sudo:session): session closed for user root Oct 07 22:20:54 volumio go-librespot[16149]: time="2024-10-07T22:20:54+02:00" level=info msg="generated new device id: 1cfc79568586d4c3f0fd4046b49e668ace5e9d37" Oct 07 22:20:54 volumio go-librespot[16149]: time="2024-10-07T22:20:54+02:00" level=debug msg="stored credentials found for sloam8" Oct 07 22:20:54 volumio go-librespot[16149]: time="2024-10-07T22:20: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-gew4.spotify.com:443 ap-gae2.spotify.com:80]" Oct 07 22:20:54 volumio go-librespot[16149]: time="2024-10-07T22:20:54+02:00" level=debug msg="fetched new dealers: [gew1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew4-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Oct 07 22:20:54 volumio go-librespot[16149]: time="2024-10-07T22:20:54+02:00" level=debug msg="fetched new spclients: [gew1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew4-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Oct 07 22:20:54 volumio go-librespot[16149]: time="2024-10-07T22:20:54+02:00" level=debug msg="zeroconf server listening on port 45045" Oct 07 22:20:54 volumio go-librespot[16149]: time="2024-10-07T22:20:54+02:00" level=debug msg="obtained new client token: AAAxh0Rm5Es5hMZVTFe4qwpXC6uVUU0N6bTIXzMY5zooF4+/U8b0JP5a4adEWwcwUWJaE6UUNNel0SURmSo2cYr+vg0ocvW7NcdOwXyvqCmi7LPLTEj0FGsdsrGlcLsqghDw/j5CNsyRN8ZAfnvpJBjnT9dVN1vKhhqCNPhJfOPZ2iE7yVpuubXKttpFH+uqTBbPby0zyL0/+toRO3HmtA+3ISQ92vlx5qu/+o1eXx2EHszDPrzaJ2tUKVys" Oct 07 22:20:54 volumio go-librespot[16149]: time="2024-10-07T22:20:54+02:00" level=info msg="connected to ap-gew1.spotify.com:4070" Oct 07 22:20:54 volumio go-librespot[16149]: time="2024-10-07T22:20:54+02:00" level=debug msg="completed keyexchange" Oct 07 22:20:54 volumio volumio[902]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Oct 07 22:20:54 volumio volumio[902]: SPOTIFY: BQAYaIypEynxITzfeiZW3sJ702wI5374KMtVj06SIcMbT6IslkOebZ4c67XmCuEErpclh-bxZQmCxEUUNwReiol5FTx0vXdtSQGw1jmIiiDLR6KcyqilygYJnI85u_DReycLhCRiU7rhjrZPhirXjCYICywQCh7ThOIFB9JDco6f1ilmS9d9l2SWCQHZGcT826wFYVx1v9vrAgzK66wk_HOPif803V84QnDRCiJQ7rzAfMvgOwWmgQ Oct 07 22:20:54 volumio volumio[902]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Oct 07 22:20:54 volumio volumio[902]: info: New Spotify access token = BQAYaIypEynxITzfeiZW3sJ702wI5374KMtVj06SIcMbT6IslkOebZ4c67XmCuEErpclh-bxZQmCxEUUNwReiol5FTx0vXdtSQGw1jmIiiDLR6KcyqilygYJnI85u_DReycLhCRiU7rhjrZPhirXjCYICywQCh7ThOIFB9JDco6f1ilmS9d9l2SWCQHZGcT826wFYVx1v9vrAgzK66wk_HOPif803V84QnDRCiJQ7rzAfMvgOwWmgQ Oct 07 22:20:54 volumio volumio[902]: info: Spotify credentials grant success - running version from March 24, 2019 Oct 07 22:20:55 volumio volumio[902]: SPOTIFY: User informations: {"display_name":"sloam8","external_urls":{"spotify":"https://open.spotify.com/user/sloam8"},"href":"https://api.spotify.com/v1/users/sloam8","id":"sloam8","images":[],"type":"user","uri":"spotify:user:sloam8","followers":{"href":null,"total":0},"country":"FR","product":"premium","explicit_content":{"filter_enabled":false,"filter_locked":false},"email":"sloam@orange.fr"} Oct 07 22:20:55 volumio volumio[902]: info: Spotify Successfully logged in Oct 07 22:20:55 volumio volumio[902]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 07 22:20:55 volumio volumio[902]: info: [1728332455011] CoreMusicLibrary::Adding element Spotify Oct 07 22:20:55 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 07 22:20:55 volumio volumio[902]: Cannot find translation for source Expert Pro USB Audio 2.0 Oct 07 22:20:55 volumio volumio[902]: Cannot find translation for source TIDAL Oct 07 22:20:55 volumio volumio[902]: Cannot find translation for source Spotify Oct 07 22:20:55 volumio go-librespot[16149]: time="2024-10-07T22:20:55+02:00" level=debug msg="completed challenge" Oct 07 22:20:55 volumio go-librespot[16149]: time="2024-10-07T22:20:55+02:00" level=debug msg="authenticated as sloam8" Oct 07 22:20:55 volumio go-librespot[16149]: time="2024-10-07T22:20:55+02:00" level=debug msg="authenticated as sloam8" Oct 07 22:20:55 volumio go-librespot[16149]: time="2024-10-07T22:20:55+02:00" level=debug msg="dealer connection opened" Oct 07 22:20:55 volumio go-librespot[16149]: time="2024-10-07T22:20:55+02:00" level=debug msg="initializing zeroconf session, username: sloam8" Oct 07 22:20:55 volumio go-librespot[16149]: time="2024-10-07T22:20:55+02:00" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336" Oct 07 22:20:55 volumio go-librespot[16149]: time="2024-10-07T22:20:55+02:00" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2" Oct 07 22:20:55 volumio go-librespot[16149]: time="2024-10-07T22:20:55+02:00" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17" Oct 07 22:20:55 volumio go-librespot[16149]: time="2024-10-07T22:20:55+02:00" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0" Oct 07 22:20:55 volumio go-librespot[16149]: time="2024-10-07T22:20:55+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 505" Oct 07 22:20:55 volumio go-librespot[16149]: time="2024-10-07T22:20:55+02:00" level=debug msg="autoplay enabled: false" Oct 07 22:20:55 volumio go-librespot[16149]: time="2024-10-07T22:20:55+02:00" level=debug msg="received connection id: MDk0YjJhOWUtYjQ2OC00ZGFhLWFjNDktY2U1Mjc5NTRmZWQ2K2RlYWxlcit0Y3A6Ly8wYWNhNDE4ZC5pcC5nZXcxLnNwb3RpZnkubmV0OjU3MDArMTgxRUMwRTIyMERCQTEyRkVFOUU2MDE4MUUyRjEyNjMzNUQ2ODMzMkE2NjEwQjQyOTZEOTc1OUVCQjQ3NTIzQQ==" Oct 07 22:20:55 volumio go-librespot[16149]: time="2024-10-07T22:20:55+02:00" level=debug msg="put connect state because NEW_DEVICE" Oct 07 22:20:55 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Oct 07 22:20:56 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 07 22:20:56 volumio volumio[902]: info: Received Get System Info Oct 07 22:20:56 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 07 22:20:56 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 07 22:20:56 volumio volumio[902]: info: Discovery: Getting this device information Oct 07 22:20:56 volumio volumio[902]: info: CoreCommandRouter::volumioGetState Oct 07 22:20:56 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 07 22:20:56 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 07 22:20:56 volumio volumio[902]: info: Received Get System Info Oct 07 22:20:56 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 07 22:20:56 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 07 22:20:56 volumio volumio[902]: info: Discovery: Getting this device information Oct 07 22:20:56 volumio volumio[902]: info: CoreCommandRouter::volumioGetState Oct 07 22:20:56 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 07 22:20:57 volumio volumio[902]: info: Initializing connection to go-librespot Websocket Oct 07 22:20:57 volumio go-librespot[16149]: time="2024-10-07T22:20:57+02:00" level=debug msg="new websocket client" Oct 07 22:20:57 volumio volumio[902]: info: Connection to go-librespot Websocket established Oct 07 22:20:57 volumio volumio[902]: info: go-librespot daemon successfully initialized Oct 07 22:21:00 volumio volumio[902]: info: Getting Spotify volume Oct 07 22:21:00 volumio volumio[902]: info: Spotify volume: 100 Oct 07 22:21:00 volumio volumio[902]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 11 Oct 07 22:21:00 volumio volumio[902]: info: CoreCommandRouter::volumioGetState Oct 07 22:21:00 volumio volumio[902]: SPOTIFY: RECEIVED VOLUMIO VOLUME 80 Oct 07 22:21:00 volumio volumio[902]: SPOTIFY: SPOTIFY VOLUME 100 Oct 07 22:21:00 volumio volumio[902]: SPOTIFY: VOLUMIO VOLUME 80 Oct 07 22:21:00 volumio volumio[902]: SPOTIFY: DELTA VOLUME ENOUGH: true Oct 07 22:21:00 volumio volumio[902]: info: Setting Spotify Volume from Volumio: 80 Oct 07 22:21:00 volumio volumio[902]: info: Initializing connection to go-librespot Websocket Oct 07 22:21:00 volumio go-librespot[16149]: time="2024-10-07T22:21:00+02:00" level=debug msg="new websocket client" Oct 07 22:21:00 volumio volumio[902]: info: Connection to go-librespot Websocket established Oct 07 22:21:02 volumio volumio[902]: SPOTIFY: SETTING SPOTIFY VOLUME 80 Oct 07 22:21:02 volumio volumio[902]: info: Sending Spotify command with payload to local API: /player/volume Oct 07 22:21:02 volumio volumio[902]: error: Failed to send command to Spotify local API: /player/volume: Error: Bad Request Oct 07 22:21:03 volumio volumio[902]: info: Getting Spotify volume Oct 07 22:21:03 volumio volumio[902]: info: Spotify volume: 100 Oct 07 22:21:03 volumio volumio[902]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Oct 07 22:21:03 volumio volumio[902]: info: CoreCommandRouter::volumioGetState Oct 07 22:21:03 volumio volumio[902]: SPOTIFY: RECEIVED VOLUMIO VOLUME 80 Oct 07 22:21:03 volumio volumio[902]: SPOTIFY: SPOTIFY VOLUME 100 Oct 07 22:21:03 volumio volumio[902]: SPOTIFY: VOLUMIO VOLUME 80 Oct 07 22:21:03 volumio volumio[902]: SPOTIFY: DELTA VOLUME ENOUGH: true Oct 07 22:21:03 volumio volumio[902]: info: Setting Spotify Volume from Volumio: 80 Oct 07 22:21:05 volumio volumio[902]: SPOTIFY: SETTING SPOTIFY VOLUME 80 Oct 07 22:21:05 volumio volumio[902]: info: Sending Spotify command with payload to local API: /player/volume Oct 07 22:21:05 volumio volumio[902]: error: Failed to send command to Spotify local API: /player/volume: Error: Bad Request Oct 07 22:21:11 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 07 22:21:11 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 07 22:21:11 volumio volumio[902]: info: Discovery: Getting this device information Oct 07 22:21:11 volumio volumio[902]: info: CoreCommandRouter::volumioGetState Oct 07 22:21:11 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 07 22:21:15 volumio go-librespot[16149]: time="2024-10-07T22:21:15+02:00" level=debug msg="skipping dealer message" uri=social-connect/v2/broadcast_status_update Oct 07 22:21:15 volumio go-librespot[16149]: time="2024-10-07T22:21:15+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 340" Oct 07 22:21:16 volumio go-librespot[16149]: time="2024-10-07T22:21:16+02:00" level=debug msg="skipping dealer message" uri=social-connect/v2/broadcast_status_update Oct 07 22:21:16 volumio go-librespot[16149]: time="2024-10-07T22:21:16+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 344" Oct 07 22:21:21 volumio go-librespot[16149]: time="2024-10-07T22:21:21+02:00" level=debug msg="handling transfer player command from 51c819875d0010c112d05cc2fec9e46981b3aa40" Oct 07 22:21:22 volumio go-librespot[16149]: time="2024-10-07T22:21:22+02:00" level=debug msg="resolved context of track" uri="spotify:user:sloam8:collection" Oct 07 22:21:22 volumio go-librespot[16149]: time="2024-10-07T22:21:22+02:00" level=trace msg="fetched new page 0 with 722 items (list: 722)" uri="spotify:user:sloam8:collection" Oct 07 22:21:22 volumio go-librespot[16149]: time="2024-10-07T22:21:22+02:00" level=debug msg="loading track (paused: false, position: 6876ms)" uri="spotify:track:1dXNoiwDI5eiIR7PsROTXB" Oct 07 22:21:22 volumio go-librespot[16149]: time="2024-10-07T22:21:22+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Oct 07 22:21:22 volumio go-librespot[16149]: time="2024-10-07T22:21:22+02:00" level=trace msg="emitting websocket event: will_play" Oct 07 22:21:22 volumio volumio[902]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:1dXNoiwDI5eiIR7PsROTXB","play_origin":"collection-songs"}} Oct 07 22:21:22 volumio volumio[902]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:1dXNoiwDI5eiIR7PsROTXB","play_origin":"collection-songs"}} Oct 07 22:21:22 volumio go-librespot[16149]: time="2024-10-07T22:21:22+02:00" level=debug msg="selected format OGG_VORBIS_320 (a7c7e0f45f3adefc84653445f20c7031ed210c3a)" uri="spotify:track:1dXNoiwDI5eiIR7PsROTXB" Oct 07 22:21:22 volumio go-librespot[16149]: time="2024-10-07T22:21:22+02:00" level=debug msg="requested aes key for file a7c7e0f45f3adefc84653445f20c7031ed210c3a, gid: 1dXNoiwDI5eiIR7PsROTXB" Oct 07 22:21:22 volumio go-librespot[16149]: time="2024-10-07T22:21:22+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 241" Oct 07 22:21:22 volumio go-librespot[16149]: time="2024-10-07T22:21:22+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 1359" Oct 07 22:21:22 volumio go-librespot[16149]: time="2024-10-07T22:21:22+02:00" level=debug msg="fetched first chunk of 25, total size is 12636560 bytes" uri="spotify:track:1dXNoiwDI5eiIR7PsROTXB" Oct 07 22:21:22 volumio go-librespot[16149]: time="2024-10-07T22:21:22+02:00" level=trace msg="seek to 6876ms (diff: 40ms, samples: 303231, bytes: 212145)" uri="spotify:track:1dXNoiwDI5eiIR7PsROTXB" Oct 07 22:21:22 volumio go-librespot[16149]: ALSA lib /home/volumio-alsa-plugin/src/pcm_volumioswitch.c:143:(_snd_pcm_volumioswitch_open_target_pcm) PCM Volumio ALSA Switch Plugin failed to open the switcher target pcm volumioLocalPlayback Oct 07 22:21:22 volumio go-librespot[16149]: time="2024-10-07T22:21:22+02:00" level=warning msg="failed handling dealer request" error="failed loading current track (transfer): failed setting stream for spotify:track:1dXNoiwDI5eiIR7PsROTXB: ALSA error at snd_pcm_open: Device or resource busy" Oct 07 22:21:22 volumio go-librespot[16149]: time="2024-10-07T22:21:22+02:00" level=debug msg="skipping dealer message" uri=social-connect/v2/broadcast_status_update Oct 07 22:21:22 volumio go-librespot[16149]: time="2024-10-07T22:21:22+02:00" level=debug msg="skipping dealer message" uri=social-connect/v2/session_update Oct 07 22:21:22 volumio go-librespot[16149]: time="2024-10-07T22:21:22+02:00" level=debug msg="fetched chunk 1/24, size: 524288" uri="spotify:track:1dXNoiwDI5eiIR7PsROTXB" Oct 07 22:21:22 volumio go-librespot[16149]: time="2024-10-07T22:21:22+02:00" level=debug msg="fetched chunk 2/24, size: 524288" uri="spotify:track:1dXNoiwDI5eiIR7PsROTXB" Oct 07 22:21:22 volumio go-librespot[16149]: time="2024-10-07T22:21:22+02:00" level=debug msg="fetched chunk 3/24, size: 524288" uri="spotify:track:1dXNoiwDI5eiIR7PsROTXB" Oct 07 22:21:22 volumio go-librespot[16149]: time="2024-10-07T22:21:22+02:00" level=debug msg="skipping dealer message" uri=social-connect/v2/session_update Oct 07 22:21:22 volumio go-librespot[16149]: time="2024-10-07T22:21:22+02:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 1141" Oct 07 22:21:32 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 07 22:21:32 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 07 22:21:32 volumio volumio[902]: info: Discovery: Getting this device information Oct 07 22:21:32 volumio volumio[902]: info: CoreCommandRouter::volumioGetState Oct 07 22:21:32 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 07 22:21:33 volumio volumio[902]: verbose: New Socket.io Connection to 192.168.1.43:3000 from 192.168.1.20 UA: Dart/3.4 (dart:io) Engine version: 3 Transport: websocket Total Clients: 7 Oct 07 22:21:39 volumio sudo[16206]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 07 22:21:39 volumio sudo[16206]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 07 22:21:39 volumio sudo[16206]: pam_unix(sudo:session): session closed for user root Oct 07 22:21:39 volumio sudo[16209]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 07 22:21:39 volumio sudo[16209]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 07 22:21:39 volumio sudo[16209]: pam_unix(sudo:session): session closed for user root Oct 07 22:21:39 volumio volumio[902]: verbose: New Socket.io Connection to 192.168.1.43 from 192.168.1.20 UA: Mozilla/5.0 (Linux; Android 10; CLT-L29 Build/HUAWEICLT-L29; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/129.0.6668.71 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Oct 07 22:21:40 volumio sudo[16214]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 07 22:21:40 volumio sudo[16214]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 07 22:21:40 volumio sudo[16214]: pam_unix(sudo:session): session closed for user root Oct 07 22:21:40 volumio sudo[16217]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 07 22:21:40 volumio sudo[16217]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 07 22:21:40 volumio sudo[16217]: pam_unix(sudo:session): session closed for user root Oct 07 22:21:40 volumio volumio[902]: verbose: New Socket.io Connection to 192.168.1.43 from 192.168.1.20 UA: Mozilla/5.0 (Linux; Android 10; CLT-L29 Build/HUAWEICLT-L29; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/129.0.6668.71 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Oct 07 22:21:40 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 07 22:21:40 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Oct 07 22:21:40 volumio volumio[902]: info: CoreCommandRouter::volumioGetVisibleSources Oct 07 22:21:40 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 07 22:21:40 volumio volumio[902]: info: CoreCommandRouter::volumioGetState Oct 07 22:21:40 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 07 22:21:40 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 07 22:21:40 volumio volumio[902]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Oct 07 22:21:40 volumio volumio[902]: info: Received Get System Info Oct 07 22:21:40 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 07 22:21:40 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 07 22:21:40 volumio volumio[902]: info: Discovery: Getting this device information Oct 07 22:21:40 volumio volumio[902]: info: CoreCommandRouter::volumioGetState Oct 07 22:21:40 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 07 22:21:40 volumio volumio[902]: info: CoreCommandRouter::volumioGetState Oct 07 22:21:40 volumio volumio[902]: info: Listing playlists Oct 07 22:21:40 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 07 22:21:40 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 07 22:21:41 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 07 22:21:41 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 07 22:21:41 volumio volumio[902]: info: Discovery: Getting this device information Oct 07 22:21:41 volumio volumio[902]: info: CoreCommandRouter::volumioGetState Oct 07 22:21:41 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 07 22:21:42 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 07 22:21:42 volumio volumio[902]: info: Received Get System Info Oct 07 22:21:42 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 07 22:21:42 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 07 22:21:42 volumio volumio[902]: info: Discovery: Getting this device information Oct 07 22:21:42 volumio volumio[902]: info: CoreCommandRouter::volumioGetState Oct 07 22:21:42 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 07 22:21:42 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Oct 07 22:21:42 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 07 22:21:42 volumio volumio[902]: info: Received Get System Info Oct 07 22:21:42 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 07 22:21:42 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 07 22:21:42 volumio volumio[902]: info: Discovery: Getting this device information Oct 07 22:21:42 volumio volumio[902]: info: CoreCommandRouter::volumioGetState Oct 07 22:21:42 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 07 22:21:43 volumio volumio[902]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 07 22:21:43 volumio volumio[902]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 07 22:21:43 volumio volumio[902]: info: Retrieving Cloud Streaming UI Oct 07 22:21:43 volumio volumio[902]: info: Getting Tidal Cloud Configuration Oct 07 22:21:43 volumio volumio[902]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 07 22:21:43 volumio volumio[902]: info: Getting Qobuz Cloud Configuration Oct 07 22:21:43 volumio volumio[902]: info: Asking plugin for UI Config Oct 07 22:21:43 volumio volumio[902]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 07 22:21:43 volumio volumio[902]: info: Getting Spotify Cloud Configuration Oct 07 22:21:43 volumio volumio[902]: info: Asking plugin for UI Config Oct 07 22:21:43 volumio volumio[902]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 07 22:21:43 volumio volumio[902]: info: Saving Spotify Acccount Oct 07 22:21:43 volumio volumio[902]: info: Got it Oct 07 22:21:43 volumio volumio[902]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Oct 07 22:21:43 volumio volumio[902]: info: Got Tidal Cloud Configuration Oct 07 22:21:43 volumio volumio[902]: info: Got it Oct 07 22:21:43 volumio volumio[902]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 07 22:21:43 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 07 22:21:43 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 07 22:21:43 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 07 22:21:43 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 07 22:21:43 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 07 22:21:43 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 07 22:21:43 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 07 22:21:43 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 07 22:21:43 volumio volumio[902]: info: CoreCommandRouter::volumioGetBrowseSources Oct 07 22:21:43 volumio volumio[902]: info: CoreCommandRouter::volumioGetBrowseSources Oct 07 22:21:43 volumio volumio[902]: info: CoreCommandRouter::volumioGetBrowseSources Oct 07 22:21:44 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 07 22:21:44 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Oct 07 22:21:47 volumio volumio[902]: info: Disabling MyMusic plugin upnp Oct 07 22:21:47 volumio sudo[16222]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service Oct 07 22:21:47 volumio sudo[16222]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 07 22:21:47 volumio systemd[1]: Stopping UPnP Renderer front-end to MPD... Oct 07 22:21:47 volumio volumio[902]: error: Upnp client error: Error: This socket has been ended by the other party Oct 07 22:21:47 volumio volumio[902]: ------------------------------------ BT MESSAGE: BT STATUS: running Oct 07 22:21:48 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 07 22:21:49 volumio volumio[902]: info: Enabling MyMusic plugin upnp Oct 07 22:21:49 volumio volumio[902]: info: Enabling plugin upnp Oct 07 22:21:49 volumio volumio[902]: info: Loading plugin "upnp"... Oct 07 22:21:49 volumio volumio[902]: info: [1728332509295] Starting Upmpd Daemon Oct 07 22:21:49 volumio volumio[902]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 07 22:21:49 volumio volumio[902]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 07 22:21:49 volumio volumio[902]: Error: listen EADDRINUSE: address already in use :::6599 Oct 07 22:21:49 volumio volumio[902]: at Server.setupListenHandle [as _listen2] (net.js:1331:16) Oct 07 22:21:49 volumio volumio[902]: at listenInCluster (net.js:1379:12) Oct 07 22:21:49 volumio volumio[902]: at Server.listen (net.js:1465:7) Oct 07 22:21:49 volumio volumio[902]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17) Oct 07 22:21:49 volumio volumio[902]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38) Oct 07 22:21:49 volumio volumio[902]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) Oct 07 22:21:49 volumio volumio[902]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Oct 07 22:21:49 volumio volumio[902]: at processTicksAndRejections (internal/process/task_queues.js:77:11) { Oct 07 22:21:49 volumio volumio[902]: code: 'EADDRINUSE', Oct 07 22:21:49 volumio volumio[902]: errno: -98, Oct 07 22:21:49 volumio volumio[902]: syscall: 'listen', Oct 07 22:21:49 volumio volumio[902]: address: '::', Oct 07 22:21:49 volumio volumio[902]: port: 6599 Oct 07 22:21:49 volumio volumio[902]: } Oct 07 22:21:49 volumio volumio[902]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 07 22:21:49 volumio sudo[16233]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-07 22:20 Oct 07 22:21:49 volumio sudo[16233]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 17 Sep 2024 05:33:09 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="ee834e1c2a28de3c5d8c48611ecf1167"