-- Logs begin at Thu 2019-02-14 08:11:59 -02, end at Tue 2024-07-09 01:26:30 -03. -- Jul 09 01:25:00 volumio---sala volumiologrotate[645]: ls: cannot access 'SALTO': No such file or directory Jul 09 01:25:32 volumio---sala nmbd[2236]: [2024/07/09 01:25:32.312649, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Jul 09 01:25:32 volumio---sala nmbd[2236]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.68.141 for name WORKGROUP<1d>. Jul 09 01:25:32 volumio---sala nmbd[2236]: This response was from IP 192.168.68.121, reporting an IP address of 192.168.68.121. Jul 09 01:25:39 volumio---sala sudo[4432]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 09 01:25:39 volumio---sala sudo[4432]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 01:25:39 volumio---sala sudo[4432]: pam_unix(sudo:session): session closed for user root Jul 09 01:25:39 volumio---sala sudo[4435]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 09 01:25:39 volumio---sala sudo[4435]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 01:25:39 volumio---sala sudo[4435]: pam_unix(sudo:session): session closed for user root Jul 09 01:25:40 volumio---sala volumio[966]: verbose: New Socket.io Connection to 192.168.68.141 from 192.168.68.131 UA: okhttp/4.9.2 Engine version: 3 Transport: polling Total Clients: 9 Jul 09 01:25:41 volumio---sala volumio[966]: verbose: New Socket.io Connection to 192.168.68.141 from 192.168.68.131 UA: okhttp/4.9.2 Engine version: 3 Transport: polling Total Clients: 10 Jul 09 01:25:41 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 09 01:25:41 volumio---sala volumio[966]: info: CoreCommandRouter::volumioGetVisibleSources Jul 09 01:25:41 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 09 01:25:41 volumio---sala volumio[966]: info: CoreCommandRouter::volumioGetState Jul 09 01:25:41 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jul 09 01:25:41 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 09 01:25:41 volumio---sala volumio[966]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Jul 09 01:25:41 volumio---sala volumio[966]: info: Received Get System Info Jul 09 01:25:41 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 09 01:25:41 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 09 01:25:41 volumio---sala volumio[966]: info: Discovery: Getting this device information Jul 09 01:25:41 volumio---sala volumio[966]: info: CoreCommandRouter::volumioGetState Jul 09 01:25:41 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 09 01:25:41 volumio---sala volumio[966]: info: CoreCommandRouter::volumioGetState Jul 09 01:25:41 volumio---sala volumio[966]: info: Listing playlists Jul 09 01:25:41 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jul 09 01:25:41 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jul 09 01:25:41 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 09 01:25:41 volumio---sala volumio[966]: info: Received Get System Info Jul 09 01:25:41 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 09 01:25:41 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 09 01:25:41 volumio---sala volumio[966]: info: Discovery: Getting this device information Jul 09 01:25:41 volumio---sala volumio[966]: info: CoreCommandRouter::volumioGetState Jul 09 01:25:41 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 09 01:25:41 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 09 01:25:41 volumio---sala volumio[966]: info: CoreCommandRouter::volumioGetVisibleSources Jul 09 01:25:41 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 09 01:25:41 volumio---sala volumio[966]: info: CoreCommandRouter::volumioGetState Jul 09 01:25:41 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jul 09 01:25:41 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 09 01:25:41 volumio---sala volumio[966]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Jul 09 01:25:41 volumio---sala volumio[966]: info: Received Get System Info Jul 09 01:25:41 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 09 01:25:41 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 09 01:25:41 volumio---sala volumio[966]: info: Discovery: Getting this device information Jul 09 01:25:41 volumio---sala volumio[966]: info: CoreCommandRouter::volumioGetState Jul 09 01:25:41 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 09 01:25:41 volumio---sala volumio[966]: info: CoreCommandRouter::volumioGetState Jul 09 01:25:41 volumio---sala volumio[966]: info: Listing playlists Jul 09 01:25:42 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jul 09 01:25:42 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jul 09 01:25:42 volumio---sala volumio[966]: info: CoreCommandRouter::volumioGetQueue Jul 09 01:25:42 volumio---sala volumio[966]: info: CoreStateMachine::getQueue Jul 09 01:25:42 volumio---sala volumio[966]: info: CorePlayQueue::getQueue Jul 09 01:25:43 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Jul 09 01:25:43 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 09 01:25:44 volumio---sala volumio[966]: info: Received Get System Info Jul 09 01:25:44 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 09 01:25:44 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 09 01:25:44 volumio---sala volumio[966]: info: Discovery: Getting this device information Jul 09 01:25:44 volumio---sala volumio[966]: info: CoreCommandRouter::volumioGetState Jul 09 01:25:44 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 09 01:25:45 volumio---sala volumio[966]: info: Tunnel connection is inactive, restarting it Jul 09 01:25:45 volumio---sala volumio[966]: info: Starting Tunnel 1 Jul 09 01:25:45 volumio---sala volumio[966]: info: Starting Tunnel Connection Checker Jul 09 01:25:45 volumio---sala sudo[4443]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service Jul 09 01:25:45 volumio---sala sudo[4443]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 01:25:45 volumio---sala autossh[4228]: received signal to exit (15) Jul 09 01:25:45 volumio---sala systemd[1]: Stopping MyVolumio SSH Tunnel... Jul 09 01:25:45 volumio---sala systemd[1]: sshtunnel.service: Main process exited, code=killed, status=15/TERM Jul 09 01:25:45 volumio---sala systemd[1]: sshtunnel.service: Succeeded. Jul 09 01:25:45 volumio---sala systemd[1]: Stopped MyVolumio SSH Tunnel. Jul 09 01:25:45 volumio---sala volumio[966]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 09 01:25:45 volumio---sala volumio[966]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 09 01:25:46 volumio---sala systemd[1]: Started MyVolumio SSH Tunnel. Jul 09 01:25:46 volumio---sala sudo[4443]: pam_unix(sudo:session): session closed for user root Jul 09 01:25:46 volumio---sala volumio[966]: info: Remote SSH Started Jul 09 01:25:46 volumio---sala autossh[4447]: port set to 0, monitoring disabled Jul 09 01:25:46 volumio---sala autossh[4447]: starting ssh (count 1) Jul 09 01:25:46 volumio---sala autossh[4447]: ssh child pid is 4450 Jul 09 01:25:46 volumio---sala volumio[966]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Jul 09 01:25:46 volumio---sala volumio[966]: info: CoreCommandRouter::volumioGetState Jul 09 01:25:46 volumio---sala volumiossh-tunnel[4445]: Warning: Permanently added '[us1.myvolumio.org]:2222,[162.243.167.188]:2222' (RSA) to the list of known hosts. Jul 09 01:25:49 volumio---sala volumio[966]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 09 01:25:49 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jul 09 01:25:49 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jul 09 01:25:49 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jul 09 01:25:49 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jul 09 01:25:49 volumio---sala volumio[966]: info: Received Get System Version Jul 09 01:25:49 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 09 01:25:52 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 09 01:25:52 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jul 09 01:25:55 volumio---sala volumio[966]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 09 01:25:59 volumio---sala volumio[966]: info: Received OAUTH Data Jul 09 01:25:59 volumio---sala volumio[966]: info: Executing Spotify Oauth Login Jul 09 01:25:59 volumio---sala volumio[966]: info: Saving Spotify Refresh Token Jul 09 01:26:00 volumio---sala sudo[4477]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 09 01:26:00 volumio---sala sudo[4477]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 01:26:00 volumio---sala sudo[4477]: pam_unix(sudo:session): session closed for user root Jul 09 01:26:00 volumio---sala sudo[4487]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 09 01:26:00 volumio---sala sudo[4487]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 01:26:00 volumio---sala sudo[4487]: pam_unix(sudo:session): session closed for user root Jul 09 01:26:00 volumio---sala volumiologrotate[645]: ls: cannot access '/var/log/samba/log.wb-VOLUMIO': No such file or directory Jul 09 01:26:00 volumio---sala volumiologrotate[645]: ls: cannot access 'SALA': No such file or directory Jul 09 01:26:00 volumio---sala volumiologrotate[645]: ls: cannot access 'SALTO': No such file or directory Jul 09 01:26:00 volumio---sala volumio[966]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Jul 09 01:26:00 volumio---sala volumio[966]: SPOTIFY: BQBaETg_sZy05oLCSoF4BGlfTkRgAk97BhVbJ04XC4PBnEvAD4ZpRpYeLtCiT8r4VSmZhkhDYbM2sHhMG0em6tCjntSgwX_pDibnZqcnfy9Efdw-MTzR3fkeZrPB6TGcSznAArW8qm5Lcgln0TDSLIrcX6zHtMTOg6Qsiwj9FF1oZW1E1fryXeVvv1j7Cw1qLtwqh6xRZyTd0pJL3zJvFmQ6i2C3pxcJCjL4Yk6mdLRES3NgI-iqZiBsBi3kPjTm_AFTTVETmV4 Jul 09 01:26:00 volumio---sala volumio[966]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Jul 09 01:26:00 volumio---sala volumio[966]: info: New Spotify access token = BQBaETg_sZy05oLCSoF4BGlfTkRgAk97BhVbJ04XC4PBnEvAD4ZpRpYeLtCiT8r4VSmZhkhDYbM2sHhMG0em6tCjntSgwX_pDibnZqcnfy9Efdw-MTzR3fkeZrPB6TGcSznAArW8qm5Lcgln0TDSLIrcX6zHtMTOg6Qsiwj9FF1oZW1E1fryXeVvv1j7Cw1qLtwqh6xRZyTd0pJL3zJvFmQ6i2C3pxcJCjL4Yk6mdLRES3NgI-iqZiBsBi3kPjTm_AFTTVETmV4 Jul 09 01:26:00 volumio---sala volumio[966]: info: Spotify credentials grant success - running version from March 24, 2019 Jul 09 01:26:00 volumio---sala volumio[966]: verbose: New Socket.io Connection to 192.168.68.141 from 192.168.68.131 UA: okhttp/4.9.2 Engine version: 3 Transport: polling Total Clients: 11 Jul 09 01:26:00 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 09 01:26:00 volumio---sala volumio[966]: info: CoreCommandRouter::volumioGetVisibleSources Jul 09 01:26:00 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 09 01:26:00 volumio---sala volumio[966]: info: CoreCommandRouter::volumioGetState Jul 09 01:26:00 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jul 09 01:26:00 volumio---sala volumio[966]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 09 01:26:00 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 09 01:26:00 volumio---sala volumio[966]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Jul 09 01:26:00 volumio---sala volumio[966]: info: Received Get System Info Jul 09 01:26:00 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 09 01:26:00 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 09 01:26:00 volumio---sala volumio[966]: info: Discovery: Getting this device information Jul 09 01:26:00 volumio---sala volumio[966]: info: CoreCommandRouter::volumioGetState Jul 09 01:26:00 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 09 01:26:00 volumio---sala volumio[966]: info: CoreCommandRouter::volumioGetState Jul 09 01:26:00 volumio---sala volumio[966]: info: Listing playlists Jul 09 01:26:00 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jul 09 01:26:00 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jul 09 01:26:00 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jul 09 01:26:00 volumio---sala volumio[966]: SPOTIFY: User informations: {"display_name":"Pedro Lins","external_urls":{"spotify":"https://open.spotify.com/user/31mw523b5vbactbquhg7wbarr5y4"},"href":"https://api.spotify.com/v1/users/31mw523b5vbactbquhg7wbarr5y4","id":"31mw523b5vbactbquhg7wbarr5y4","images":[],"type":"user","uri":"spotify:user:31mw523b5vbactbquhg7wbarr5y4","followers":{"href":null,"total":0},"country":"BR","product":"premium","explicit_content":{"filter_enabled":false,"filter_locked":false},"email":"pedro.quintao@gmail.com"} Jul 09 01:26:00 volumio---sala volumio[966]: info: Creating Spotify config file Jul 09 01:26:00 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 01:26:00 volumio---sala volumio[966]: info: Spotify config file written Jul 09 01:26:00 volumio---sala sudo[4535]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Jul 09 01:26:00 volumio---sala sudo[4535]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 01:26:00 volumio---sala systemd[1]: Stopping go-librespot Daemon... Jul 09 01:26:00 volumio---sala systemd[1]: go-librespot-daemon.service: Main process exited, code=killed, status=15/TERM Jul 09 01:26:00 volumio---sala systemd[1]: go-librespot-daemon.service: Succeeded. Jul 09 01:26:00 volumio---sala systemd[1]: Stopped go-librespot Daemon. Jul 09 01:26:00 volumio---sala volumio[966]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 09 01:26:00 volumio---sala volumio[966]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 09 01:26:00 volumio---sala volumio[966]: info: Connection to go-librespot Websocket closed Jul 09 01:26:00 volumio---sala systemd[1]: Started go-librespot Daemon. Jul 09 01:26:00 volumio---sala go-librespot[4538]: Librespot-go daemon starting... Jul 09 01:26:00 volumio---sala sudo[4535]: pam_unix(sudo:session): session closed for user root Jul 09 01:26:00 volumio---sala go-librespot[4538]: time="2024-07-09T01:26:00-03:00" level=info msg="generated new device id: 5db8fac636ff75e4fa8bfa7ceaba41c62dd6ccb3" Jul 09 01:26:00 volumio---sala go-librespot[4538]: time="2024-07-09T01:26:00-03:00" level=debug msg="stored credentials not found" Jul 09 01:26:01 volumio---sala volumio[966]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Jul 09 01:26:01 volumio---sala volumio[966]: SPOTIFY: BQAl-IFNxqmJeF25zpI-jhIKzR_v9bHGY__XsGJEh-vDSTGfScONEkjSBPWOzOyT6MsW8Dwg2tZs1d-3oqdkiF29JMJBQ-YaJahub9CkEtvZqdOuzDDiKaEMWwONaqsenmvQIgxZ69zVbopAe4YnJueBcUSyFGDXu0EK3OeH2Zv-ybW04VeJRDuwUmUyYb4NW3OCCr_M8UYLzm3danQAtiWV87eEbcqdc4ECDIoMGghqBiyxEDZl_A4RuFR7l-s6v1bJehKodaU Jul 09 01:26:01 volumio---sala volumio[966]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Jul 09 01:26:01 volumio---sala volumio[966]: info: New Spotify access token = BQAl-IFNxqmJeF25zpI-jhIKzR_v9bHGY__XsGJEh-vDSTGfScONEkjSBPWOzOyT6MsW8Dwg2tZs1d-3oqdkiF29JMJBQ-YaJahub9CkEtvZqdOuzDDiKaEMWwONaqsenmvQIgxZ69zVbopAe4YnJueBcUSyFGDXu0EK3OeH2Zv-ybW04VeJRDuwUmUyYb4NW3OCCr_M8UYLzm3danQAtiWV87eEbcqdc4ECDIoMGghqBiyxEDZl_A4RuFR7l-s6v1bJehKodaU Jul 09 01:26:01 volumio---sala volumio[966]: info: Spotify credentials grant success - running version from March 24, 2019 Jul 09 01:26:01 volumio---sala go-librespot[4538]: time="2024-07-09T01:26:01-03:00" level=debug msg="obtained new client token: AABv+wDtJVFFC3mGSMf3dfqDnRomXNAbbWG5z/xQDv4355lKc8RBWmy4klSdQjt7uw6WaEAJvhmdbS/PJNflXZNH0iX7h6XrIqKoSYkdKnloSvwSt9mZe4XBJ2sGHIC2br1jJrJeHRxPjpP5k3bvHu+abdlE04rLP5qr0p1ew/rgBpgBBHe0nM4UcHhHCR3XGYmczqmWmqXU0qScRFbSPZikx1K44oBkhWt/Ml1x+vdIUTv3WbryCso/TvAz2A==" Jul 09 01:26:01 volumio---sala volumio[966]: SPOTIFY: User informations: {"display_name":"Pedro Lins","external_urls":{"spotify":"https://open.spotify.com/user/31mw523b5vbactbquhg7wbarr5y4"},"href":"https://api.spotify.com/v1/users/31mw523b5vbactbquhg7wbarr5y4","id":"31mw523b5vbactbquhg7wbarr5y4","images":[],"type":"user","uri":"spotify:user:31mw523b5vbactbquhg7wbarr5y4","followers":{"href":null,"total":0},"country":"BR","product":"premium","explicit_content":{"filter_enabled":false,"filter_locked":false},"email":"pedro.quintao@gmail.com"} Jul 09 01:26:01 volumio---sala volumio[966]: info: Spotify Successfully logged in Jul 09 01:26:01 volumio---sala volumio[966]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 09 01:26:01 volumio---sala volumio[966]: info: [1720499161329] CoreMusicLibrary::Adding element Spotify Jul 09 01:26:01 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 09 01:26:01 volumio---sala volumio[966]: Cannot find translation for source TIDAL Jul 09 01:26:01 volumio---sala volumio[966]: Cannot find translation for source YouTube Music Jul 09 01:26:01 volumio---sala volumio[966]: Cannot find translation for source Spotify Jul 09 01:26:01 volumio---sala go-librespot[4538]: time="2024-07-09T01:26:01-03:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Jul 09 01:26:01 volumio---sala go-librespot[4538]: time="2024-07-09T01:26:01-03:00" level=debug msg="completed keyexchange" Jul 09 01:26:01 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Jul 09 01:26:02 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 09 01:26:02 volumio---sala volumio[966]: info: Received Get System Info Jul 09 01:26:02 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 09 01:26:02 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 09 01:26:02 volumio---sala volumio[966]: info: Discovery: Getting this device information Jul 09 01:26:02 volumio---sala volumio[966]: info: CoreCommandRouter::volumioGetState Jul 09 01:26:02 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 09 01:26:02 volumio---sala go-librespot[4538]: time="2024-07-09T01:26:02-03:00" level=debug msg="completed challenge" Jul 09 01:26:02 volumio---sala go-librespot[4538]: time="2024-07-09T01:26:02-03:00" level=debug msg="authenticated as 31mw523b5vbactbquhg7wbarr5y4" Jul 09 01:26:02 volumio---sala go-librespot[4538]: time="2024-07-09T01:26:02-03:00" level=debug msg="authenticated as 31mw523b5vbactbquhg7wbarr5y4" Jul 09 01:26:03 volumio---sala go-librespot[4538]: time="2024-07-09T01:26:03-03:00" level=debug msg="fetched new spclients: [gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Jul 09 01:26:03 volumio---sala go-librespot[4538]: time="2024-07-09T01:26:03-03:00" level=debug msg="fetched new dealers: [gue1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gew1-dealer.spotify.com:443]" Jul 09 01:26:03 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 09 01:26:03 volumio---sala volumio[966]: info: Received Get System Info Jul 09 01:26:03 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 09 01:26:03 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 09 01:26:03 volumio---sala volumio[966]: info: Discovery: Getting this device information Jul 09 01:26:03 volumio---sala volumio[966]: info: CoreCommandRouter::volumioGetState Jul 09 01:26:03 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 09 01:26:03 volumio---sala go-librespot[4538]: time="2024-07-09T01:26:03-03:00" level=debug msg="dealer connection opened" Jul 09 01:26:03 volumio---sala go-librespot[4538]: time="2024-07-09T01:26:03-03:00" level=debug msg="stored credentials for 31mw523b5vbactbquhg7wbarr5y4" Jul 09 01:26:03 volumio---sala go-librespot[4538]: time="2024-07-09T01:26:03-03:00" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336" Jul 09 01:26:03 volumio---sala go-librespot[4538]: time="2024-07-09T01:26:03-03:00" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2" Jul 09 01:26:03 volumio---sala go-librespot[4538]: time="2024-07-09T01:26:03-03:00" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17" Jul 09 01:26:03 volumio---sala go-librespot[4538]: time="2024-07-09T01:26:03-03:00" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0" Jul 09 01:26:03 volumio---sala go-librespot[4538]: time="2024-07-09T01:26:03-03:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 513" Jul 09 01:26:03 volumio---sala go-librespot[4538]: time="2024-07-09T01:26:03-03:00" level=debug msg="received connection id: MzE3NTFiNWEtNGE1MC00YjEyLWEzZjYtMjkzOWExN2FmYmNlK2RlYWxlcit0Y3A6Ly9ndWUxLWRlYWxlci1hLWxkZmsuZ3VlMS5zcG90aWZ5Lm5ldDo1NzAwK0IyMDQ0MTY0ODQ0Qjk5QTE3RDgzNTkxQzM2RTZCOUE4OEJCMkNBMDJCOEU3RDBENTNBOThCRjU3MTg4MkI2RUU=" Jul 09 01:26:03 volumio---sala volumio[966]: info: Initializing connection to go-librespot Websocket Jul 09 01:26:03 volumio---sala go-librespot[4538]: time="2024-07-09T01:26:03-03:00" level=debug msg="new websocket client" Jul 09 01:26:03 volumio---sala volumio[966]: info: Connection to go-librespot Websocket established Jul 09 01:26:03 volumio---sala volumio[966]: info: go-librespot daemon successfully initialized Jul 09 01:26:03 volumio---sala go-librespot[4538]: time="2024-07-09T01:26:03-03:00" level=debug msg="put connect state because NEW_DEVICE" Jul 09 01:26:04 volumio---sala volumio[966]: info: CALLMETHOD: music_service spop saveGoLibrespotSettings [object Object] Jul 09 01:26:04 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: spop , saveGoLibrespotSettings Jul 09 01:26:04 volumio---sala volumio[966]: info: Creating Spotify config file Jul 09 01:26:04 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 01:26:04 volumio---sala volumio[966]: info: Spotify config file written Jul 09 01:26:04 volumio---sala sudo[4549]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Jul 09 01:26:04 volumio---sala sudo[4549]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 01:26:04 volumio---sala systemd[1]: Stopping go-librespot Daemon... Jul 09 01:26:04 volumio---sala systemd[1]: go-librespot-daemon.service: Main process exited, code=killed, status=15/TERM Jul 09 01:26:04 volumio---sala systemd[1]: go-librespot-daemon.service: Succeeded. Jul 09 01:26:04 volumio---sala systemd[1]: Stopped go-librespot Daemon. Jul 09 01:26:04 volumio---sala volumio[966]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 09 01:26:04 volumio---sala volumio[966]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 09 01:26:04 volumio---sala volumio[966]: info: Connection to go-librespot Websocket closed Jul 09 01:26:04 volumio---sala systemd[1]: Started go-librespot Daemon. Jul 09 01:26:04 volumio---sala go-librespot[4551]: Librespot-go daemon starting... Jul 09 01:26:04 volumio---sala sudo[4549]: pam_unix(sudo:session): session closed for user root Jul 09 01:26:04 volumio---sala go-librespot[4551]: time="2024-07-09T01:26:04-03:00" level=info msg="generated new device id: 4c708bf2052ce5db0ee49cd1588be7885041883f" Jul 09 01:26:04 volumio---sala go-librespot[4551]: time="2024-07-09T01:26:04-03:00" level=debug msg="stored credentials found for 31mw523b5vbactbquhg7wbarr5y4" Jul 09 01:26:05 volumio---sala go-librespot[4551]: time="2024-07-09T01:26:05-03:00" level=debug msg="obtained new client token: AACz8fxJO1GXcAKlcpMNaDpR/jqEpKTORdCtAypeGM0OPHFiZKBqSwk3uQijpzhJJR6gcE+FOSOvhw7sg2lydztQKBT6KNC1lWEFhGx3hX+4EI6VGTHdDdcM+upn2L39rbRJ5561zjsZrsXlmVvXhQBFH1Jlk2WbObzxrJ3QQXBOfpzmu8iI5/GsJd3d6herxisbkR4kFOuYNdeP/t24q7PAg4yX/SCRSN7UPjWGa4JPA6+HSO3bcb1q4cEhqA==" Jul 09 01:26:05 volumio---sala go-librespot[4551]: time="2024-07-09T01:26:05-03:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-gae2.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Jul 09 01:26:05 volumio---sala go-librespot[4551]: time="2024-07-09T01:26:05-03:00" level=debug msg="completed keyexchange" Jul 09 01:26:06 volumio---sala volumio[966]: info: CoreCommandRouter::volumioGetQueue Jul 09 01:26:06 volumio---sala volumio[966]: info: CoreStateMachine::getQueue Jul 09 01:26:06 volumio---sala volumio[966]: info: CorePlayQueue::getQueue Jul 09 01:26:06 volumio---sala go-librespot[4551]: time="2024-07-09T01:26:06-03:00" level=debug msg="completed challenge" Jul 09 01:26:06 volumio---sala go-librespot[4551]: time="2024-07-09T01:26:06-03:00" level=debug msg="authenticated as 31mw523b5vbactbquhg7wbarr5y4" Jul 09 01:26:06 volumio---sala volumio[966]: info: Getting Spotify volume Jul 09 01:26:06 volumio---sala volumio[966]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 11 Jul 09 01:26:06 volumio---sala volumio[966]: info: CoreCommandRouter::volumioGetState Jul 09 01:26:06 volumio---sala volumio[966]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jul 09 01:26:06 volumio---sala volumio[966]: info: Initializing connection to go-librespot Websocket Jul 09 01:26:06 volumio---sala go-librespot[4551]: time="2024-07-09T01:26:06-03:00" level=debug msg="new websocket client" Jul 09 01:26:06 volumio---sala volumio[966]: info: Connection to go-librespot Websocket established Jul 09 01:26:06 volumio---sala go-librespot[4551]: time="2024-07-09T01:26:06-03:00" level=debug msg="authenticated as 31mw523b5vbactbquhg7wbarr5y4" Jul 09 01:26:06 volumio---sala go-librespot[4551]: time="2024-07-09T01:26:06-03:00" level=debug msg="fetched new spclients: [gue1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Jul 09 01:26:07 volumio---sala go-librespot[4551]: time="2024-07-09T01:26:07-03:00" level=debug msg="fetched new dealers: [gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Jul 09 01:26:07 volumio---sala go-librespot[4551]: time="2024-07-09T01:26:07-03:00" level=debug msg="dealer connection opened" Jul 09 01:26:07 volumio---sala go-librespot[4551]: time="2024-07-09T01:26:07-03:00" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336" Jul 09 01:26:07 volumio---sala go-librespot[4551]: time="2024-07-09T01:26:07-03:00" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2" Jul 09 01:26:07 volumio---sala go-librespot[4551]: time="2024-07-09T01:26:07-03:00" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17" Jul 09 01:26:07 volumio---sala go-librespot[4551]: time="2024-07-09T01:26:07-03:00" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0" Jul 09 01:26:07 volumio---sala go-librespot[4551]: time="2024-07-09T01:26:07-03:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 513" Jul 09 01:26:07 volumio---sala volumio[966]: info: Spotify volume: 100 Jul 09 01:26:07 volumio---sala go-librespot[4551]: time="2024-07-09T01:26:07-03:00" level=debug msg="received connection id: ZDIxZGI1NWEtYWY1Mi00ZGFkLTkzZmYtYzZmY2FmMTQ3ZGZmK2RlYWxlcit0Y3A6Ly9ndWUxLWRlYWxlci1hLXpiZDcuZ3VlMS5zcG90aWZ5Lm5ldDo1NzAwKzA3OTFENTgxQkU0QjQ2QzkxRjFGMzBDQUI5RTQ5MkIwMTk0OEE3N0Y1NkQ1NkM0NjdFRDgwMEY4OTRBRkI4MkM=" Jul 09 01:26:07 volumio---sala volumio[966]: info: Initializing connection to go-librespot Websocket Jul 09 01:26:07 volumio---sala go-librespot[4551]: time="2024-07-09T01:26:07-03:00" level=debug msg="new websocket client" Jul 09 01:26:07 volumio---sala volumio[966]: info: Connection to go-librespot Websocket established Jul 09 01:26:07 volumio---sala volumio[966]: info: go-librespot daemon successfully initialized Jul 09 01:26:07 volumio---sala go-librespot[4551]: time="2024-07-09T01:26:07-03:00" level=debug msg="put connect state because NEW_DEVICE" Jul 09 01:26:09 volumio---sala volumio[966]: info: Getting Spotify volume Jul 09 01:26:09 volumio---sala volumio[966]: info: Spotify volume: 100 Jul 09 01:26:09 volumio---sala volumio[966]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 11 Jul 09 01:26:09 volumio---sala volumio[966]: info: CoreCommandRouter::volumioGetState Jul 09 01:26:09 volumio---sala volumio[966]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jul 09 01:26:10 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jul 09 01:26:10 volumio---sala volumio[966]: info: Getting Spotify volume Jul 09 01:26:10 volumio---sala volumio[966]: info: Spotify volume: 100 Jul 09 01:26:10 volumio---sala volumio[966]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Jul 09 01:26:10 volumio---sala volumio[966]: info: CoreCommandRouter::volumioGetState Jul 09 01:26:10 volumio---sala volumio[966]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jul 09 01:26:10 volumio---sala volumio[966]: info: Initializing connection to go-librespot Websocket Jul 09 01:26:10 volumio---sala go-librespot[4551]: time="2024-07-09T01:26:10-03:00" level=debug msg="new websocket client" Jul 09 01:26:10 volumio---sala volumio[966]: info: Connection to go-librespot Websocket established Jul 09 01:26:13 volumio---sala volumio[966]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 09 01:26:13 volumio---sala volumio[966]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 09 01:26:13 volumio---sala volumio[966]: info: Retrieving Cloud Streaming UI Jul 09 01:26:13 volumio---sala volumio[966]: info: Getting Tidal Cloud Configuration Jul 09 01:26:13 volumio---sala volumio[966]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 09 01:26:13 volumio---sala volumio[966]: info: Getting Qobuz Cloud Configuration Jul 09 01:26:13 volumio---sala volumio[966]: info: Asking plugin for UI Config Jul 09 01:26:13 volumio---sala volumio[966]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 09 01:26:13 volumio---sala volumio[966]: info: Getting Spotify Cloud Configuration Jul 09 01:26:13 volumio---sala volumio[966]: info: Asking plugin for UI Config Jul 09 01:26:13 volumio---sala volumio[966]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 09 01:26:13 volumio---sala volumio[966]: info: Saving Spotify Acccount Jul 09 01:26:13 volumio---sala volumio[966]: info: Got it Jul 09 01:26:13 volumio---sala volumio[966]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Jul 09 01:26:13 volumio---sala volumio[966]: info: Got Tidal Cloud Configuration Jul 09 01:26:13 volumio---sala volumio[966]: info: Got it Jul 09 01:26:13 volumio---sala volumio[966]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 09 01:26:13 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jul 09 01:26:13 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jul 09 01:26:13 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jul 09 01:26:13 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jul 09 01:26:13 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 09 01:26:13 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 09 01:26:13 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 09 01:26:13 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 09 01:26:13 volumio---sala volumio[966]: info: CoreCommandRouter::volumioGetBrowseSources Jul 09 01:26:13 volumio---sala volumio[966]: info: CoreCommandRouter::volumioGetBrowseSources Jul 09 01:26:13 volumio---sala volumio[966]: info: CoreCommandRouter::volumioGetBrowseSources Jul 09 01:26:13 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 09 01:26:13 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jul 09 01:26:13 volumio---sala volumio[966]: info: Getting Spotify volume Jul 09 01:26:13 volumio---sala volumio[966]: info: Spotify volume: 100 Jul 09 01:26:13 volumio---sala volumio[966]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Jul 09 01:26:13 volumio---sala volumio[966]: info: CoreCommandRouter::volumioGetState Jul 09 01:26:13 volumio---sala volumio[966]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jul 09 01:26:17 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 09 01:26:18 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jul 09 01:26:18 volumio---sala volumio[966]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Jul 09 01:26:18 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Jul 09 01:26:18 volumio---sala volumio[966]: info: Received Get System Version Jul 09 01:26:18 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 09 01:26:18 volumio---sala volumio[966]: info: Received Get System Info Jul 09 01:26:18 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 09 01:26:18 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 09 01:26:18 volumio---sala volumio[966]: info: Discovery: Getting this device information Jul 09 01:26:18 volumio---sala volumio[966]: info: CoreCommandRouter::volumioGetState Jul 09 01:26:18 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 09 01:26:19 volumio---sala volumio[966]: info: Disabling MyMusic plugin upnp Jul 09 01:26:19 volumio---sala sudo[4561]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service Jul 09 01:26:19 volumio---sala sudo[4561]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 01:26:19 volumio---sala systemd[1]: Stopping UPnP Renderer front-end to MPD... Jul 09 01:26:19 volumio---sala volumio[966]: error: Upnp client error: Error: This socket has been ended by the other party Jul 09 01:26:19 volumio---sala volumio[966]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 09 01:26:19 volumio---sala volumio[966]: info: Disabling MyMusic plugin airplay_emulation Jul 09 01:26:19 volumio---sala volumio[966]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesShairport-Sync Jul 09 01:26:19 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 09 01:26:19 volumio---sala volumio[966]: Cannot find translation for source TIDAL Jul 09 01:26:19 volumio---sala volumio[966]: Cannot find translation for source YouTube Music Jul 09 01:26:19 volumio---sala volumio[966]: Cannot find translation for source Spotify Jul 09 01:26:19 volumio---sala volumio[966]: info: Disabling plugin airplay_emulation Jul 09 01:26:19 volumio---sala volumio[966]: info: Done. Jul 09 01:26:19 volumio---sala sudo[4564]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop shairport-sync Jul 09 01:26:19 volumio---sala sudo[4564]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 01:26:19 volumio---sala systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 09 01:26:19 volumio---sala systemd[1]: shairport-sync.service: Succeeded. Jul 09 01:26:19 volumio---sala systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 09 01:26:19 volumio---sala sudo[4564]: pam_unix(sudo:session): session closed for user root Jul 09 01:26:19 volumio---sala volumio[966]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 09 01:26:19 volumio---sala volumio[966]: info: Shairport-Sync Stopped Jul 09 01:26:21 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 09 01:26:23 volumio---sala volumio[966]: info: Disabling MyMusic plugin upnp_browser Jul 09 01:26:23 volumio---sala volumio[966]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesMedia Servers Jul 09 01:26:23 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 09 01:26:23 volumio---sala volumio[966]: Cannot find translation for source TIDAL Jul 09 01:26:23 volumio---sala volumio[966]: Cannot find translation for source YouTube Music Jul 09 01:26:23 volumio---sala volumio[966]: Cannot find translation for source Spotify Jul 09 01:26:23 volumio---sala volumio[966]: info: Disabling plugin upnp_browser Jul 09 01:26:23 volumio---sala volumio[966]: info: Done. Jul 09 01:26:24 volumio---sala volumio[966]: info: Disabling MyMusic plugin bluetooth Jul 09 01:26:24 volumio---sala volumio[966]: info: [MyVolumio PluginManager] Disabling and stopping plugin audio_interface bluetooth Jul 09 01:26:24 volumio---sala sudo[4567]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumiobt.service Jul 09 01:26:24 volumio---sala sudo[4567]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 01:26:24 volumio---sala systemd[1]: Stopping Volumio Bluetooth Module... Jul 09 01:26:24 volumio---sala volumiobt[4569]: Killing pulse Jul 09 01:26:24 volumio---sala volumio[966]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 09 01:26:24 volumio---sala bluetoothd[721]: Endpoint unregistered: sender=:1.49 path=/MediaEndpoint/A2DPSource Jul 09 01:26:24 volumio---sala bluetoothd[721]: Endpoint unregistered: sender=:1.49 path=/MediaEndpoint/A2DPSink Jul 09 01:26:24 volumio---sala volumiobt[4569]: Killing BT Pair agent Jul 09 01:26:24 volumio---sala volumiobt[1853]: Terminated Jul 09 01:26:24 volumio---sala systemd[1]: volumiobt.service: Main process exited, code=killed, status=15/TERM Jul 09 01:26:24 volumio---sala systemd[1]: volumiobt.service: Succeeded. Jul 09 01:26:24 volumio---sala systemd[1]: Stopped Volumio Bluetooth Module. Jul 09 01:26:24 volumio---sala sudo[4567]: pam_unix(sudo:session): session closed for user root Jul 09 01:26:24 volumio---sala volumio[966]: info: Volumio BT Module successfully stopped Jul 09 01:26:24 volumio---sala volumio[966]: info: Disabling plugin bluetooth Jul 09 01:26:25 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 09 01:26:28 volumio---sala volumio[966]: info: Disabling MyMusic plugin upnp Jul 09 01:26:28 volumio---sala sudo[4575]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service Jul 09 01:26:28 volumio---sala sudo[4575]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 01:26:28 volumio---sala volumio[966]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 09 01:26:29 volumio---sala volumio[966]: info: Enabling MyMusic plugin airplay_emulation Jul 09 01:26:29 volumio---sala volumio[966]: info: Enabling plugin airplay_emulation Jul 09 01:26:29 volumio---sala volumio[966]: info: Loading plugin "airplay_emulation"... Jul 09 01:26:29 volumio---sala volumio[966]: info: Starting Shairport Sync Jul 09 01:26:29 volumio---sala volumio[966]: info: PLUGIN START: airplay_emulation Jul 09 01:26:29 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 01:26:29 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 09 01:26:29 volumio---sala volumio[966]: xcb_connection_has_error() returned true Jul 09 01:26:29 volumio---sala volumio[966]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 09 01:26:29 volumio---sala volumio[966]: xcb_connection_has_error() returned true Jul 09 01:26:29 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 01:26:29 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 09 01:26:29 volumio---sala volumio[966]: xcb_connection_has_error() returned true Jul 09 01:26:29 volumio---sala volumio[966]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 09 01:26:29 volumio---sala volumio[966]: xcb_connection_has_error() returned true Jul 09 01:26:29 volumio---sala volumio[966]: info: Done. Jul 09 01:26:29 volumio---sala volumio[966]: info: Starting Shairport Sync Jul 09 01:26:29 volumio---sala volumio[966]: info: Starting Shairport Sync Jul 09 01:26:29 volumio---sala sudo[4584]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 09 01:26:29 volumio---sala sudo[4584]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 01:26:29 volumio---sala sudo[4587]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 09 01:26:29 volumio---sala sudo[4587]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 01:26:29 volumio---sala systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 09 01:26:29 volumio---sala sudo[4584]: pam_unix(sudo:session): session closed for user root Jul 09 01:26:29 volumio---sala volumio[966]: info: Shairport-Sync Started Jul 09 01:26:29 volumio---sala systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 09 01:26:29 volumio---sala systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Jul 09 01:26:29 volumio---sala systemd[1]: shairport-sync.service: Succeeded. Jul 09 01:26:29 volumio---sala systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 09 01:26:29 volumio---sala volumio[966]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 09 01:26:29 volumio---sala volumio[966]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 09 01:26:29 volumio---sala systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 09 01:26:29 volumio---sala sudo[4587]: pam_unix(sudo:session): session closed for user root Jul 09 01:26:29 volumio---sala volumio[966]: info: Shairport-Sync Started Jul 09 01:26:29 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 09 01:26:29 volumio---sala volumio[966]: info: Disabling MyMusic plugin upnp Jul 09 01:26:29 volumio---sala sudo[4594]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service Jul 09 01:26:29 volumio---sala sudo[4594]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 01:26:29 volumio---sala volumio[966]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 09 01:26:30 volumio---sala volumio[966]: info: Enabling MyMusic plugin upnp Jul 09 01:26:30 volumio---sala volumio[966]: info: Enabling plugin upnp Jul 09 01:26:30 volumio---sala volumio[966]: info: Loading plugin "upnp"... Jul 09 01:26:30 volumio---sala volumio[966]: info: [1720499190293] Starting Upmpd Daemon Jul 09 01:26:30 volumio---sala volumio[966]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 09 01:26:30 volumio---sala volumio[966]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 09 01:26:30 volumio---sala volumio[966]: Error: listen EADDRINUSE: address already in use :::6599 Jul 09 01:26:30 volumio---sala volumio[966]: at Server.setupListenHandle [as _listen2] (net.js:1318:16) Jul 09 01:26:30 volumio---sala volumio[966]: at listenInCluster (net.js:1366:12) Jul 09 01:26:30 volumio---sala volumio[966]: at Server.listen (net.js:1452:7) Jul 09 01:26:30 volumio---sala volumio[966]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17) Jul 09 01:26:30 volumio---sala volumio[966]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38) Jul 09 01:26:30 volumio---sala volumio[966]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) Jul 09 01:26:30 volumio---sala volumio[966]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Jul 09 01:26:30 volumio---sala volumio[966]: at processTicksAndRejections (internal/process/task_queues.js:75:11) { Jul 09 01:26:30 volumio---sala volumio[966]: code: 'EADDRINUSE', Jul 09 01:26:30 volumio---sala volumio[966]: errno: -98, Jul 09 01:26:30 volumio---sala volumio[966]: syscall: 'listen', Jul 09 01:26:30 volumio---sala volumio[966]: address: '::', Jul 09 01:26:30 volumio---sala volumio[966]: port: 6599 Jul 09 01:26:30 volumio---sala volumio[966]: } Jul 09 01:26:30 volumio---sala volumio[966]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 09 01:26:30 volumio---sala sudo[4605]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-09 01:25 Jul 09 01:26:30 volumio---sala sudo[4605]: 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="4b122b2365bb8c09786cd63b50d1ea6db780eb4e" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="49f98390f2d84c6549f33dc85b694fbd99e4c720" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 04 Jun 2024 08:41:12 PM CEST" VOLUMIO_VERSION="3.703" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="8e78a6e3f56f1bcbbd1760812129a8e9"