Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

Sign up for GitHub

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Jump to bottom

[Errno 104] Connection reset by peer from Spotcast #511

Open
mfabiani53 opened this issue Jan 24, 2025 · 11 comments
Open

[Errno 104] Connection reset by peer from Spotcast #511

mfabiani53 opened this issue Jan 24, 2025 · 11 comments
Assignees
@fcusson
Labels
beta Related to the beta program bug Something isn't working more info needed Maintainers will be unable to work on the issue until more information is provided

Comments

@mfabiani53
Copy link

The problem

I am getting ton of these errors and really don't know the meaning of them and the reasons...

2025-01-24` 17:11:43.073 ERROR (MainThread) [homeassistant.helpers.entity] Update for sensor.spotcast_mfabiani53_spotify_liked_songs fails
Traceback (most recent call last):
  File "/usr/local/lib/python3.13/site-packages/urllib3/connectionpool.py", line 716, in urlopen
    httplib_response = self._make_request(
        conn,
    ...<5 lines>...
        chunked=chunked,
    )
  File "/usr/local/lib/python3.13/site-packages/urllib3/connectionpool.py", line 468, in _make_request
    six.raise_from(e, None)
    ~~~~~~~~~~~~~~^^^^^^^^^
  File "<string>", line 3, in raise_from
  File "/usr/local/lib/python3.13/site-packages/urllib3/connectionpool.py", line 463, in _make_request
    httplib_response = conn.getresponse()
  File "/usr/local/lib/python3.13/http/client.py", line 1428, in getresponse
    response.begin()
    ~~~~~~~~~~~~~~^^
  File "/usr/local/lib/python3.13/http/client.py", line 331, in begin
    version, status, reason = self._read_status()
                              ~~~~~~~~~~~~~~~~~^^
  File "/usr/local/lib/python3.13/http/client.py", line 292, in _read_status
    line = str(self.fp.readline(_MAXLINE + 1), "iso-8859-1")
               ~~~~~~~~~~~~~~~~^^^^^^^^^^^^^^
  File "/usr/local/lib/python3.13/socket.py", line 719, in readinto
    return self._sock.recv_into(b)
           ~~~~~~~~~~~~~~~~~~~~^^^
  File "/usr/local/lib/python3.13/ssl.py", line 1304, in recv_into
    return self.read(nbytes, buffer)
           ~~~~~~~~~^^^^^^^^^^^^^^^^
  File "/usr/local/lib/python3.13/ssl.py", line 1138, in read
    return self._sslobj.read(len, buffer)
           ~~~~~~~~~~~~~~~~~^^^^^^^^^^^^^
ConnectionResetError: [Errno 104] Connection reset by peer

During handling of the above exception, another exception occurred:

Traceback (most recent call last):
  File "/usr/local/lib/python3.13/site-packages/requests/adapters.py", line 667, in send
    resp = conn.urlopen(
        method=request.method,
    ...<9 lines>...
        chunked=chunked,
    )
  File "/usr/local/lib/python3.13/site-packages/urllib3/connectionpool.py", line 802, in urlopen
    retries = retries.increment(
        method, url, error=e, _pool=self, _stacktrace=sys.exc_info()[2]
    )
  File "/usr/local/lib/python3.13/site-packages/urllib3/util/retry.py", line 552, in increment
    raise six.reraise(type(error), error, _stacktrace)
          ~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  File "/usr/local/lib/python3.13/site-packages/urllib3/packages/six.py", line 769, in reraise
    raise value.with_traceback(tb)
  File "/usr/local/lib/python3.13/site-packages/urllib3/connectionpool.py", line 716, in urlopen
    httplib_response = self._make_request(
        conn,
    ...<5 lines>...
        chunked=chunked,
    )
  File "/usr/local/lib/python3.13/site-packages/urllib3/connectionpool.py", line 468, in _make_request
    six.raise_from(e, None)
    ~~~~~~~~~~~~~~^^^^^^^^^
  File "<string>", line 3, in raise_from
  File "/usr/local/lib/python3.13/site-packages/urllib3/connectionpool.py", line 463, in _make_request
    httplib_response = conn.getresponse()
  File "/usr/local/lib/python3.13/http/client.py", line 1428, in getresponse
    response.begin()
    ~~~~~~~~~~~~~~^^
  File "/usr/local/lib/python3.13/http/client.py", line 331, in begin
    version, status, reason = self._read_status()
                              ~~~~~~~~~~~~~~~~~^^
  File "/usr/local/lib/python3.13/http/client.py", line 292, in _read_status
    line = str(self.fp.readline(_MAXLINE + 1), "iso-8859-1")
               ~~~~~~~~~~~~~~~~^^^^^^^^^^^^^^
  File "/usr/local/lib/python3.13/socket.py", line 719, in readinto
    return self._sock.recv_into(b)
           ~~~~~~~~~~~~~~~~~~~~^^^
  File "/usr/local/lib/python3.13/ssl.py", line 1304, in recv_into
    return self.read(nbytes, buffer)
           ~~~~~~~~~^^^^^^^^^^^^^^^^
  File "/usr/local/lib/python3.13/ssl.py", line 1138, in read
    return self._sslobj.read(len, buffer)
           ~~~~~~~~~~~~~~~~~^^^^^^^^^^^^^
urllib3.exceptions.ProtocolError: ('Connection aborted.', ConnectionResetError(104, 'Connection reset by peer'))

During handling of the above exception, another exception occurred:

Traceback (most recent call last):
  File "/usr/src/homeassistant/homeassistant/helpers/entity.py", line 960, in async_update_ha_state
    await self.async_device_update()
  File "/usr/src/homeassistant/homeassistant/helpers/entity.py", line 1318, in async_device_update
    await self.async_update()
  File "/config/custom_components/spotcast/sensor/spotify_liked_songs_sensor.py", line 40, in async_update
    count = await self.account.async_liked_songs_count()
            ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  File "/config/custom_components/spotcast/spotify/account.py", line 911, in async_liked_songs_count
    return await self._async_get_count(
           ^^^^^^^^^^^^^^^^^^^^^^^^^^^^
        self.apis["private"].current_user_saved_tracks,
        ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
    )
    ^
  File "/config/custom_components/spotcast/spotify/account.py", line 1158, in _async_get_count
    result = await self.hass.async_add_executor_job(
             ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
    ...<2 lines>...
    )
    ^
  File "/usr/local/lib/python3.13/concurrent/futures/thread.py", line 59, in run
    result = self.fn(*self.args, **self.kwargs)
  File "/usr/local/lib/python3.13/site-packages/spotipy/client.py", line 1286, in current_user_saved_tracks
    return self._get("me/tracks", limit=limit, offset=offset, market=market)
           ~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  File "/usr/local/lib/python3.13/site-packages/spotipy/client.py", line 323, in _get
    return self._internal_call("GET", url, payload, kwargs)
           ~~~~~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  File "/usr/local/lib/python3.13/site-packages/spotipy/client.py", line 266, in _internal_call
    response = self._session.request(
        method, url, headers=headers, proxies=self.proxies,
        timeout=self.requests_timeout, **args
    )
  File "/usr/local/lib/python3.13/site-packages/requests/sessions.py", line 589, in request
    resp = self.send(prep, **send_kwargs)
  File "/usr/local/lib/python3.13/site-packages/requests/sessions.py", line 703, in send
    r = adapter.send(request, **kwargs)
  File "/usr/local/lib/python3.13/site-packages/requests/adapters.py", line 682, in send
    raise ConnectionError(err, request=request)
requests.exceptions.ConnectionError: ('Connection aborted.', ConnectionResetError(104, 'Connection reset by peer'))
2025-01-24 17:15:43.232 ERROR (MainThread) [homeassistant] Error doing job: Task exception was never retrieved (None)
Traceback (most recent call last):
  File "/config/custom_components/spotcast/media_player/device_manager.py", line 124, in async_update
    playback_state = await self._account.async_playback_state()
                     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  File "/config/custom_components/spotcast/spotify/account.py", line 661, in async_playback_state
    data = await self._async_add_audio_features(data)
           ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  File "/config/custom_components/spotcast/spotify/account.py", line 672, in _async_add_audio_features
    current_uri = playback_state.get("item", {}).get("uri")
                  `^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^

Any hints?
Hope this helps....

System Health details

System Information

version core-2025.1.4
installation_type Home Assistant OS
dev false
hassio true
docker true
user root
virtualenv false
python_version 3.13.1
os_name Linux
os_version 6.6.62-haos-raspi
arch aarch64
timezone Europe/Rome
config_dir /config
Home Assistant Community Store
GitHub API ok
GitHub Content ok
GitHub Web ok
HACS Data ok
GitHub API Calls Remaining 5000
Installed Version 2.0.3
Stage running
Available Repositories 1501
Downloaded Repositories 52
AccuWeather
can_reach_server ok
remaining_requests 13
Home Assistant Cloud
logged_in true
subscription_expiration 22 agosto 2025 alle ore 02:00
relayer_connected true
relayer_region eu-central-1
remote_enabled true
remote_connected true
alexa_enabled true
google_enabled true
cloud_ice_servers_enabled true
remote_server eu-central-1-0.ui.nabu.casa
certificate_status ready
instance_id 997fba7ab1624de78c408ed3cd76897a
can_reach_cert_server ok
can_reach_cloud_auth ok
can_reach_cloud ok
Home Assistant Supervisor
host_os Home Assistant OS 14.1
update_channel stable
supervisor_version supervisor-2024.12.3
agent_version 1.6.0
docker_version 27.2.0
disk_total 219.4 GB
disk_used 13.6 GB
healthy true
supported true
host_connectivity true
supervisor_connectivity true
ntp_synchronized true
virtualization
board rpi4-64
supervisor_api ok
version_api ok
installed_addons Samba share (12.4.0), Advanced SSH & Web Terminal (20.0.0), Home Assistant Google Drive Backup (0.112.1), Terminal & SSH (9.16.0), Music Assistant Server (beta) (2.4.0b20)
Dashboards
dashboards 19
resources 42
views 32
mode yaml
Recorder
oldest_recorder_run 13 gennaio 2025 alle ore 21:05
current_recorder_run 24 gennaio 2025 alle ore 13:08
estimated_db_size 1485.05 MiB
database_engine sqlite
database_version 3.47.1
Spotcast
Version 5.0.0-b24
Mfabiani53 Is Default true
Mfabiani53 Public Endpoint ok
Mfabiani53 Public Token healthy
Mfabiani53 Private Endpoint ok
Mfabiani53 Private Token healthy
Mfabiani53 Product free
Spotify
api_endpoint_reachable ok

What type of installation are you running?

Home Assistant OS

Diagnostics information

