-- 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"