ersione | core-2025.1.4 -- | -- Installation type | Home Assistant OS Sviluppo | false Supervisor | true Docker | true Utente | root Virtual environment | false Python version | 3.13.1 Operating system family | Linux Operating system version | 6.6.62-haos-raspi CPU architecture | aarch64 Fuso orario | Europe/Rome Configuration directory | /config

Example YAML snippet



Anything in the logs that might be useful for us?




Additional information


No response

      		
    

      
  





        



            

              
            

        

      


      
    








      

    



      

  
            

    

      
    

    


      

          @mfabiani53
mfabiani53




            added
      

  beta

  Related to the beta program

      

  bug

  Something isn't working

      

  pending-triage

  The issue is awaiting a review from a maintainer

  labels


      Jan 24, 2025

    

  



    


    

    

      
    

    


      

          @fcusson
fcusson




          removed
  the 

  pending-triage

  The issue is awaiting a review from a maintainer
 label


      Jan 24, 2025

    

  








      

  
      



  

  @fcusson





  


    

      

  

    

        
    
    

  


      
          
  
      
            Copy link

  

      
    

  


  

      

  
    Collaborator


      

  


  

    

      

      
            fcusson
  

      

      

      commented


        Jan 24, 2025


      
    


  





      


        


  
    

      
          
@mfabiani53, this look like a connection issue with Spotify. ConnectionResetError: [Errno 104] Connection reset by peer means somewhere in the network stack a device declined your connection. This could be for loads of reason:


    

  • Your device had a change of IP address, that should not be the case with a Home Assistant
    • 

  • The Spotify Proxy you are using is overloaded
    • 



Is it a constant issue or only momentarily? You say tons of errors, how many? Can you provide a debug log so we get more information on the situation?

      		
    

  





        


            

            

              
            

        

      


      

            
  

    
  
    
    

  

  



    












      

  
            

    

      
    

    


      

          @fcusson
fcusson




        changed the title
Tons of erros

[Errno 104] Connection reset by peer from Spotcast


      Jan 24, 2025

    

  



    

    

      
    

    


      

          @fcusson
fcusson




            added
      

  dependency issue

  issue exist because of dependency not the project itself

      

  more info needed

  Maintainers will be unable to work on the issue until more information is provided

    and removed
      

  dependency issue

  issue exist because of dependency not the project itself

  labels


      Jan 24, 2025

    

  








      

  
      



  

  @mfabiani53





  


    

      

  

    

        
    
    

  


      
          
  
      
            Copy link

  

      
    

  


  

      



      

  Author


  


  

    

  





      


        


  
    

      
          
It happens constantly... i see those errors everyday. How to have a debug log?


This is from today log:


2025-01-25 08:46:57.220 ERROR (MainThread) [homeassistant] Error doing job: Task exception was never retrieved (None)
Traceback (most recent call last):
  File "/config/custom_components/spotcast/media_player/device_manager.py", line 124, in async_update
    playback_state = await self._account.async_playback_state()
                     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  File "/config/custom_components/spotcast/spotify/account.py", line 661, in async_playback_state
    data = await self._async_add_audio_features(data)
           ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  File "/config/custom_components/spotcast/spotify/account.py", line 672, in _async_add_audio_features
    current_uri = playback_state.get("item", {}).get("uri")
                  ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
AttributeError: 'NoneType' object has no attribute 'get'
2025-01-25 08:47:27.215 ERROR (MainThread) [homeassistant] Error doing job: Task exception was never retrieved (None)
Traceback (most recent call last):
  File "/config/custom_components/spotcast/media_player/device_manager.py", line 124, in async_update
    playback_state = await self._account.async_playback_state()
                     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  File "/config/custom_components/spotcast/spotify/account.py", line 661, in async_playback_state
    data = await self._async_add_audio_features(data)
           ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  File "/config/custom_components/spotcast/spotify/account.py", line 672, in _async_add_audio_features
    current_uri = playback_state.get("item", {}).get("uri")
                  ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
AttributeError: 'NoneType' object has no attribute 'get'
2025-01-25 08:47:57.280 ERROR (MainThread) [homeassistant] Error doing job: Task exception was never retrieved (None)
Traceback (most recent call last):
  File "/config/custom_components/spotcast/media_player/device_manager.py", line 124, in async_update
    playback_state = await self._account.async_playback_state()
                     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  File "/config/custom_components/spotcast/spotify/account.py", line 661, in async_playback_state
    data = await self._async_add_audio_features(data)
           ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  File "/config/custom_components/spotcast/spotify/account.py", line 672, in _async_add_audio_features
    current_uri = playback_state.get("item", {}).get("uri")
                  ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
AttributeError: 'NoneType' object has no attribute 'get'
2025-01-25 08:48:27.222 ERROR (MainThread) [homeassistant] Error doing job: Task exception was never retrieved (None)
Traceback (most recent call last):
  File "/config/custom_components/spotcast/media_player/device_manager.py", line 124, in async_update
    playback_state = await self._account.async_playback_state()
                     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  File "/config/custom_components/spotcast/spotify/account.py", line 661, in async_playback_state
    data = await self._async_add_audio_features(data)
           ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  File "/config/custom_components/spotcast/spotify/account.py", line 672, in _async_add_audio_features
    current_uri = playback_state.get("item", {}).get("uri")
                  ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
AttributeError: 'NoneType' object has no attribute 'get'



      		
    

  





        


            

            

              
            

        

      


      

            
  

    
  
    
    

  

  



    












      

  
      



  

  @fcusson





  


    

      

  

    

        
    
    

  


      
          
  
      
            Copy link

  

      
    

  


  

      

  
    Collaborator


      

  


  

    

      

      
            fcusson
  

      

      

      commented


        Jan 25, 2025


      
    


  





      


        


  
    

      
          
@mfabiani53 that one would be a different issue. I'll open a new ticket for that one.




How to have a debug log?




By going into the Integration dashboard in Home Assistant, clicking on Spotcast and then Activate Debug Log


You can go through that link to go directly to your server's Spotcast Integration screen

Open your Home Assistant instance and show an integration.


Please provide a debug log, so we can look further into the 104 error.

      		
    

  





        


            

            

              
            

        

      


      

            
  

    
  
    
    

  

  



    












      

  
      



  

  @mfabiani53





  


    

      

  

    

        
    
    

  


      
          
  
      
            Copy link

  

      
    

  


  

      



      

  Author


  


  

    

      

      
            mfabiani53
  

      

      

      commented


        Jan 25, 2025


      
  •

  

    
      

        
          edited
          
        
        
      

    
    
      
        
      Loading

      
    
  



    


  





      


        


  
    

      
          
Ok, done. How much i must wait to send you the log?

      		
    

  





        


            

            

              
            

        

      


      

            
  

    
  
    
    

  

  



    












      

  
          

  

    
  


  

      

    @fcusson
fcusson



    mentioned this issue
    
      Jan 25, 2025
    





  


  

      
  
  Open

  







  









      

  
      



  

  @fcusson





  


    

      

  

    

        
    
    

  


      
          
  
      
            Copy link

  

      
    

  


  

      

  
    Collaborator


      

  


  

    

      

      
            fcusson
  

      

      

      commented


        Jan 25, 2025


      
    


  





      


        


  
    

      
          
@mfabiani53 you let it run for a while, making sure the error you want is triggered and then deactivate. It will download the file directly in your browser

      		
    

  





        


            

            

              
            

        

      


      

            
  

    
  
    
    

  

  



    












      

  
      



  

  @mfabiani53





  


    

      

  

    

        
    
    

  


      
          
  
      
            Copy link

  

      
    

  


  

      



      

  Author


  


  

    

      

      
            mfabiani53
  

      

      

      commented


        Jan 25, 2025


      
  •

  

    
      

        
          edited by fcusson
          
        
        
      

    
    
      
        
      Loading

      
    
  



    


  





      


        


  
    

      
          
Here it is, but cannot find the errors we are discussing about...



Logs

2025-01-25 15:12:01.741 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:12:01.742 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:12:01.742 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:12:01.742 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:12:01.742 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Devices for account `mfabiani53`
2025-01-25 15:12:01.743 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using Cached devices dataset
2025-01-25 15:12:01.743 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_devices_sensor] Getting Spotify Device for account mfabiani53
2025-01-25 15:12:01.743 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_devices_sensor] Found 5 devices linked to spotify account mfabiani53
2025-01-25 15:12:01.744 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:12:01.744 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:12:01.744 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:12:01.744 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_profile_sensor] Getting Spotify Profile for account `mfabiani53`
2025-01-25 15:12:01.744 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_profile_sensor] Profile retrieve for account id `mfabiani53`
2025-01-25 15:12:01.745 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:12:01.745 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:12:01.745 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:12:01.745 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_product_sensor] Getting Spotify Subscription Type `mfabiani53`
2025-01-25 15:12:01.745 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_product_sensor] Account `mfabiani53` has the `free` subscription
2025-01-25 15:12:01.746 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:12:01.746 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:12:01.746 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:12:01.746 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_followers_sensor] Getting Spotify followers for account `mfabiani53`
2025-01-25 15:12:01.746 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_followers_sensor] Found 0 followers for spotify account `mfabiani53`
2025-01-25 15:12:01.749 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:12:01.750 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:12:01.750 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:12:01.750 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_account_type_sensor] Getting Spotify account type for `mfabiani53`
2025-01-25 15:12:01.750 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_account_type_sensor] Type retrieve for account id `mfabiani53`
2025-01-25 15:12:01.755 DEBUG (MainThread) [custom_components.spotcast.binary_sensor.is_default_binary_sensor] Updating default state sensor for `01JDM1YRVP8QKD8MNDEAZB12MK`
2025-01-25 15:12:01.755 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:12:01.755 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:12:01.756 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:12:01.756 DEBUG (MainThread) [custom_components.spotcast.binary_sensor.spotify_profile_malfunction_sensor] Getting Spotify Profile for account `mfabiani53`
2025-01-25 15:12:01.756 DEBUG (MainThread) [custom_components.spotcast.binary_sensor.spotify_profile_malfunction_sensor] Profile retrieve for account id `mfabiani53`
2025-01-25 15:12:01.769 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:12:01.770 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:12:01.770 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:12:01.770 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:12:01.770 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Devices for account `mfabiani53`
2025-01-25 15:12:01.770 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using Cached devices dataset
2025-01-25 15:12:01.771 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:12:01.771 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:12:01.771 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:12:01.771 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:12:01.771 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Playback Sate for account `mfabiani53`
2025-01-25 15:12:01.772 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing playback state dataset
2025-01-25 15:12:01.843 DEBUG (MainThread) [custom_components.spotcast.media_player.device_manager] Updating device info for `Spotcast (mfabiani53) - Salotto`
2025-01-25 15:12:01.843 DEBUG (MainThread) [custom_components.spotcast.media_player.device_manager] Updating device info for `Spotcast (mfabiani53) - 38cc2af29cf8a2dbc4bfb14b4130cf47e3b0516a`
2025-01-25 15:12:01.843 DEBUG (MainThread) [custom_components.spotcast.media_player.device_manager] Updating device info for `Spotcast (mfabiani53) - Echo Show`
2025-01-25 15:12:01.843 DEBUG (MainThread) [custom_components.spotcast.media_player.device_manager] Updating device info for `Spotcast (mfabiani53) - Ovunque`
2025-01-25 15:12:01.844 DEBUG (MainThread) [custom_components.spotcast.media_player.device_manager] Updating device info for `Spotcast (mfabiani53) - Echo Show 5`
2025-01-25 15:12:01.950 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_playlists_sensor] Found 274 playlist for spotify account `mfabiani53`
2025-01-25 15:12:02.002 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_liked_songs_sensor] Found 6133 liked songs for spotify account `mfabiani53`
2025-01-25 15:12:31.742 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:12:31.743 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:12:31.743 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:12:31.743 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:12:31.743 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Devices for account `mfabiani53`
2025-01-25 15:12:31.743 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing devices dataset
2025-01-25 15:12:31.744 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:12:31.744 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:12:31.744 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:12:31.744 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_profile_sensor] Getting Spotify Profile for account `mfabiani53`
2025-01-25 15:12:31.744 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_profile_sensor] Profile retrieve for account id `mfabiani53`
2025-01-25 15:12:31.745 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:12:31.745 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:12:31.745 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:12:31.745 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_product_sensor] Getting Spotify Subscription Type `mfabiani53`
2025-01-25 15:12:31.746 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_product_sensor] Account `mfabiani53` has the `free` subscription
2025-01-25 15:12:31.746 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:12:31.746 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:12:31.746 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:12:31.746 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_followers_sensor] Getting Spotify followers for account `mfabiani53`
2025-01-25 15:12:31.746 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_followers_sensor] Found 0 followers for spotify account `mfabiani53`
2025-01-25 15:12:31.747 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:12:31.747 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:12:31.747 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:12:31.747 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_account_type_sensor] Getting Spotify account type for `mfabiani53`
2025-01-25 15:12:31.747 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_account_type_sensor] Type retrieve for account id `mfabiani53`
2025-01-25 15:12:31.758 DEBUG (MainThread) [custom_components.spotcast.binary_sensor.is_default_binary_sensor] Updating default state sensor for `01JDM1YRVP8QKD8MNDEAZB12MK`
2025-01-25 15:12:31.758 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:12:31.758 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:12:31.758 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:12:31.759 DEBUG (MainThread) [custom_components.spotcast.binary_sensor.spotify_profile_malfunction_sensor] Getting Spotify Profile for account `mfabiani53`
2025-01-25 15:12:31.759 DEBUG (MainThread) [custom_components.spotcast.binary_sensor.spotify_profile_malfunction_sensor] Profile retrieve for account id `mfabiani53`
2025-01-25 15:12:31.771 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:12:31.771 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:12:31.771 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:12:31.771 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:12:31.771 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Devices for account `mfabiani53`
2025-01-25 15:12:31.819 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_devices_sensor] Getting Spotify Device for account mfabiani53
2025-01-25 15:12:31.819 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_devices_sensor] Found 5 devices linked to spotify account mfabiani53
2025-01-25 15:12:31.820 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using Cached devices dataset
2025-01-25 15:12:31.821 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:12:31.821 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:12:31.821 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:12:31.821 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:12:31.821 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Playback Sate for account `mfabiani53`
2025-01-25 15:12:31.822 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing playback state dataset
2025-01-25 15:12:31.902 DEBUG (MainThread) [custom_components.spotcast.media_player.device_manager] Updating device info for `Spotcast (mfabiani53) - Salotto`
2025-01-25 15:12:31.902 DEBUG (MainThread) [custom_components.spotcast.media_player.device_manager] Updating device info for `Spotcast (mfabiani53) - 38cc2af29cf8a2dbc4bfb14b4130cf47e3b0516a`
2025-01-25 15:12:31.902 DEBUG (MainThread) [custom_components.spotcast.media_player.device_manager] Updating device info for `Spotcast (mfabiani53) - Echo Show`
2025-01-25 15:12:31.903 DEBUG (MainThread) [custom_components.spotcast.media_player.device_manager] Updating device info for `Spotcast (mfabiani53) - Ovunque`
2025-01-25 15:12:31.903 DEBUG (MainThread) [custom_components.spotcast.media_player.device_manager] Updating device info for `Spotcast (mfabiani53) - Echo Show 5`
2025-01-25 15:12:31.919 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_playlists_sensor] Found 274 playlist for spotify account `mfabiani53`
2025-01-25 15:12:32.001 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_liked_songs_sensor] Found 6133 liked songs for spotify account `mfabiani53`
2025-01-25 15:13:01.743 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:13:01.743 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:13:01.743 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:13:01.744 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:13:01.744 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Devices for account `mfabiani53`
2025-01-25 15:13:01.744 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using Cached devices dataset
2025-01-25 15:13:01.744 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_devices_sensor] Getting Spotify Device for account mfabiani53
2025-01-25 15:13:01.745 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_devices_sensor] Found 5 devices linked to spotify account mfabiani53
2025-01-25 15:13:01.745 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:13:01.745 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:13:01.745 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:13:01.746 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_profile_sensor] Getting Spotify Profile for account `mfabiani53`
2025-01-25 15:13:01.746 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_profile_sensor] Profile retrieve for account id `mfabiani53`
2025-01-25 15:13:01.746 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:13:01.746 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:13:01.747 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:13:01.747 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_product_sensor] Getting Spotify Subscription Type `mfabiani53`
2025-01-25 15:13:01.747 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_product_sensor] Account `mfabiani53` has the `free` subscription
2025-01-25 15:13:01.747 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:13:01.747 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:13:01.747 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:13:01.747 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_followers_sensor] Getting Spotify followers for account `mfabiani53`
2025-01-25 15:13:01.747 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_followers_sensor] Found 0 followers for spotify account `mfabiani53`
2025-01-25 15:13:01.748 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:13:01.748 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:13:01.748 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:13:01.748 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_account_type_sensor] Getting Spotify account type for `mfabiani53`
2025-01-25 15:13:01.753 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_account_type_sensor] Type retrieve for account id `mfabiani53`
2025-01-25 15:13:01.764 DEBUG (MainThread) [custom_components.spotcast.binary_sensor.is_default_binary_sensor] Updating default state sensor for `01JDM1YRVP8QKD8MNDEAZB12MK`
2025-01-25 15:13:01.764 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:13:01.764 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:13:01.765 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:13:01.765 DEBUG (MainThread) [custom_components.spotcast.binary_sensor.spotify_profile_malfunction_sensor] Getting Spotify Profile for account `mfabiani53`
2025-01-25 15:13:01.765 DEBUG (MainThread) [custom_components.spotcast.binary_sensor.spotify_profile_malfunction_sensor] Profile retrieve for account id `mfabiani53`
2025-01-25 15:13:01.773 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:13:01.774 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:13:01.774 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:13:01.774 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:13:01.774 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Devices for account `mfabiani53`
2025-01-25 15:13:01.774 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using Cached devices dataset
2025-01-25 15:13:01.774 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:13:01.775 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:13:01.775 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:13:01.775 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:13:01.775 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Playback Sate for account `mfabiani53`
2025-01-25 15:13:01.776 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing playback state dataset
2025-01-25 15:13:01.839 DEBUG (MainThread) [custom_components.spotcast.media_player.device_manager] Updating device info for `Spotcast (mfabiani53) - Salotto`
2025-01-25 15:13:01.840 DEBUG (MainThread) [custom_components.spotcast.media_player.device_manager] Updating device info for `Spotcast (mfabiani53) - 38cc2af29cf8a2dbc4bfb14b4130cf47e3b0516a`
2025-01-25 15:13:01.840 DEBUG (MainThread) [custom_components.spotcast.media_player.device_manager] Updating device info for `Spotcast (mfabiani53) - Echo Show`
2025-01-25 15:13:01.840 DEBUG (MainThread) [custom_components.spotcast.media_player.device_manager] Updating device info for `Spotcast (mfabiani53) - Ovunque`
2025-01-25 15:13:01.840 DEBUG (MainThread) [custom_components.spotcast.media_player.device_manager] Updating device info for `Spotcast (mfabiani53) - Echo Show 5`
2025-01-25 15:13:01.886 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_playlists_sensor] Found 274 playlist for spotify account `mfabiani53`
2025-01-25 15:13:02.009 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_liked_songs_sensor] Found 6133 liked songs for spotify account `mfabiani53`
2025-01-25 15:13:31.744 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:13:31.744 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:13:31.744 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:13:31.744 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:13:31.745 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Devices for account `mfabiani53`
2025-01-25 15:13:31.745 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing devices dataset
2025-01-25 15:13:31.745 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:13:31.745 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:13:31.745 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:13:31.745 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_profile_sensor] Getting Spotify Profile for account `mfabiani53`
2025-01-25 15:13:31.746 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_profile_sensor] Profile retrieve for account id `mfabiani53`
2025-01-25 15:13:31.746 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:13:31.747 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:13:31.747 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:13:31.747 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_product_sensor] Getting Spotify Subscription Type `mfabiani53`
2025-01-25 15:13:31.747 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_product_sensor] Account `mfabiani53` has the `free` subscription
2025-01-25 15:13:31.747 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:13:31.747 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:13:31.748 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:13:31.748 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_followers_sensor] Getting Spotify followers for account `mfabiani53`
2025-01-25 15:13:31.748 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_followers_sensor] Found 0 followers for spotify account `mfabiani53`
2025-01-25 15:13:31.748 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:13:31.748 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:13:31.748 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:13:31.748 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_account_type_sensor] Getting Spotify account type for `mfabiani53`
2025-01-25 15:13:31.749 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_account_type_sensor] Type retrieve for account id `mfabiani53`
2025-01-25 15:13:31.765 DEBUG (MainThread) [custom_components.spotcast.binary_sensor.is_default_binary_sensor] Updating default state sensor for `01JDM1YRVP8QKD8MNDEAZB12MK`
2025-01-25 15:13:31.765 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:13:31.766 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:13:31.766 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:13:31.766 DEBUG (MainThread) [custom_components.spotcast.binary_sensor.spotify_profile_malfunction_sensor] Getting Spotify Profile for account `mfabiani53`
2025-01-25 15:13:31.766 DEBUG (MainThread) [custom_components.spotcast.binary_sensor.spotify_profile_malfunction_sensor] Profile retrieve for account id `mfabiani53`
2025-01-25 15:13:31.777 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:13:31.777 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:13:31.778 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:13:31.778 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:13:31.778 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Devices for account `mfabiani53`
2025-01-25 15:13:31.827 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_devices_sensor] Getting Spotify Device for account mfabiani53
2025-01-25 15:13:31.827 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_devices_sensor] Found 5 devices linked to spotify account mfabiani53
2025-01-25 15:13:31.829 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using Cached devices dataset
2025-01-25 15:13:31.830 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:13:31.830 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:13:31.830 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:13:31.830 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:13:31.830 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Playback Sate for account `mfabiani53`
2025-01-25 15:13:31.830 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing playback state dataset
2025-01-25 15:13:31.884 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_playlists_sensor] Found 274 playlist for spotify account `mfabiani53`
2025-01-25 15:13:31.899 DEBUG (MainThread) [custom_components.spotcast.media_player.device_manager] Updating device info for `Spotcast (mfabiani53) - Salotto`
2025-01-25 15:13:31.900 DEBUG (MainThread) [custom_components.spotcast.media_player.device_manager] Updating device info for `Spotcast (mfabiani53) - 38cc2af29cf8a2dbc4bfb14b4130cf47e3b0516a`
2025-01-25 15:13:31.900 DEBUG (MainThread) [custom_components.spotcast.media_player.device_manager] Updating device info for `Spotcast (mfabiani53) - Echo Show`
2025-01-25 15:13:31.900 DEBUG (MainThread) [custom_components.spotcast.media_player.device_manager] Updating device info for `Spotcast (mfabiani53) - Ovunque`
2025-01-25 15:13:31.900 DEBUG (MainThread) [custom_components.spotcast.media_player.device_manager] Updating device info for `Spotcast (mfabiani53) - Echo Show 5`
2025-01-25 15:13:32.066 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_liked_songs_sensor] Found 6133 liked songs for spotify account `mfabiani53`
2025-01-25 15:14:01.744 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:14:01.744 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:14:01.744 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:14:01.744 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:14:01.745 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Devices for account `mfabiani53`
2025-01-25 15:14:01.745 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using Cached devices dataset
2025-01-25 15:14:01.745 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_devices_sensor] Getting Spotify Device for account mfabiani53
2025-01-25 15:14:01.745 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_devices_sensor] Found 5 devices linked to spotify account mfabiani53
2025-01-25 15:14:01.745 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:14:01.745 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:14:01.746 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:14:01.746 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_profile_sensor] Getting Spotify Profile for account `mfabiani53`
2025-01-25 15:14:01.746 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_profile_sensor] Profile retrieve for account id `mfabiani53`
2025-01-25 15:14:01.746 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:14:01.747 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:14:01.747 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:14:01.747 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_product_sensor] Getting Spotify Subscription Type `mfabiani53`
2025-01-25 15:14:01.747 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_product_sensor] Account `mfabiani53` has the `free` subscription
2025-01-25 15:14:01.748 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:14:01.748 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:14:01.748 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:14:01.748 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_followers_sensor] Getting Spotify followers for account `mfabiani53`
2025-01-25 15:14:01.748 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_followers_sensor] Found 0 followers for spotify account `mfabiani53`
2025-01-25 15:14:01.748 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:14:01.748 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:14:01.749 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:14:01.752 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_account_type_sensor] Getting Spotify account type for `mfabiani53`
2025-01-25 15:14:01.752 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_account_type_sensor] Type retrieve for account id `mfabiani53`
2025-01-25 15:14:01.766 DEBUG (MainThread) [custom_components.spotcast.binary_sensor.is_default_binary_sensor] Updating default state sensor for `01JDM1YRVP8QKD8MNDEAZB12MK`
2025-01-25 15:14:01.766 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:14:01.766 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:14:01.767 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:14:01.767 DEBUG (MainThread) [custom_components.spotcast.binary_sensor.spotify_profile_malfunction_sensor] Getting Spotify Profile for account `mfabiani53`
2025-01-25 15:14:01.767 DEBUG (MainThread) [custom_components.spotcast.binary_sensor.spotify_profile_malfunction_sensor] Profile retrieve for account id `mfabiani53`
2025-01-25 15:14:01.777 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:14:01.777 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:14:01.778 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:14:01.778 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:14:01.778 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Devices for account `mfabiani53`
2025-01-25 15:14:01.778 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using Cached devices dataset
2025-01-25 15:14:01.778 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:14:01.778 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:14:01.778 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:14:01.779 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:14:01.779 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Playback Sate for account `mfabiani53`
2025-01-25 15:14:01.779 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing playback state dataset
2025-01-25 15:14:01.855 DEBUG (MainThread) [custom_components.spotcast.media_player.device_manager] Updating device info for `Spotcast (mfabiani53) - Salotto`
2025-01-25 15:14:01.855 DEBUG (MainThread) [custom_components.spotcast.media_player.device_manager] Updating device info for `Spotcast (mfabiani53) - 38cc2af29cf8a2dbc4bfb14b4130cf47e3b0516a`
2025-01-25 15:14:01.856 DEBUG (MainThread) [custom_components.spotcast.media_player.device_manager] Updating device info for `Spotcast (mfabiani53) - Echo Show`
2025-01-25 15:14:01.856 DEBUG (MainThread) [custom_components.spotcast.media_player.device_manager] Updating device info for `Spotcast (mfabiani53) - Ovunque`
2025-01-25 15:14:01.856 DEBUG (MainThread) [custom_components.spotcast.media_player.device_manager] Updating device info for `Spotcast (mfabiani53) - Echo Show 5`
2025-01-25 15:14:01.910 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_playlists_sensor] Found 274 playlist for spotify account `mfabiani53`
2025-01-25 15:14:02.044 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_liked_songs_sensor] Found 6133 liked songs for spotify account `mfabiani53`
2025-01-25 15:14:31.744 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:14:31.744 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:14:31.745 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:14:31.745 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:14:31.745 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Devices for account `mfabiani53`
2025-01-25 15:14:31.745 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing devices dataset
2025-01-25 15:14:31.745 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:14:31.745 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:14:31.745 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:14:31.745 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_profile_sensor] Getting Spotify Profile for account `mfabiani53`
2025-01-25 15:14:31.746 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_profile_sensor] Profile retrieve for account id `mfabiani53`
2025-01-25 15:14:31.746 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:14:31.746 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:14:31.746 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:14:31.746 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_product_sensor] Getting Spotify Subscription Type `mfabiani53`
2025-01-25 15:14:31.747 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_product_sensor] Account `mfabiani53` has the `free` subscription
2025-01-25 15:14:31.747 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:14:31.747 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:14:31.747 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:14:31.747 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_followers_sensor] Getting Spotify followers for account `mfabiani53`
2025-01-25 15:14:31.747 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_followers_sensor] Found 0 followers for spotify account `mfabiani53`
2025-01-25 15:14:31.748 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:14:31.748 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:14:31.748 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:14:31.748 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_account_type_sensor] Getting Spotify account type for `mfabiani53`
2025-01-25 15:14:31.748 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_account_type_sensor] Type retrieve for account id `mfabiani53`
2025-01-25 15:14:31.769 DEBUG (MainThread) [custom_components.spotcast.binary_sensor.is_default_binary_sensor] Updating default state sensor for `01JDM1YRVP8QKD8MNDEAZB12MK`
2025-01-25 15:14:31.769 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:14:31.770 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:14:31.770 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:14:31.770 DEBUG (MainThread) [custom_components.spotcast.binary_sensor.spotify_profile_malfunction_sensor] Getting Spotify Profile for account `mfabiani53`
2025-01-25 15:14:31.770 DEBUG (MainThread) [custom_components.spotcast.binary_sensor.spotify_profile_malfunction_sensor] Profile retrieve for account id `mfabiani53`
2025-01-25 15:14:31.784 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:14:31.784 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:14:31.784 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:14:31.784 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:14:31.784 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Devices for account `mfabiani53`
2025-01-25 15:14:31.830 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_devices_sensor] Getting Spotify Device for account mfabiani53
2025-01-25 15:14:31.831 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_devices_sensor] Found 5 devices linked to spotify account mfabiani53
2025-01-25 15:14:31.833 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using Cached devices dataset
2025-01-25 15:14:31.834 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:14:31.834 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:14:31.834 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:14:31.834 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:14:31.834 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Playback Sate for account `mfabiani53`
2025-01-25 15:14:31.834 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing playback state dataset
2025-01-25 15:14:31.896 DEBUG (MainThread) [custom_components.spotcast.media_player.device_manager] Updating device info for `Spotcast (mfabiani53) - Salotto`
2025-01-25 15:14:31.896 DEBUG (MainThread) [custom_components.spotcast.media_player.device_manager] Updating device info for `Spotcast (mfabiani53) - 38cc2af29cf8a2dbc4bfb14b4130cf47e3b0516a`
2025-01-25 15:14:31.896 DEBUG (MainThread) [custom_components.spotcast.media_player.device_manager] Updating device info for `Spotcast (mfabiani53) - Echo Show`
2025-01-25 15:14:31.896 DEBUG (MainThread) [custom_components.spotcast.media_player.device_manager] Updating device info for `Spotcast (mfabiani53) - Ovunque`
2025-01-25 15:14:31.897 DEBUG (MainThread) [custom_components.spotcast.media_player.device_manager] Updating device info for `Spotcast (mfabiani53) - Echo Show 5`
2025-01-25 15:14:31.902 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_playlists_sensor] Found 274 playlist for spotify account `mfabiani53`
2025-01-25 15:14:32.010 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_liked_songs_sensor] Found 6133 liked songs for spotify account `mfabiani53`
2025-01-25 15:15:01.749 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:15:01.749 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:15:01.749 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:15:01.749 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:15:01.749 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Devices for account `mfabiani53`
2025-01-25 15:15:01.750 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using Cached devices dataset
2025-01-25 15:15:01.750 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_devices_sensor] Getting Spotify Device for account mfabiani53
2025-01-25 15:15:01.750 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_devices_sensor] Found 5 devices linked to spotify account mfabiani53
2025-01-25 15:15:01.750 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:15:01.750 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:15:01.750 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:15:01.754 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_profile_sensor] Getting Spotify Profile for account `mfabiani53`
2025-01-25 15:15:01.754 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_profile_sensor] Profile retrieve for account id `mfabiani53`
2025-01-25 15:15:01.755 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:15:01.755 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:15:01.755 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:15:01.755 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_product_sensor] Getting Spotify Subscription Type `mfabiani53`
2025-01-25 15:15:01.755 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_product_sensor] Account `mfabiani53` has the `free` subscription
2025-01-25 15:15:01.755 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:15:01.756 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:15:01.756 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:15:01.756 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_followers_sensor] Getting Spotify followers for account `mfabiani53`
2025-01-25 15:15:01.756 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_followers_sensor] Found 0 followers for spotify account `mfabiani53`
2025-01-25 15:15:01.756 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:15:01.756 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:15:01.756 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:15:01.757 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_account_type_sensor] Getting Spotify account type for `mfabiani53`
2025-01-25 15:15:01.757 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_account_type_sensor] Type retrieve for account id `mfabiani53`
2025-01-25 15:15:01.770 DEBUG (MainThread) [custom_components.spotcast.binary_sensor.is_default_binary_sensor] Updating default state sensor for `01JDM1YRVP8QKD8MNDEAZB12MK`
2025-01-25 15:15:01.770 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:15:01.771 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:15:01.771 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:15:01.771 DEBUG (MainThread) [custom_components.spotcast.binary_sensor.spotify_profile_malfunction_sensor] Getting Spotify Profile for account `mfabiani53`
2025-01-25 15:15:01.771 DEBUG (MainThread) [custom_components.spotcast.binary_sensor.spotify_profile_malfunction_sensor] Profile retrieve for account id `mfabiani53`
2025-01-25 15:15:01.786 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:15:01.787 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:15:01.787 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:15:01.787 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:15:01.787 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Devices for account `mfabiani53`
2025-01-25 15:15:01.787 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using Cached devices dataset
2025-01-25 15:15:01.788 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:15:01.788 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:15:01.788 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:15:01.788 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:15:01.788 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Playback Sate for account `mfabiani53`
2025-01-25 15:15:01.788 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing playback state dataset
2025-01-25 15:15:01.860 DEBUG (MainThread) [custom_components.spotcast.media_player.device_manager] Updating device info for `Spotcast (mfabiani53) - Salotto`
2025-01-25 15:15:01.860 DEBUG (MainThread) [custom_components.spotcast.media_player.device_manager] Updating device info for `Spotcast (mfabiani53) - 38cc2af29cf8a2dbc4bfb14b4130cf47e3b0516a`
2025-01-25 15:15:01.860 DEBUG (MainThread) [custom_components.spotcast.media_player.device_manager] Updating device info for `Spotcast (mfabiani53) - Echo Show`
2025-01-25 15:15:01.861 DEBUG (MainThread) [custom_components.spotcast.media_player.device_manager] Updating device info for `Spotcast (mfabiani53) - Ovunque`
2025-01-25 15:15:01.861 DEBUG (MainThread) [custom_components.spotcast.media_player.device_manager] Updating device info for `Spotcast (mfabiani53) - Echo Show 5`
2025-01-25 15:15:01.930 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_playlists_sensor] Found 274 playlist for spotify account `mfabiani53`
2025-01-25 15:15:02.039 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_liked_songs_sensor] Found 6133 liked songs for spotify account `mfabiani53`
2025-01-25 15:15:31.749 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:15:31.749 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:15:31.749 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:15:31.750 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:15:31.750 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Devices for account `mfabiani53`
2025-01-25 15:15:31.750 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing devices dataset
2025-01-25 15:15:31.750 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:15:31.750 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:15:31.750 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:15:31.751 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_profile_sensor] Getting Spotify Profile for account `mfabiani53`
2025-01-25 15:15:31.751 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_profile_sensor] Profile retrieve for account id `mfabiani53`
2025-01-25 15:15:31.751 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:15:31.752 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:15:31.752 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:15:31.752 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_product_sensor] Getting Spotify Subscription Type `mfabiani53`
2025-01-25 15:15:31.752 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_product_sensor] Account `mfabiani53` has the `free` subscription
2025-01-25 15:15:31.752 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:15:31.752 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:15:31.752 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:15:31.753 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_followers_sensor] Getting Spotify followers for account `mfabiani53`
2025-01-25 15:15:31.753 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_followers_sensor] Found 0 followers for spotify account `mfabiani53`
2025-01-25 15:15:31.753 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:15:31.753 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:15:31.753 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:15:31.753 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_account_type_sensor] Getting Spotify account type for `mfabiani53`
2025-01-25 15:15:31.753 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_account_type_sensor] Type retrieve for account id `mfabiani53`
2025-01-25 15:15:31.771 DEBUG (MainThread) [custom_components.spotcast.binary_sensor.is_default_binary_sensor] Updating default state sensor for `01JDM1YRVP8QKD8MNDEAZB12MK`
2025-01-25 15:15:31.772 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:15:31.772 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:15:31.772 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:15:31.772 DEBUG (MainThread) [custom_components.spotcast.binary_sensor.spotify_profile_malfunction_sensor] Getting Spotify Profile for account `mfabiani53`
2025-01-25 15:15:31.772 DEBUG (MainThread) [custom_components.spotcast.binary_sensor.spotify_profile_malfunction_sensor] Profile retrieve for account id `mfabiani53`
2025-01-25 15:15:31.789 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:15:31.789 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:15:31.789 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:15:31.789 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:15:31.789 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Devices for account `mfabiani53`
2025-01-25 15:15:31.830 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_devices_sensor] Getting Spotify Device for account mfabiani53
2025-01-25 15:15:31.831 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_devices_sensor] Found 5 devices linked to spotify account mfabiani53
2025-01-25 15:15:31.831 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using Cached devices dataset
2025-01-25 15:15:31.832 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:15:31.832 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:15:31.832 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:15:31.832 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:15:31.832 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Playback Sate for account `mfabiani53`
2025-01-25 15:15:31.833 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing playback state dataset
2025-01-25 15:15:31.881 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_playlists_sensor] Found 274 playlist for spotify account `mfabiani53`
2025-01-25 15:15:31.898 DEBUG (MainThread) [custom_components.spotcast.media_player.device_manager] Updating device info for `Spotcast (mfabiani53) - Salotto`
2025-01-25 15:15:31.898 DEBUG (MainThread) [custom_components.spotcast.media_player.device_manager] Updating device info for `Spotcast (mfabiani53) - 38cc2af29cf8a2dbc4bfb14b4130cf47e3b0516a`
2025-01-25 15:15:31.898 DEBUG (MainThread) [custom_components.spotcast.media_player.device_manager] Updating device info for `Spotcast (mfabiani53) - Echo Show`
2025-01-25 15:15:31.898 DEBUG (MainThread) [custom_components.spotcast.media_player.device_manager] Updating device info for `Spotcast (mfabiani53) - Ovunque`
2025-01-25 15:15:31.898 DEBUG (MainThread) [custom_components.spotcast.media_player.device_manager] Updating device info for `Spotcast (mfabiani53) - Echo Show 5`
2025-01-25 15:15:32.124 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_liked_songs_sensor] Found 6133 liked songs for spotify account `mfabiani53`
2025-01-25 15:16:01.750 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:16:01.751 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:16:01.751 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:16:01.751 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:16:01.751 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Devices for account `mfabiani53`
2025-01-25 15:16:01.751 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using Cached devices dataset
2025-01-25 15:16:01.752 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_devices_sensor] Getting Spotify Device for account mfabiani53
2025-01-25 15:16:01.752 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_devices_sensor] Found 5 devices linked to spotify account mfabiani53
2025-01-25 15:16:01.752 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:16:01.752 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:16:01.752 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:16:01.753 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_profile_sensor] Getting Spotify Profile for account `mfabiani53`
2025-01-25 15:16:01.753 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_profile_sensor] Profile retrieve for account id `mfabiani53`
2025-01-25 15:16:01.753 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:16:01.754 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:16:01.754 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:16:01.754 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_product_sensor] Getting Spotify Subscription Type `mfabiani53`
2025-01-25 15:16:01.754 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_product_sensor] Account `mfabiani53` has the `free` subscription
2025-01-25 15:16:01.754 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:16:01.754 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:16:01.755 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:16:01.755 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_followers_sensor] Getting Spotify followers for account `mfabiani53`
2025-01-25 15:16:01.755 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_followers_sensor] Found 0 followers for spotify account `mfabiani53`
2025-01-25 15:16:01.755 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:16:01.759 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:16:01.759 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:16:01.760 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_account_type_sensor] Getting Spotify account type for `mfabiani53`
2025-01-25 15:16:01.760 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_account_type_sensor] Type retrieve for account id `mfabiani53`
2025-01-25 15:16:01.771 DEBUG (MainThread) [custom_components.spotcast.binary_sensor.is_default_binary_sensor] Updating default state sensor for `01JDM1YRVP8QKD8MNDEAZB12MK`
2025-01-25 15:16:01.772 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:16:01.772 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:16:01.772 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:16:01.772 DEBUG (MainThread) [custom_components.spotcast.binary_sensor.spotify_profile_malfunction_sensor] Getting Spotify Profile for account `mfabiani53`
2025-01-25 15:16:01.772 DEBUG (MainThread) [custom_components.spotcast.binary_sensor.spotify_profile_malfunction_sensor] Profile retrieve for account id `mfabiani53`
2025-01-25 15:16:01.789 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:16:01.790 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:16:01.790 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:16:01.790 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:16:01.790 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Devices for account `mfabiani53`
2025-01-25 15:16:01.790 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using Cached devices dataset
2025-01-25 15:16:01.790 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:16:01.791 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:16:01.791 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:16:01.791 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:16:01.791 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Playback Sate for account `mfabiani53`
2025-01-25 15:16:01.791 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing playback state dataset
2025-01-25 15:16:01.860 DEBUG (MainThread) [custom_components.spotcast.media_player.device_manager] Updating device info for `Spotcast (mfabiani53) - Salotto`
2025-01-25 15:16:01.860 DEBUG (MainThread) [custom_components.spotcast.media_player.device_manager] Updating device info for `Spotcast (mfabiani53) - 38cc2af29cf8a2dbc4bfb14b4130cf47e3b0516a`
2025-01-25 15:16:01.860 DEBUG (MainThread) [custom_components.spotcast.media_player.device_manager] Updating device info for `Spotcast (mfabiani53) - Echo Show`
2025-01-25 15:16:01.860 DEBUG (MainThread) [custom_components.spotcast.media_player.device_manager] Updating device info for `Spotcast (mfabiani53) - Ovunque`
2025-01-25 15:16:01.860 DEBUG (MainThread) [custom_components.spotcast.media_player.device_manager] Updating device info for `Spotcast (mfabiani53) - Echo Show 5`
2025-01-25 15:16:01.881 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_playlists_sensor] Found 274 playlist for spotify account `mfabiani53`
2025-01-25 15:16:02.067 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_liked_songs_sensor] Found 6133 liked songs for spotify account `mfabiani53`
2025-01-25 15:16:31.756 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:16:31.756 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:16:31.756 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:16:31.756 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:16:31.756 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Devices for account `mfabiani53`
2025-01-25 15:16:31.757 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing devices dataset
2025-01-25 15:16:31.757 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:16:31.757 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:16:31.757 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:16:31.757 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_profile_sensor] Getting Spotify Profile for account `mfabiani53`
2025-01-25 15:16:31.757 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_profile_sensor] Profile retrieve for account id `mfabiani53`
2025-01-25 15:16:31.758 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:16:31.758 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:16:31.758 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:16:31.758 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_product_sensor] Getting Spotify Subscription Type `mfabiani53`
2025-01-25 15:16:31.758 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_product_sensor] Account `mfabiani53` has the `free` subscription
2025-01-25 15:16:31.759 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:16:31.759 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:16:31.759 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:16:31.759 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_followers_sensor] Getting Spotify followers for account `mfabiani53`
2025-01-25 15:16:31.759 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_followers_sensor] Found 0 followers for spotify account `mfabiani53`
2025-01-25 15:16:31.759 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:16:31.759 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:16:31.760 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:16:31.760 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_account_type_sensor] Getting Spotify account type for `mfabiani53`
2025-01-25 15:16:31.760 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_account_type_sensor] Type retrieve for account id `mfabiani53`
2025-01-25 15:16:31.774 DEBUG (MainThread) [custom_components.spotcast.binary_sensor.is_default_binary_sensor] Updating default state sensor for `01JDM1YRVP8QKD8MNDEAZB12MK`
2025-01-25 15:16:31.775 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:16:31.775 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:16:31.775 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:16:31.775 DEBUG (MainThread) [custom_components.spotcast.binary_sensor.spotify_profile_malfunction_sensor] Getting Spotify Profile for account `mfabiani53`
2025-01-25 15:16:31.775 DEBUG (MainThread) [custom_components.spotcast.binary_sensor.spotify_profile_malfunction_sensor] Profile retrieve for account id `mfabiani53`
2025-01-25 15:16:31.790 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:16:31.791 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:16:31.791 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:16:31.791 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:16:31.792 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Devices for account `mfabiani53`
2025-01-25 15:16:31.844 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_devices_sensor] Getting Spotify Device for account mfabiani53
2025-01-25 15:16:31.845 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_devices_sensor] Found 5 devices linked to spotify account mfabiani53
2025-01-25 15:16:31.849 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using Cached devices dataset
2025-01-25 15:16:31.850 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:16:31.850 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:16:31.850 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:16:31.850 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:16:31.850 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Playback Sate for account `mfabiani53`
2025-01-25 15:16:31.851 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing playback state dataset
2025-01-25 15:16:31.918 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_playlists_sensor] Found 274 playlist for spotify account `mfabiani53`
2025-01-25 15:16:31.919 DEBUG (MainThread) [custom_components.spotcast.media_player.device_manager] Updating device info for `Spotcast (mfabiani53) - Salotto`
2025-01-25 15:16:31.919 DEBUG (MainThread) [custom_components.spotcast.media_player.device_manager] Updating device info for `Spotcast (mfabiani53) - 38cc2af29cf8a2dbc4bfb14b4130cf47e3b0516a`
2025-01-25 15:16:31.919 DEBUG (MainThread) [custom_components.spotcast.media_player.device_manager] Updating device info for `Spotcast (mfabiani53) - Echo Show`
2025-01-25 15:16:31.919 DEBUG (MainThread) [custom_components.spotcast.media_player.device_manager] Updating device info for `Spotcast (mfabiani53) - Ovunque`
2025-01-25 15:16:31.919 DEBUG (MainThread) [custom_components.spotcast.media_player.device_manager] Updating device info for `Spotcast (mfabiani53) - Echo Show 5`
2025-01-25 15:16:32.045 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_liked_songs_sensor] Found 6133 liked songs for spotify account `mfabiani53`
2025-01-25 15:17:01.756 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:17:01.756 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:17:01.757 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:17:01.757 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:17:01.757 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Devices for account `mfabiani53`
2025-01-25 15:17:01.757 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using Cached devices dataset
2025-01-25 15:17:01.757 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_devices_sensor] Getting Spotify Device for account mfabiani53
2025-01-25 15:17:01.757 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_devices_sensor] Found 5 devices linked to spotify account mfabiani53
2025-01-25 15:17:01.758 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:17:01.758 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:17:01.758 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:17:01.758 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_profile_sensor] Getting Spotify Profile for account `mfabiani53`
2025-01-25 15:17:01.758 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_profile_sensor] Profile retrieve for account id `mfabiani53`
2025-01-25 15:17:01.759 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:17:01.759 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:17:01.759 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:17:01.760 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_product_sensor] Getting Spotify Subscription Type `mfabiani53`
2025-01-25 15:17:01.760 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_product_sensor] Account `mfabiani53` has the `free` subscription
2025-01-25 15:17:01.760 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:17:01.760 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:17:01.760 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:17:01.761 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_followers_sensor] Getting Spotify followers for account `mfabiani53`
2025-01-25 15:17:01.761 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_followers_sensor] Found 0 followers for spotify account `mfabiani53`
2025-01-25 15:17:01.761 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:17:01.761 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:17:01.761 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:17:01.761 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_account_type_sensor] Getting Spotify account type for `mfabiani53`
2025-01-25 15:17:01.761 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_account_type_sensor] Type retrieve for account id `mfabiani53`
2025-01-25 15:17:01.783 DEBUG (MainThread) [custom_components.spotcast.binary_sensor.is_default_binary_sensor] Updating default state sensor for `01JDM1YRVP8QKD8MNDEAZB12MK`
2025-01-25 15:17:01.783 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:17:01.783 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:17:01.783 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:17:01.784 DEBUG (MainThread) [custom_components.spotcast.binary_sensor.spotify_profile_malfunction_sensor] Getting Spotify Profile for account `mfabiani53`
2025-01-25 15:17:01.784 DEBUG (MainThread) [custom_components.spotcast.binary_sensor.spotify_profile_malfunction_sensor] Profile retrieve for account id `mfabiani53`
2025-01-25 15:17:01.791 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:17:01.792 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:17:01.792 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:17:01.792 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:17:01.792 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Devices for account `mfabiani53`
2025-01-25 15:17:01.792 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using Cached devices dataset
2025-01-25 15:17:01.793 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:17:01.793 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:17:01.793 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:17:01.793 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:17:01.793 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Playback Sate for account `mfabiani53`
2025-01-25 15:17:01.794 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing playback state dataset
2025-01-25 15:17:01.862 DEBUG (MainThread) [custom_components.spotcast.media_player.device_manager] Updating device info for `Spotcast (mfabiani53) - Salotto`
2025-01-25 15:17:01.863 DEBUG (MainThread) [custom_components.spotcast.media_player.device_manager] Updating device info for `Spotcast (mfabiani53) - 38cc2af29cf8a2dbc4bfb14b4130cf47e3b0516a`
2025-01-25 15:17:01.863 DEBUG (MainThread) [custom_components.spotcast.media_player.device_manager] Updating device info for `Spotcast (mfabiani53) - Echo Show`
2025-01-25 15:17:01.863 DEBUG (MainThread) [custom_components.spotcast.media_player.device_manager] Updating device info for `Spotcast (mfabiani53) - Ovunque`
2025-01-25 15:17:01.863 DEBUG (MainThread) [custom_components.spotcast.media_player.device_manager] Updating device info for `Spotcast (mfabiani53) - Echo Show 5`
2025-01-25 15:17:01.902 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_playlists_sensor] Found 274 playlist for spotify account `mfabiani53`
2025-01-25 15:17:02.033 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_liked_songs_sensor] Found 6133 liked songs for s




      		
    

  





        


            

            

              
            

        

      


      

            
  

    
  
    
    

  

  



    












      

  
      



  

  @mfabiani53





  


    

      

  

    

        
    
    

  


      
          
  
      
            Copy link

  

      
    

  


  

      



      

  Author


  


  

    

      

      
            mfabiani53
  

      

      

      commented


        Jan 25, 2025


      
  •

  

    
      

        
          edited by fcusson
          
        
        
      

    
    
      
        
      Loading

      
    
  



    


  





      


        


  
    

      
          
This while playing some music on one of my devices...



    logs

2025-01-25 15:51:48.349 DEBUG (MainThread) [custom_components.spotcast.utils] Searching for default spotcast account
2025-01-25 15:51:48.349 DEBUG (MainThread) [custom_components.spotcast.services.play_media] Loading Spotify Account for User `None`
2025-01-25 15:51:48.350 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Providing preexisting account for entry `01JDM1YRVP8QKD8MNDEAZB12MK`
2025-01-25 15:51:48.350 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:51:48.350 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:51:48.350 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:51:48.351 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:51:48.351 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Fetching information from playlist `spotify:playlist:37i9dQZF1E36buj8U8F3MT`
2025-01-25 15:51:48.888 DEBUG (MainThread) [custom_components.spotcast.services.play_media] Getting media_player.wiim_pro_81e2 from home assistant
2025-01-25 15:51:48.888 DEBUG (MainThread) [custom_components.spotcast.media_player.utils] Adding 7 entities from platform `cast`
2025-01-25 15:51:48.888 DEBUG (MainThread) [custom_components.spotcast.media_player.utils] Building Device of type `<class 'homeassistant.helpers.entity.ABCCachedProperties'>`
2025-01-25 15:51:48.997 DEBUG (MainThread) [custom_components.spotcast.chromecast.spotify_controller] Build SpotifyController for Chromecast
2025-01-25 15:51:48.997 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:51:48.998 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:51:48.998 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:51:48.998 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:51:48.999 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Playback Sate for account `mfabiani53`
2025-01-25 15:51:48.999 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing playback state dataset
2025-01-25 15:51:49.063 DEBUG (SyncWorker_30) [custom_components.spotcast.chromecast.spotify_controller] Waiting for `WiiM Pro` to be ready
2025-01-25 15:51:49.063 DEBUG (SyncWorker_30) [custom_components.spotcast.chromecast.spotify_controller] Starting Spotify on `WiiM Pro`
2025-01-25 15:51:49.616 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:51:49.616 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:51:49.616 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:51:49.616 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:51:49.617 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Devices for account `mfabiani53`
2025-01-25 15:51:49.617 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using Cached devices dataset
2025-01-25 15:51:49.617 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_devices_sensor] Getting Spotify Device for account mfabiani53
2025-01-25 15:51:49.617 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_devices_sensor] Found 5 devices linked to spotify account mfabiani53
2025-01-25 15:51:49.618 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:51:49.618 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:51:49.618 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:51:49.618 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_profile_sensor] Getting Spotify Profile for account `mfabiani53`
2025-01-25 15:51:49.618 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_profile_sensor] Profile retrieve for account id `mfabiani53`
2025-01-25 15:51:49.619 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:51:49.619 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:51:49.619 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:51:49.620 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_product_sensor] Getting Spotify Subscription Type `mfabiani53`
2025-01-25 15:51:49.620 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_product_sensor] Account `mfabiani53` has the `free` subscription
2025-01-25 15:51:49.620 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:51:49.620 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:51:49.620 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:51:49.621 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_followers_sensor] Getting Spotify followers for account `mfabiani53`
2025-01-25 15:51:49.621 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_followers_sensor] Found 0 followers for spotify account `mfabiani53`
2025-01-25 15:51:49.623 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:51:49.623 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:51:49.624 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:51:49.624 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_account_type_sensor] Getting Spotify account type for `mfabiani53`
2025-01-25 15:51:49.624 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_account_type_sensor] Type retrieve for account id `mfabiani53`
2025-01-25 15:51:49.630 DEBUG (MainThread) [custom_components.spotcast.binary_sensor.is_default_binary_sensor] Updating default state sensor for `01JDM1YRVP8QKD8MNDEAZB12MK`
2025-01-25 15:51:49.630 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:51:49.631 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:51:49.631 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:51:49.631 DEBUG (MainThread) [custom_components.spotcast.binary_sensor.spotify_profile_malfunction_sensor] Getting Spotify Profile for account `mfabiani53`
2025-01-25 15:51:49.631 DEBUG (MainThread) [custom_components.spotcast.binary_sensor.spotify_profile_malfunction_sensor] Profile retrieve for account id `mfabiani53`
2025-01-25 15:51:49.632 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:51:49.632 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:51:49.632 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:51:49.632 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:51:49.632 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Devices for account `mfabiani53`
2025-01-25 15:51:49.632 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using Cached devices dataset
2025-01-25 15:51:49.633 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:51:49.633 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:51:49.633 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:51:49.633 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:51:49.633 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Playback Sate for account `mfabiani53`
2025-01-25 15:51:49.633 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using Cached playback state dataset
2025-01-25 15:51:49.633 DEBUG (MainThread) [custom_components.spotcast.media_player.device_manager] Updating device info for `Spotcast (mfabiani53) - Salotto`
2025-01-25 15:51:49.633 DEBUG (MainThread) [custom_components.spotcast.media_player.device_manager] Updating device info for `Spotcast (mfabiani53) - 38cc2af29cf8a2dbc4bfb14b4130cf47e3b0516a`
2025-01-25 15:51:49.634 DEBUG (MainThread) [custom_components.spotcast.media_player.device_manager] Updating device info for `Spotcast (mfabiani53) - Echo Show`
2025-01-25 15:51:49.634 DEBUG (MainThread) [custom_components.spotcast.media_player.device_manager] Updating device info for `Spotcast (mfabiani53) - Ovunque`
2025-01-25 15:51:49.634 DEBUG (MainThread) [custom_components.spotcast.media_player.device_manager] Updating device info for `Spotcast (mfabiani53) - Echo Show 5`
2025-01-25 15:51:49.797 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_playlists_sensor] Found 274 playlist for spotify account `mfabiani53`
2025-01-25 15:51:49.863 DEBUG (MainThread) > This while playing some music on one of my devices...
> 
> 2025-01-25 15:51:48.349 DEBUG (MainThread) [custom_components.spotcast.utils] Searching for default spotcast account 2025-01-25 15:51:48.349 DEBUG (MainThread) [custom_components.spotcast.services.play_media] Loading Spotify Account for User `None` 2025-01-25 15:51:48.350 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Providing preexisting account for entry `01JDM1YRVP8QKD8MNDEAZB12MK` 2025-01-25 15:51:48.350 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account 2025-01-25 15:51:48.350 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify 2025-01-25 15:51:48.350 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset 2025-01-25 15:51:48.351 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account 2025-01-25 15:51:48.351 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Fetching information from playlist `spotify:playlist:37i9dQZF1E36buj8U8F3MT` 2025-01-25 15:51:48.888 DEBUG (MainThread) [custom_components.spotcast.services.play_media] Getting media_player.wiim_pro_81e2 from home assistant 2025-01-25 15:51:48.888 DEBUG (MainThread) [custom_components.spotcast.media_player.utils] Adding 7 entities from platform `cast` 2025-01-25 15:51:48.888 DEBUG (MainThread) [custom_components.spotcast.media_player.utils] Building Device of type `<class 'homeassistant.helpers.entity.ABCCachedProperties'>` 2025-01-25 15:51:48.997 DEBUG (MainThread) [custom_components.spotcast.chromecast.spotify_controller] Build SpotifyController for Chromecast 2025-01-25 15:51:48.997 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account 2025-01-25 15:51:48.998 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify 2025-01-25 15:51:48.998 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset 2025-01-25 15:51:48.998 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account 2025-01-25 15:51:48.999 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Playback Sate for account `mfabiani53` 2025-01-25 15:51:48.999 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing playback state dataset 2025-01-25 15:51:49.063 DEBUG (SyncWorker_30) [custom_components.spotcast.chromecast.spotify_controller] Waiting for `WiiM Pro` to be ready 2025-01-25 15:51:49.063 DEBUG (SyncWorker_30) [custom_components.spotcast.chromecast.spotify_controller] Starting Spotify on `WiiM Pro` 2025-01-25 15:51:49.616 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account 2025-01-25 15:51:49.616 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify 2025-01-25 15:51:49.616 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset 2025-01-25 15:51:49.616 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account 2025-01-25 15:51:49.617 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Devices for account `mfabiani53` 2025-01-25 15:51:49.617 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using Cached devices dataset 2025-01-25 15:51:49.617 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_devices_sensor] Getting Spotify Device for account mfabiani53 2025-01-25 15:51:49.617 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_devices_sensor] Found 5 devices linked to spotify account mfabiani53 2025-01-25 15:51:49.618 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account 2025-01-25 15:51:49.618 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify 2025-01-25 15:51:49.618 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset 2025-01-25 15:51:49.618 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_profile_sensor] Getting Spotify Profile for account `mfabiani53` 2025-01-25 15:51:49.618 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_profile_sensor] Profile retrieve for account id `mfabiani53` 2025-01-25 15:51:49.619 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account 2025-01-25 15:51:49.619 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify 2025-01-25 15:51:49.619 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset 2025-01-25 15:51:49.620 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_product_sensor] Getting Spotify Subscription Type `mfabiani53` 2025-01-25 15:51:49.620 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_product_sensor] Account `mfabiani53` has the `free` subscription 2025-01-25 15:51:49.620 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account 2025-01-25 15:51:49.620 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify 2025-01-25 15:51:49.620 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset 2025-01-25 15:51:49.621 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_followers_sensor] Getting Spotify followers for account `mfabiani53` 2025-01-25 15:51:49.621 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_followers_sensor] Found 0 followers for spotify account `mfabiani53` 2025-01-25 15:51:49.623 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account 2025-01-25 15:51:49.623 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify 2025-01-25 15:51:49.624 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset 2025-01-25 15:51:49.624 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_account_type_sensor] Getting Spotify account type for `mfabiani53` 2025-01-25 15:51:49.624 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_account_type_sensor] Type retrieve for account id `mfabiani53` 2025-01-25 15:51:49.630 DEBUG (MainThread) [custom_components.spotcast.binary_sensor.is_default_binary_sensor] Updating default state sensor for `01JDM1YRVP8QKD8MNDEAZB12MK` 2025-01-25 15:51:49.630 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account 2025-01-25 15:51:49.631 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify 2025-01-25 15:51:49.631 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset 2025-01-25 15:51:49.631 DEBUG (MainThread) [custom_components.spotcast.binary_sensor.spotify_profile_malfunction_sensor] Getting Spotify Profile for account `mfabiani53` 2025-01-25 15:51:49.631 DEBUG (MainThread) [custom_components.spotcast.binary_sensor.spotify_profile_malfunction_sensor] Profile retrieve for account id `mfabiani53` 2025-01-25 15:51:49.632 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account 2025-01-25 15:51:49.632 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify 2025-01-25 15:51:49.632 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset 2025-01-25 15:51:49.632 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account 2025-01-25 15:51:49.632 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Devices for account `mfabiani53` 2025-01-25 15:51:49.632 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using Cached devices dataset 2025-01-25 15:51:49.633 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account 2025-01-25 15:51:49.633 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify 2025-01-25 15:51:49.633 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset 2025-01-25 15:51:49.633 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account 2025-01-25 15:51:49.633 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Playback Sate for account `mfabiani53` 2025-01-25 15:51:49.633 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using Cached playback state dataset 2025-01-25 15:51:49.633 DEBUG (MainThread) [custom_components.spotcast.media_player.device_manager] Updating device info for `Spotcast (mfabiani53) - Salotto` 2025-01-25 15:51:49.633 DEBUG (MainThread) [custom_components.spotcast.media_player.device_manager] Updating device info for `Spotcast (mfabiani53) - 38cc2af29cf8a2dbc4bfb14b4130cf47e3b0516a` 2025-01-25 15:51:49.634 DEBUG (MainThread) [custom_components.spotcast.media_player.device_manager] Updating device info for `Spotcast (mfabiani53) - Echo Show` 2025-01-25 15:51:49.634 DEBUG (MainThread) [custom_components.spotcast.media_player.device_manager] Updating device info for `Spotcast (mfabiani53) - Ovunque` 2025-01-25 15:51:49.634 DEBUG (MainThread) [custom_components.spotcast.media_player.device_manager] Updating device info for `Spotcast (mfabiani53) - Echo Show 5` 2025-01-25 15:51:49.797 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_playlists_sensor] Found 274 playlist for spotify account `mfabiani53` 2025-01-25 15:51:49.863 DEBUG (MainThread) [custom_components.spotcast.sensor.spotify_liked_songs_sensor] Found 6133 liked songs for spotify account `mfabiani53` 2025-01-25 15:51:51.739 DEBUG (SyncWorker_30) [custom_components.spotcast.chromecast.spotify_controller] Waiting for `WiiM Pro` to be available 2025-01-25 15:51:51.740 DEBUG (SyncWorker_30) [custom_components.spotcast.chromecast.spotify_controller] Requesting Spotify App to launch on `WiiM Pro` 2025-01-25 15:51:51.756 DEBUG (SyncWorker_30) [custom_components.spotcast.chromecast.spotify_controller] Spotify App not yet launched on `WiiM Pro`. Waiting Before retry 2025-01-25 15:51:51.893 DEBUG (Thread-2593) [custom_components.spotcast.chromecast.spotify_controller] Received message of type `getInfoResponse` 2025-01-25 15:51:51.893 DEBUG (Thread-2593) [custom_components.spotcast.chromecast.spotify_controller] {'type': 'getInfoResponse', 'payload': {'remoteName': 'WiiM Pro', 'deviceID': '822fbf65be33f3e10824838715db06ee', 'deviceAPI_isGroup': False, 'version': '2.9.0', 'publicKey': 'empty', 'deviceType': 'cast_audio', 'brandDisplayName': 'google', 'modelDisplayName': 'Chromecast_Audio', 'libraryVersion': '5.44.1', 'resolverVersion': '1', 'groupStatus': 'NONE', 'tokenType': 'accesstoken', 'clientID': 'd7df0887fb71494ea994202cb473eae7', 'productID': 0, 'scope': 'streaming', 'availability': '', 'spotifyError': 0, 'status': 101, 'statusString': 'OK'}} 2025-01-25 15:51:52.762 DEBUG (SyncWorker_30) [custom_components.spotcast.chromecast.spotify_controller] Spotify App not yet launched on `WiiM Pro`. Waiting Before retry 2025-01-25 15:51:54.357 DEBUG (SyncWorker_30) [custom_components.spotcast.chromecast.spotify_controller] Spotify App not yet launched on `WiiM Pro`. Waiting Before retry 2025-01-25 15:51:55.357 DEBUG (SyncWorker_30) [custom_components.spotcast.chromecast.spotify_controller] Spotify App not yet launched on `WiiM Pro`. Waiting Before retry 2025-01-25 15:51:56.213 DEBUG (Thread-2593) [custom_components.spotcast.chromecast.spotify_controller] Received message of type `addUserResponse` 2025-01-25 15:51:56.213 DEBUG (Thread-2593) [custom_components.spotcast.chromecast.spotify_controller] {'type': 'addUserResponse', 'payload': {'status': 101, 'statusString': 'OK', 'spotifyError': 0, 'user': {'id': 'mfabiani53'}, 'deviceId': '822fbf65be33f3e10824838715db06ee'}} 2025-01-25 15:51:56.216 DEBUG (SyncWorker_30) [custom_components.spotcast.chromecast.spotify_controller] Spotify App Launched successfully on `WiiM Pro` 2025-01-25 15:51:56.218 INFO (MainThread) [custom_components.spotcast.services.play_media] Playing `spotify:playlist:37i9dQZF1E36buj8U8F3MT` on `WiiM Pro` for account `mfabiani53` 2025-01-25 15:51:56.218 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account 2025-01-25 15:51:56.218 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify 2025-01-25 15:51:56.219 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset 2025-01-25 15:51:56.219 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account 2025-01-25 15:51:56.219 INFO (MainThread) [custom_components.spotcast.spotify.account] Starting playback of `spotify:playlist:37i9dQZF1E36buj8U8F3MT` on device `822fbf65be33f3e10824838715db06ee` 2025-01-25 15:51:56.712 DEBUG (Thread-2593) [custom_components.spotcast.chromecast.spotify_controller] Received message of type `transferSuccess` 2025-01-25 15:51:56.712 DEBUG (Thread-2593) [custom_components.spotcast.chromecast.spotify_controller] {'type': 'transferSuccess', 'payload': {'status': 101, 'statusString': 'OK', 'spotifyError': 0}}

[custom_components.spotcast.sensor.spotify_liked_songs_sensor] Found 6133 liked songs for spotify account `mfabiani53`
2025-01-25 15:51:51.739 DEBUG (SyncWorker_30) [custom_components.spotcast.chromecast.spotify_controller] Waiting for `WiiM Pro` to be available
2025-01-25 15:51:51.740 DEBUG (SyncWorker_30) [custom_components.spotcast.chromecast.spotify_controller] Requesting Spotify App to launch on `WiiM Pro`
2025-01-25 15:51:51.756 DEBUG (SyncWorker_30) [custom_components.spotcast.chromecast.spotify_controller] Spotify App not yet launched on `WiiM Pro`. Waiting Before retry
2025-01-25 15:51:51.893 DEBUG (Thread-2593) [custom_components.spotcast.chromecast.spotify_controller] Received message of type `getInfoResponse`
2025-01-25 15:51:51.893 DEBUG (Thread-2593) [custom_components.spotcast.chromecast.spotify_controller] {'type': 'getInfoResponse', 'payload': {'remoteName': 'WiiM Pro', 'deviceID': '822fbf65be33f3e10824838715db06ee', 'deviceAPI_isGroup': False, 'version': '2.9.0', 'publicKey': 'empty', 'deviceType': 'cast_audio', 'brandDisplayName': 'google', 'modelDisplayName': 'Chromecast_Audio', 'libraryVersion': '5.44.1', 'resolverVersion': '1', 'groupStatus': 'NONE', 'tokenType': 'accesstoken', 'clientID': 'd7df0887fb71494ea994202cb473eae7', 'productID': 0, 'scope': 'streaming', 'availability': '', 'spotifyError': 0, 'status': 101, 'statusString': 'OK'}}
2025-01-25 15:51:52.762 DEBUG (SyncWorker_30) [custom_components.spotcast.chromecast.spotify_controller] Spotify App not yet launched on `WiiM Pro`. Waiting Before retry
2025-01-25 15:51:54.357 DEBUG (SyncWorker_30) [custom_components.spotcast.chromecast.spotify_controller] Spotify App not yet launched on `WiiM Pro`. Waiting Before retry
2025-01-25 15:51:55.357 DEBUG (SyncWorker_30) [custom_components.spotcast.chromecast.spotify_controller] Spotify App not yet launched on `WiiM Pro`. Waiting Before retry
2025-01-25 15:51:56.213 DEBUG (Thread-2593) [custom_components.spotcast.chromecast.spotify_controller] Received message of type `addUserResponse`
2025-01-25 15:51:56.213 DEBUG (Thread-2593) [custom_components.spotcast.chromecast.spotify_controller] {'type': 'addUserResponse', 'payload': {'status': 101, 'statusString': 'OK', 'spotifyError': 0, 'user': {'id': 'mfabiani53'}, 'deviceId': '822fbf65be33f3e10824838715db06ee'}}
2025-01-25 15:51:56.216 DEBUG (SyncWorker_30) [custom_components.spotcast.chromecast.spotify_controller] Spotify App Launched successfully on `WiiM Pro`
2025-01-25 15:51:56.218 INFO (MainThread) [custom_components.spotcast.services.play_media] Playing `spotify:playlist:37i9dQZF1E36buj8U8F3MT` on `WiiM Pro` for account `mfabiani53`
2025-01-25 15:51:56.218 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:51:56.218 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Getting Profile from Spotify
2025-01-25 15:51:56.219 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Using cached profile dataset
2025-01-25 15:51:56.219 DEBUG (MainThread) [custom_components.spotcast.spotify.account] Refreshing api tokens for Spotify Account
2025-01-25 15:51:56.219 INFO (MainThread) [custom_components.spotcast.spotify.account] Starting playback of `spotify:playlist:37i9dQZF1E36buj8U8F3MT` on device `822fbf65be33f3e10824838715db06ee`
2025-01-25 15:51:56.712 DEBUG (Thread-2593) [custom_components.spotcast.chromecast.spotify_controller] Received message of type `transferSuccess`
2025-01-25 15:51:56.712 DEBUG (Thread-2593) [custom_components.spotcast.chromecast.spotify_controller] {'type': 'transferSuccess', 'payload': {'status': 101, 'statusString': 'OK', 'spotifyError': 0}}




      		
    

  





        


            

            

              
            

        

      


      

            
  

    
  
    
    

  

  



    












      

  
      



  

  @mfabiani53





  


    

      

  

    

        
    
    

  


      
          
  
      
            Copy link

  

      
    

  


  

      



      

  Author


  


  

    

  





      


        


  
    

      
          
It seems all ok....

      		
    

  





        


            

            

              
            

        

      


      

            
  

    
  
    
    

  

  



    












      

  
      



  

  @fcusson





  


    

      

  

    

        
    
    

  


      
          
  
      
            Copy link

  

      
    

  


  

      

  
    Collaborator


      

  


  

    

      

      
            fcusson
  

      

      

      commented


        Jan 25, 2025


      
    


  





      


        


  
    

      
          
@mfabiani53 I don't see any errors in the logs you sent. Good news is that, the 104 error is not a constant one. That would have mean your network stack would have been at fault probably. I can see you are able to get tokens and all sensors seem to be able to load.


My best guess currently for the 104 might have been the Spotify Proxy you tried to reach was being overloaded, so it wasn't even able to respond with a 503 error which would mean its unable to serve you at the moment, it simply declined the new connection, so the TCP relay replied back with a 104 error.


I'll make 104 error a warning instead of a traceback error, that still means they will register. Its not something that can be fixed at the integration level.

      		
    

  





        


            

            

              
            

        

      


      

            
  

    
  
    
    

  

  



    












      

  
      



  

  @fcusson





  


    

      

  

    

        
    
    

  


      
          
  
      
            Copy link

  

      
    

  


  

      

  
    Collaborator


      

  


  

    

      

      
            fcusson
  

      

      

      commented


        Jan 25, 2025


      
    


  





      


        


  
    

      
          
@mfabiani53 quick tip, you can drag and drop a file in Github, it will upload it and create a permalink. Its much easier to parse through

      		
    

  





        


            

            

              
            

        

      


      

            
  

    
  
    
    

  

  



    












      

  
      



  

  @mfabiani53





  


    

      

  

    

        
    
    

  


      
          
  
      
            Copy link

  

      
    

  


  

      



      

  Author


  


  

    

  





      


        


  
    

      
          
Ok, glad to help you...

      		
    

  





        


            

            

              
            

        

      


      

            
  

    
  
    
    

  

  



    
















  
  

    

      

  





  




  
  

              

  
    Sign up for free
    to join this conversation on GitHub.
    Already have an account?
    Sign in to comment


  



  






  
                    




    

  


      
  

    Assignees
  



        

      

        

  
      @fcusson
  
    fcusson
    

      








      


  


  

    Labels
  



    

      

    beta

  Related to the beta program
  

    bug

  Something isn't working
  

    more info needed

  Maintainers will be unable to work on the issue until more information is provided








      

  

    

        

    Projects
  


        




    None yet




  



      


  

    
  

    Milestone
  


      No milestone





    
      
          


  

    
      

        
    

    Development
  




          
    
No branches or pull requests







    
  




      

    

  
      

  

    

      2 participants
    

    

        
          @mfabiani53 
        
          @fcusson