Step 1 has reached error limit

[kevindery]

Hi i can't remote start or lock the door like i use to i get "Step 1 has reached error limit" error but the fuel level is still accurate. There is something to do to fix it?

[140213703355200] Step 1 has reached error limit Traceback (most recent call last): File "/usr/src/homeassistant/homeassistant/components/websocket_api/commands.py", line 230, in handle_call_service await hass.services.async_call( File "/usr/src/homeassistant/homeassistant/core.py", line 2035, in async_call response_data = await coro ^^^^^^^^^^ File "/usr/src/homeassistant/homeassistant/core.py", line 2072, in _execute_service return await target(service_call) ^^^^^^^^^^^^^^^^^^^^^^^^^^ File "/usr/src/homeassistant/homeassistant/helpers/entity_component.py", line 235, in handle_service return await service.entity_service_call( ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ File "/usr/src/homeassistant/homeassistant/helpers/service.py", line 876, in entity_service_call response_data = await _handle_entity_call( ^^^^^^^^^^^^^^^^^^^^^^^^^^ File "/usr/src/homeassistant/homeassistant/helpers/service.py", line 948, in _handle_entity_call result = await task ^^^^^^^^^^ File "/usr/src/homeassistant/homeassistant/components/lock/__init__.py", line 99, in _async_lock await entity.async_lock(**remove_entity_service_fields(service_call)) File "/config/custom_components/fordpass/lock.py", line 41, in async_lock status = await self.coordinator.hass.async_add_executor_job( ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ File "/usr/local/lib/python3.11/concurrent/futures/thread.py", line 58, in run result = self.fn(*self.args, **self.kwargs) ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ File "/config/custom_components/fordpass/fordpass_new.py", line 636, in lock return self.__request_and_poll_command("lock") ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ File "/config/custom_components/fordpass/fordpass_new.py", line 694, in __request_and_poll_command self.__acquire_token() File "/config/custom_components/fordpass/fordpass_new.py", line 383, in __acquire_token self.auth() File "/config/custom_components/fordpass/fordpass_new.py", line 281, in auth raise Exception("Step 1 has reached error limit") Exception: Step 1 has reached error limit

[tcc0]

Same problem for me as well

Traceback (most recent call last): File "/usr/src/homeassistant/homeassistant/components/websocket_api/commands.py", line 230, in handle_call_service await hass.services.async_call( File "/usr/src/homeassistant/homeassistant/core.py", line 2035, in async_call response_data = await coro ^^^^^^^^^^ File "/usr/src/homeassistant/homeassistant/core.py", line 2072, in _execute_service return await target(service_call) ^^^^^^^^^^^^^^^^^^^^^^^^^^ File "/usr/src/homeassistant/homeassistant/helpers/entity_component.py", line 235, in handle_service return await service.entity_service_call( ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ File "/usr/src/homeassistant/homeassistant/helpers/service.py", line 876, in entity_service_call response_data = await _handle_entity_call( ^^^^^^^^^^^^^^^^^^^^^^^^^^ File "/usr/src/homeassistant/homeassistant/helpers/service.py", line 948, in _handle_entity_call result = await task ^^^^^^^^^^ File "/config/custom_components/fordpass/switch.py", line 46, in async_turn_on await self.coordinator.hass.async_add_executor_job( File "/usr/local/lib/python3.11/concurrent/futures/thread.py", line 58, in run result = self.fn(*self.args, **self.kwargs) ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ File "/config/custom_components/fordpass/fordpass_new.py", line 624, in start return self.request_and_poll_command("remoteStart") ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ File "/config/custom_components/fordpass/fordpass_new.py", line 694, in __request_and_poll_command self.acquire_token() File "/config/custom_components/fordpass/fordpass_new.py", line 383, in __acquire_token self.auth() File "/config/custom_components/fordpass/fordpass_new.py", line 281, in auth raise Exception("Step 1 has reached error limit") Exception: Step 1 has reached error limit

[itchannel]

Are you both just experiencing this for remote start and locks? Does normal data still update for you?

Is there any other errors in your logs around url connection timeouts. As it looks like Step 1 is hitting the 10 retry error count.

[tcc0]

Yes remote start and locks indeed, the other data is still updating!

And yes, other errors (replaced client_id with blablabla):

Deze fout is ontstaan door een aangepaste integratie.

Logger: urllib3.connectionpool Source: custom_components/fordpass/fordpass_new.py:97 Integration: FordPass (documentation, issues) First occurred: 05:31:33 (21 occurrences) Last logged: 12:32:49

Retrying (Retry(total=9, connect=3, read=None, redirect=None, status=None)) after connection broken by 'ProtocolError('Connection aborted.', RemoteDisconnected('Remote end closed connection without response'))': /v1.0/endpoint/default/authorize?redirect_uri=fordapp://userauthorized&response_type=code&scope=openid&max_age=3600&client_id=blablabla&code_challenge=lzxitCHq1_KfFJO8OwnXRnnBcj195_f1rm92OUJNcRA&code_challenge_method=S256 Retrying (Retry(total=9, connect=3, read=None, redirect=None, status=None)) after connection broken by 'ProtocolError('Connection aborted.', RemoteDisconnected('Remote end closed connection without response'))': /v1.0/endpoint/default/authorize?redirect_uri=fordapp://userauthorized&response_type=code&scope=openid&max_age=3600&client_id=blablabla&code_challenge=ea8L2Nbv5Nb6PxzOomka1uyzSmJPUfWtY3AneqnCX_M&code_challenge_method=S256 Retrying (Retry(total=9, connect=3, read=None, redirect=None, status=None)) after connection broken by 'ProtocolError('Connection aborted.', RemoteDisconnected('Remote end closed connection without response'))': /v1.0/endpoint/default/authorize?redirect_uri=fordapp://userauthorized&response_type=code&scope=openid&max_age=3600&client_id=blablabla&code_challenge=BFU3rtmURYKIXu1S4nVWEDszXHtH_GqHNK4eBol3X1E&code_challenge_method=S256 Retrying (Retry(total=9, connect=3, read=None, redirect=None, status=None)) after connection broken by 'ProtocolError('Connection aborted.', RemoteDisconnected('Remote end closed connection without response'))': /v1.0/endpoint/default/authorize?redirect_uri=fordapp://userauthorized&response_type=code&scope=openid&max_age=3600&client_id=blablabla&code_challenge=xm9mpuW8N1f0B2_X4DD_wkJLKe9Ex7KYLg1xVBPgn7o&code_challenge_method=S256 Retrying (Retry(total=9, connect=3, read=None, redirect=None, status=None)) after connection broken by 'ProtocolError('Connection aborted.', RemoteDisconnected('Remote end closed connection without response'))': /v1.0/endpoint/default/authorize?redirect_uri=fordapp://userauthorized&response_type=code&scope=openid&max_age=3600&client_id=blablabla&code_challenge=3l_O0FR6ThbXOhqS1z_UUGyP5gh6sfCCvTwM4iToitA&code_challenge_method=S256

[kevindery]

There's the full logs, i'm still new to HA 😅 Line 35 is it what you looking for? 2023-11-03 13:25:27.516 WARNING (MainThread) [custom_components.fordpass] cannot access local variable 'response' where it is not associated with a value

2023-11-03 13:10:14.873 WARNING (SyncWorker_3) [homeassistant.loader] We found a custom integration ui_lovelace_minimalist which has not been tested by Home Assistant. This component might cause stability problems, be sure to disable it if you experience issues with Home Assistant 2023-11-03 13:10:14.875 WARNING (SyncWorker_3) [homeassistant.loader] We found a custom integration fordpass which has not been tested by Home Assistant. This component might cause stability problems, be sure to disable it if you experience issues with Home Assistant 2023-11-03 13:10:14.878 WARNING (SyncWorker_3) [homeassistant.loader] We found a custom integration ember_mug which has not been tested by Home Assistant. This component might cause stability problems, be sure to disable it if you experience issues with Home Assistant 2023-11-03 13:10:14.880 WARNING (SyncWorker_3) [homeassistant.loader] We found a custom integration localtuya which has not been tested by Home Assistant. This component might cause stability problems, be sure to disable it if you experience issues with Home Assistant 2023-11-03 13:10:14.881 WARNING (SyncWorker_3) [homeassistant.loader] We found a custom integration hacs which has not been tested by Home Assistant. This component might cause stability problems, be sure to disable it if you experience issues with Home Assistant 2023-11-03 13:10:14.882 WARNING (SyncWorker_3) [homeassistant.loader] We found a custom integration webrtc which has not been tested by Home Assistant. This component might cause stability problems, be sure to disable it if you experience issues with Home Assistant 2023-11-03 13:10:16.116 WARNING (Recorder) [homeassistant.components.recorder.util] The system could not validate that the sqlite3 database at //config/home-assistant_v2.db was shutdown cleanly 2023-11-03 13:10:16.142 WARNING (Recorder) [homeassistant.components.recorder.util] Ended unfinished session (id=19 from 2023-11-01 21:16:57.219787) 2023-11-03 13:10:21.199 WARNING (MainThread) [hass_nabucasa.cloud_api] Fetched https://alexa-api.nabucasa.com/access_token (400) 2023-11-03 13:14:13.467 ERROR (stream_worker) [homeassistant.components.stream.stream.camera.kitchen] Error from stream worker: Error opening stream (HTTP_NOT_FOUND, Server returned 404 Not Found) rtsps://stream-ue1-bravo.dropcam.com:443/sdm_live_stream/CiUA2vuxr8TL3pmIE3RmV_rFHIaqeEkhnyk3qxOlbZQBhLRuxtXiEnEAJV7BO4AXVQM283pgb3mffTSxgeghj_ew3oL3QKe3YBYDyN1iK23MT0bwO1q5f4H0u-MIJJ72u7MHrH2jZDEPVFKuMrMf7W0csUwKmpLU_qS6aHu8sW3hZCSDZFhEJSLSI0-BGkzLMlkZ4oi5d5-Qsw?auth=**** 2023-11-03 13:14:32.631 ERROR (MainThread) [frontend.js.latest.202310301] Uncaught error from Chrome 118.0.0.0 on Windows 10 TypeError: Cannot read properties of undefined (reading 'domain') _keyFunction (src/panels/config/integrations/dialog-add-integration.ts:455:16) keyFunction (src/virtualize.ts:116:41) r (src/directives/repeat.ts:56:28) ct (src/directives/repeat.ts:93:52) update (src/directive.ts:134:16) _$AS (src/lit-html.ts:1085:23) S (src/lit-html.ts:1362:12) _$AI (src/async-directive.ts:366:18) setValue (src/virtualize.ts:139:13) dispatchEvent (src/Virtualizer.ts:802:23) 2023-11-03 13:14:33.817 ERROR (MainThread) [frontend.js.latest.202310301] Uncaught error from Chrome 118.0.0.0 on Windows 10 TypeError: Cannot read properties of undefined (reading 'domain') _keyFunction (src/panels/config/integrations/dialog-add-integration.ts:455:16) keyFunction (src/virtualize.ts:116:41) r (src/directives/repeat.ts:56:28) ct (src/directives/repeat.ts:93:52) update (src/directive.ts:134:16) _$AS (src/lit-html.ts:1085:23) S (src/lit-html.ts:1362:12) _$AI (src/async-directive.ts:366:18) setValue (src/virtualize.ts:139:13) dispatchEvent (src/Virtualizer.ts:802:23) 2023-11-03 13:25:27.516 WARNING (MainThread) [custom_components.fordpass] cannot access local variable 'response' where it is not associated with a value 2023-11-03 13:25:27.516 WARNING (MainThread) [custom_components.fordpass] Error communicating with FordPass for 1FTFW1E52MKE01417 2023-11-03 13:25:27.516 WARNING (MainThread) [custom_components.fordpass] Returning Stale data to prevent unavaliable status 2023-11-03 13:40:27.891 WARNING (SyncWorker_1) [urllib3.connectionpool] Retrying (Retry(total=9, connect=3, read=None, redirect=None, status=None)) after connection broken by 'ProtocolError('Connection aborted.', RemoteDisconnected('Remote end closed connection without response'))': /v1.0/endpoint/default/authorize?redirect_uri=fordapp://userauthorized&response_type=code&scope=openid&max_age=3600&client_id=9fb503e0-715b-47e8-adfd-ad4b7770f73b&code_challenge=OJ1evBQPdRGgkelUUakag71Af-P6sWjMzb92ZL3LS1w&code_challenge_method=S256 2023-11-03 13:40:33.667 WARNING (MainThread) [custom_components.fordpass] Step 1 has reached error limit 2023-11-03 13:40:33.667 WARNING (MainThread) [custom_components.fordpass] Error communicating with FordPass for 1FTFW1E52MKE01417 2023-11-03 13:40:33.667 WARNING (MainThread) [custom_components.fordpass] Returning Stale data to prevent unavaliable status 2023-11-03 13:40:53.559 WARNING (MainThread) [google_nest_sdm.event_media] Failure when pre-fetching event 'AVPHwEsE4GHiAoVK2jKNy_SnVbWJJfcTemx3ZD9tTnFJSOLJMwu6D6DExJ5nTCZb7Kw8pzzQ_XGjogLy8i4TTnHpUWpN': Internal Server Error 2023-11-03 13:55:33.587 WARNING (SyncWorker_2) [urllib3.connectionpool] Retrying (Retry(total=9, connect=3, read=None, redirect=None, status=None)) after connection broken by 'ProtocolError('Connection aborted.', RemoteDisconnected('Remote end closed connection without response'))': /v1.0/endpoint/default/authorize?redirect_uri=fordapp://userauthorized&response_type=code&scope=openid&max_age=3600&client_id=9fb503e0-715b-47e8-adfd-ad4b7770f73b&code_challenge=00DAbn7zf95ll-kn87Lcdmi4LdsgYsbxDqqIcou5D-4&code_challenge_method=S256 2023-11-03 13:55:34.229 WARNING (MainThread) [custom_components.fordpass] Step 1 has reached error limit 2023-11-03 13:55:34.230 WARNING (MainThread) [custom_components.fordpass] Error communicating with FordPass for 1FTFW1E52MKE01417 2023-11-03 13:55:34.230 WARNING (MainThread) [custom_components.fordpass] Returning Stale data to prevent unavaliable status 2023-11-03 14:00:15.184 ERROR (MainThread) [homeassistant.components.websocket_api.http.connection] [140576621448896] Step 1 has reached error limit Traceback (most recent call last): File "/usr/src/homeassistant/homeassistant/components/websocket_api/commands.py", line 230, in handle_call_service await hass.services.async_call( File "/usr/src/homeassistant/homeassistant/core.py", line 2035, in async_call response_data = await coro ^^^^^^^^^^ File "/usr/src/homeassistant/homeassistant/core.py", line 2072, in _execute_service return await target(service_call) ^^^^^^^^^^^^^^^^^^^^^^^^^^ File "/usr/src/homeassistant/homeassistant/helpers/entity_component.py", line 235, in handle_service return await service.entity_service_call( ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ File "/usr/src/homeassistant/homeassistant/helpers/service.py", line 876, in entity_service_call response_data = await _handle_entity_call( ^^^^^^^^^^^^^^^^^^^^^^^^^^ File "/usr/src/homeassistant/homeassistant/helpers/service.py", line 948, in _handle_entity_call result = await task ^^^^^^^^^^ File "/usr/src/homeassistant/homeassistant/components/lock/__init__.py", line 99, in _async_lock await entity.async_lock(**remove_entity_service_fields(service_call)) File "/config/custom_components/fordpass/lock.py", line 41, in async_lock status = await self.coordinator.hass.async_add_executor_job( ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ File "/usr/local/lib/python3.11/concurrent/futures/thread.py", line 58, in run result = self.fn(*self.args, **self.kwargs) ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ File "/config/custom_components/fordpass/fordpass_new.py", line 636, in lock return self.__request_and_poll_command("lock") ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ File "/config/custom_components/fordpass/fordpass_new.py", line 694, in __request_and_poll_command self.__acquire_token() File "/config/custom_components/fordpass/fordpass_new.py", line 383, in __acquire_token self.auth() File "/config/custom_components/fordpass/fordpass_new.py", line 281, in auth raise Exception("Step 1 has reached error limit") Exception: Step 1 has reached error limit

[itchannel]

Does this happen every time you try locking/unlocking or only every so often?

The error indicates that it is having problems connecting to the Fordpass authentication endpoint so is timing out.

Can anyone experiencing the issue please provide me with the current information so I can try and narrow down the cause.

• Model and Year of vehicle
• Version of Home Assistant (Including is it HAOS, Docker etc)
• Version of fordpass integration (Latest 1.61)
• Region/Country you are from and the region you choose when setting it up.
• Is it only locking/unlocking and remote start that is affected
• Output from enabling debugging and trying to lock/unlock (https://github.com/itchannel/fordpass-ha/wiki/Obtaining-Integration-Logs)

Hopefully with this information I will be able to narrow down the issue as it seems to only be affecting a small number and I've been unable to replicate it on my end.

[tcc0]

I have this problem everytime I want to control something (doors, lock, update status) and since the last couple of versions.

Kinda weird, looks like read-only is always working (getting data from the cloud) but writing/controlling something doesn't work (opening, locking, refreshing)

The info is always(!) automatically updating when I drove the car, but when I manually press the refresh car button for instance I get the 3 log entries as well:

Retrying (Retry(total=9, connect=3, read=None, redirect=None, status=None)) after connection broken by 'ProtocolError('Connection aborted.', RemoteDisconnected('Remote end closed connection without response'))': /v1.0/endpoint/default/authorize?redirect_uri=fordapp://userauthorized&response_type=code&scope=openid&max_age=3600&client_id=blablabla&code_challenge=y5SHDToMK6kvnS3O129NM2OZWrLy-OgRhgIfEx4swOo&code_challenge_method=S256 08:45:14 – (WAARSCHUWING) FordPass (aangepaste integratie)

FordPass Refresh Status: Error executing script. Unexpected error for call_service at pos 1: Step 1 has reached error limit 08:45:15 – (FOUT) Script

Error doing job: Task exception was never retrieved 08:45:15 – (FOUT) FordPass (aangepaste integratie)

Removed the config, removed the fordpass addon and tried again using

Nov 2018 Ford Focus MK4 (2019 model) HA Core 2023.11.0 FordPass 1.61 Europe/The Netherlands, configured region UK&Europe

Now after importing the VIN (Kun kjøretøy som ikke er lagt til for øyeblikket, vises???) I get some errors about not generating unique ID's (replaced my VIN with blablabla):

Logger: homeassistant.components.lock Source: helpers/entity_platform.py:610 Integration: Slot (documentation, issues) First occurred: 09:11:20 (1 occurrences) Last logged: 09:11:20 Platform fordpass does not generate unique IDs. ID blablabla-fordpass_doorlock already exists - ignoring lock.fordpass_doorlock

Logger: homeassistant.components.switch Source: helpers/entity_platform.py:610 Integration: Schakelaar (documentation, issues) First occurred: 09:11:20 (1 occurrences) Last logged: 09:11:20 Platform fordpass does not generate unique IDs. ID blablabla-fordpass_ignition already exists - ignoring switch.fordpass_ignition_switch

Logger: homeassistant.components.device_tracker Source: helpers/entity_platform.py:610 Integration: Apparaattracker (documentation, issues) First occurred: 09:11:20 (1 occurrences) Last logged: 09:11:20 Platform fordpass does not generate unique IDs. ID blablabla-fordpass_tracker already exists - ignoring device_tracker.fordpass_tracker

Logger: homeassistant.components.sensor Source: helpers/entity_platform.py:610 Integration: Sensor (documentation, issues) First occurred: 09:11:20 (15 occurrences) Last logged: 09:11:22 Platform fordpass does not generate unique IDs. ID blablabla-fordpass_indicators already exists - ignoring sensor.fordpass_indicators Platform fordpass does not generate unique IDs. ID blablabla-fordpass_coolantTemp already exists - ignoring sensor.fordpass_coolanttemp Platform fordpass does not generate unique IDs. ID blablabla-fordpass_remoteStartStatus already exists - ignoring sensor.fordpass_remotestartstatus Platform fordpass does not generate unique IDs. ID blablabla-fordpass_messages already exists - ignoring sensor.fordpass_messages Platform fordpass does not generate unique IDs. ID blablabla-fordpass_odometer already exists - ignoring sensor.fordpass_odometer

Now the remove/reconfigure actions solved the authorization shizzle and error messages, but I have to test if doors/ignition works (got only 44km left in the tank so remote start doesn't work now), will let you know!

[EDIT]

Ah bummer, after restarting Home Assistant it's back

Logger: urllib3.connectionpool Source: custom_components/fordpass/fordpass_new.py:97 Integration: FordPass (documentation, issues) First occurred: 09:58:07 (1 occurrences) Last logged: 09:58:07

Retrying (Retry(total=9, connect=3, read=None, redirect=None, status=None)) after connection broken by 'ProtocolError('Connection aborted.', RemoteDisconnected('Remote end closed connection without response'))': /v1.0/endpoint/default/authorize?redirect_uri=fordapp://userauthorized&response_type=code&scope=openid&max_age=3600&client_id=blablabla&code_challenge=Eps4dtE4R9tkyjub6j2QDtxm9Emj6m5QIjA0R23p2mI&code_challenge_method=S256

[itchannel]

@tcc0 The already exists errors will fix themselves after a restart it's because on removal HA isn't releasing them correctly. It's on my list to look into at some point.

The timeout issue seems to be that the API stops responding "'ProtocolError('Connection aborted.',". I've added a timeout of 10 seconds in the loop just to see if that helps as well as logging the step1 URL. If you have five can you replace your fordpass_new.py with the one linked https://github.com/itchannel/fordpass-ha/blob/1.62/custom_components/fordpass/fordpass_new.py

Otherwise I'm happy to screenshare or walkthrough with someone to do some debug testing as I can't replicate on my end.

[tcc0]

Upgraded to Home Assistant 2023.11.1 meanwhile and after that restarted I was able to lock and unlock the doors and refresh the info without the errors in the log.

Anyway, replaced fordpass_new.py with the new version and restarted Home Assistant.

Will keep you posted, thanks for your great support already!

[tcc0]

Got the error again while just running HA (didnt replace client_id because it's the same as kevindery's?):

Logboek Details (WAARSCHUWING) Deze fout is ontstaan door een aangepaste integratie.

Logger: urllib3.connectionpool Source: custom_components/fordpass/fordpass_new.py:98 Integration: FordPass (documentation, issues) First occurred: 11:12:35 (2 occurrences) Last logged: 11:58:06

Retrying (Retry(total=9, connect=3, read=None, redirect=None, status=None)) after connection broken by 'ProtocolError('Connection aborted.', RemoteDisconnected('Remote end closed connection without response'))': /v1.0/endpoint/default/authorize?redirect_uri=fordapp://userauthorized&response_type=code&scope=openid&max_age=3600&client_id=9fb503e0-715b-47e8-adfd-ad4b7770f73b&code_challenge=qCaji6Ls2rrmOl9PDYE_xVps4XMlgJDBhSndpFA97XM&code_challenge_method=S256

Retrying (Retry(total=9, connect=3, read=None, redirect=None, status=None)) after connection broken by 'ProtocolError('Connection aborted.', RemoteDisconnected('Remote end closed connection without response'))': /v1.0/endpoint/default/authorize?redirect_uri=fordapp://userauthorized&response_type=code&scope=openid&max_age=3600&client_id=9fb503e0-715b-47e8-adfd-ad4b7770f73b&code_challenge=XazwsahSohJzX-C4RtjQDB5f-s5G9dhQB5X6_ikDres&code_challenge_method=S256

[MartyTremblay]

Same issue here for a 2018 Ford Expedition. Error logs look almost identical.

[itchannel]

Can someone please enabled debug logging (https://github.com/itchannel/fordpass-ha/wiki/Obtaining-Integration-Logs) and provide me with a full copy of the log. There should be debug code in it so we can see more than just the exception that is raised. You can email me at github@itchannel.me if it contains any sensitive info.

The issue appears to be potential rate limiting on the API or some instability as the error indicates the connection was closed with the initial endpoint as part of the authentication check.

Can anyone else please provide what region they are from so far I have one user with "UK&Europe" having the issue.

[kevindery]

For me it look like i can't send data(remote start, locking door) but can read(odometer, fuel) Ford F150 2021 lariat, Canada here's the debug log for trying to lock the door and after remote start home-assistant_fordpass_2023-11-05T21-23-16.808Z.log

Thank you for your awesome support :D

[tcc0]

Missed the debug part, my bad, just emailed you the debug log!

[edit]Hmmm, think I pressed the disable debug logging too early, step 1 shizzle came after it. Will create another debug tonight

[bradleyd444]

I am sending my debug log with the error on both vehicle start and door Lock.

[tcc0]

Emailed you another debug log, this time one including everything, thanks again!

[itchannel]

Thanks for the emails with the log output. I've had a look and the issue appears to be the initial ford endpoint is not responding which is really weird it just ends up timing out. This seems to only affect a number of users but so far I can't find anything in common with the affected users. Please give me a little more time to get to the bottom of this :)

I might need someone to screen share with me so we can live debug the issue. However I have just managed to see in my logs a couple of times it has error ed out. It appears the API is being quite unstable or there is a rate limit applied.

[ziptbm]

@itchannel depending on time, I’d be willing to screen share as I’m seeing this as well. Started for me today. I can grab logs when I’m not on mobile helpful. They look just like the ones above for both of my vehicles.

UPDATE - I noticed this when attempting to remote start my vehicles this morning. It was after sending that command, I noticed the sensors had not updated in a few days. After reloading the sensors, I found them not to properly reconnect to FordPass. I've since then disabled and re-enabled the integration, and restarted HA, but it now appears to be no longer able to connect to either of my vehicles (Mach-E and F150 Lightning).

2023-11-14 08:23:50.033 DEBUG (SyncWorker_3) [custom_components.fordpass.fordpass_new] Getting Vehicle Status 2023-11-14 08:23:50.033 DEBUG (SyncWorker_3) [custom_components.fordpass.fordpass_new] Fetching token 2023-11-14 08:23:50.034 DEBUG (SyncWorker_3) [custom_components.fordpass.fordpass_new] AUTO token not set in file 2023-11-14 08:23:50.034 DEBUG (SyncWorker_3) [custom_components.fordpass.fordpass_new] None 2023-11-14 08:23:50.034 DEBUG (SyncWorker_3) [custom_components.fordpass.fordpass_new] None 2023-11-14 08:23:50.034 DEBUG (SyncWorker_3) [custom_components.fordpass.fordpass_new] New System 2023-11-14 08:23:50.034 DEBUG (SyncWorker_3) [custom_components.fordpass.fordpass_new] 0 2023-11-14 08:23:50.034 DEBUG (SyncWorker_3) [custom_components.fordpass.fordpass_new] Running Step1 2023-11-14 08:23:50.036 DEBUG (SyncWorker_7) [custom_components.fordpass.fordpass_new] Getting Vehicle Status 2023-11-14 08:23:50.036 DEBUG (SyncWorker_7) [custom_components.fordpass.fordpass_new] Fetching token 2023-11-14 08:23:50.039 DEBUG (SyncWorker_7) [custom_components.fordpass.fordpass_new] AUTO token not set in file 2023-11-14 08:23:50.039 DEBUG (SyncWorker_7) [custom_components.fordpass.fordpass_new] None 2023-11-14 08:23:50.039 DEBUG (SyncWorker_7) [custom_components.fordpass.fordpass_new] None 2023-11-14 08:23:50.039 DEBUG (SyncWorker_7) [custom_components.fordpass.fordpass_new] New System 2023-11-14 08:23:50.039 DEBUG (SyncWorker_7) [custom_components.fordpass.fordpass_new] 0 2023-11-14 08:23:50.040 DEBUG (SyncWorker_7) [custom_components.fordpass.fordpass_new] Running Step1 2023-11-14 08:23:50.205 DEBUG (SyncWorker_3) [custom_components.fordpass.fordpass_new] Incorrect response from URL 2023-11-14 08:23:50.206 DEBUG (SyncWorker_3) [custom_components.fordpass.fordpass_new] Step 1 Exception 2023-11-14 08:23:50.206 DEBUG (SyncWorker_3) [custom_components.fordpass.fordpass_new] Response from URL was invalid 2023-11-14 08:23:50.206 DEBUG (SyncWorker_3) [custom_components.fordpass.fordpass_new] New System 2023-11-14 08:23:50.206 DEBUG (SyncWorker_3) [custom_components.fordpass.fordpass_new] 1 2023-11-14 08:23:50.206 DEBUG (SyncWorker_3) [custom_components.fordpass.fordpass_new] Running Step1 2023-11-14 08:23:50.231 DEBUG (SyncWorker_7) [custom_components.fordpass.fordpass_new] Incorrect response from URL 2023-11-14 08:23:50.231 DEBUG (SyncWorker_7) [custom_components.fordpass.fordpass_new] Step 1 Exception 2023-11-14 08:23:50.231 DEBUG (SyncWorker_7) [custom_components.fordpass.fordpass_new] Response from URL was invalid 2023-11-14 08:23:50.231 DEBUG (SyncWorker_7) [custom_components.fordpass.fordpass_new] New System 2023-11-14 08:23:50.231 DEBUG (SyncWorker_7) [custom_components.fordpass.fordpass_new] 1 2023-11-14 08:23:50.231 DEBUG (SyncWorker_7) [custom_components.fordpass.fordpass_new] Running Step1 2023-11-14 08:23:50.321 DEBUG (SyncWorker_7) [custom_components.fordpass.fordpass_new] Incorrect response from URL 2023-11-14 08:23:50.321 DEBUG (SyncWorker_7) [custom_components.fordpass.fordpass_new] Step 1 Exception 2023-11-14 08:23:50.321 DEBUG (SyncWorker_7) [custom_components.fordpass.fordpass_new] Response from URL was invalid 2023-11-14 08:23:50.321 DEBUG (SyncWorker_7) [custom_components.fordpass.fordpass_new] New System 2023-11-14 08:23:50.321 DEBUG (SyncWorker_7) [custom_components.fordpass.fordpass_new] 2 2023-11-14 08:23:50.321 DEBUG (SyncWorker_7) [custom_components.fordpass.fordpass_new] Running Step1 2023-11-14 08:23:50.328 DEBUG (SyncWorker_3) [custom_components.fordpass.fordpass_new] Incorrect response from URL 2023-11-14 08:23:50.328 DEBUG (SyncWorker_3) [custom_components.fordpass.fordpass_new] Step 1 Exception 2023-11-14 08:23:50.328 DEBUG (SyncWorker_3) [custom_components.fordpass.fordpass_new] Response from URL was invalid 2023-11-14 08:23:50.328 DEBUG (SyncWorker_3) [custom_components.fordpass.fordpass_new] New System 2023-11-14 08:23:50.328 DEBUG (SyncWorker_3) [custom_components.fordpass.fordpass_new] 2 2023-11-14 08:23:50.328 DEBUG (SyncWorker_3) [custom_components.fordpass.fordpass_new] Running Step1 2023-11-14 08:23:50.406 DEBUG (SyncWorker_3) [custom_components.fordpass.fordpass_new] Incorrect response from URL 2023-11-14 08:23:50.407 DEBUG (SyncWorker_3) [custom_components.fordpass.fordpass_new] Step 1 Exception 2023-11-14 08:23:50.407 DEBUG (SyncWorker_3) [custom_components.fordpass.fordpass_new] Response from URL was invalid 2023-11-14 08:23:50.407 DEBUG (SyncWorker_3) [custom_components.fordpass.fordpass_new] New System 2023-11-14 08:23:50.407 DEBUG (SyncWorker_3) [custom_components.fordpass.fordpass_new] 3 2023-11-14 08:23:50.407 DEBUG (SyncWorker_3) [custom_components.fordpass.fordpass_new] Running Step1 2023-11-14 08:23:50.408 DEBUG (SyncWorker_7) [custom_components.fordpass.fordpass_new] Incorrect response from URL 2023-11-14 08:23:50.409 DEBUG (SyncWorker_7) [custom_components.fordpass.fordpass_new] Step 1 Exception 2023-11-14 08:23:50.409 DEBUG (SyncWorker_7) [custom_components.fordpass.fordpass_new] Response from URL was invalid 2023-11-14 08:23:50.409 DEBUG (SyncWorker_7) [custom_components.fordpass.fordpass_new] New System 2023-11-14 08:23:50.409 DEBUG (SyncWorker_7) [custom_components.fordpass.fordpass_new] 3 2023-11-14 08:23:50.409 DEBUG (SyncWorker_7) [custom_components.fordpass.fordpass_new] Running Step1 2023-11-14 08:23:50.461 WARNING (MainThread) [slixmpp.stringprep] Using slower stringprep, consider compiling the faster cython/libidn one. 2023-11-14 08:23:50.612 DEBUG (SyncWorker_7) [custom_components.fordpass.fordpass_new] Incorrect response from URL 2023-11-14 08:23:50.612 DEBUG (SyncWorker_7) [custom_components.fordpass.fordpass_new] Step 1 Exception 2023-11-14 08:23:50.612 DEBUG (SyncWorker_7) [custom_components.fordpass.fordpass_new] Response from URL was invalid 2023-11-14 08:23:50.612 DEBUG (SyncWorker_7) [custom_components.fordpass.fordpass_new] New System 2023-11-14 08:23:50.612 DEBUG (SyncWorker_7) [custom_components.fordpass.fordpass_new] 4 2023-11-14 08:23:50.612 DEBUG (SyncWorker_7) [custom_components.fordpass.fordpass_new] Running Step1 2023-11-14 08:23:50.613 DEBUG (SyncWorker_3) [custom_components.fordpass.fordpass_new] Incorrect response from URL 2023-11-14 08:23:50.613 DEBUG (SyncWorker_3) [custom_components.fordpass.fordpass_new] Step 1 Exception 2023-11-14 08:23:50.613 DEBUG (SyncWorker_3) [custom_components.fordpass.fordpass_new] Response from URL was invalid 2023-11-14 08:23:50.613 DEBUG (SyncWorker_3) [custom_components.fordpass.fordpass_new] New System 2023-11-14 08:23:50.613 DEBUG (SyncWorker_3) [custom_components.fordpass.fordpass_new] 4 2023-11-14 08:23:50.613 DEBUG (SyncWorker_3) [custom_components.fordpass.fordpass_new] Running Step1 2023-11-14 08:23:50.724 DEBUG (SyncWorker_3) [custom_components.fordpass.fordpass_new] Incorrect response from URL 2023-11-14 08:23:50.724 DEBUG (SyncWorker_3) [custom_components.fordpass.fordpass_new] Step 1 Exception 2023-11-14 08:23:50.724 DEBUG (SyncWorker_3) [custom_components.fordpass.fordpass_new] Response from URL was invalid 2023-11-14 08:23:50.724 DEBUG (SyncWorker_3) [custom_components.fordpass.fordpass_new] New System 2023-11-14 08:23:50.724 DEBUG (SyncWorker_3) [custom_components.fordpass.fordpass_new] 5 2023-11-14 08:23:50.724 DEBUG (SyncWorker_3) [custom_components.fordpass.fordpass_new] Running Step1 2023-11-14 08:23:50.762 DEBUG (SyncWorker_7) [custom_components.fordpass.fordpass_new] Incorrect response from URL 2023-11-14 08:23:50.762 DEBUG (SyncWorker_7) [custom_components.fordpass.fordpass_new] Step 1 Exception 2023-11-14 08:23:50.762 DEBUG (SyncWorker_7) [custom_components.fordpass.fordpass_new] Response from URL was invalid 2023-11-14 08:23:50.762 DEBUG (SyncWorker_7) [custom_components.fordpass.fordpass_new] New System 2023-11-14 08:23:50.762 DEBUG (SyncWorker_7) [custom_components.fordpass.fordpass_new] 5 2023-11-14 08:23:50.762 DEBUG (SyncWorker_7) [custom_components.fordpass.fordpass_new] Running Step1 2023-11-14 08:23:50.833 DEBUG (SyncWorker_3) [custom_components.fordpass.fordpass_new] Incorrect response from URL 2023-11-14 08:23:50.833 DEBUG (SyncWorker_3) [custom_components.fordpass.fordpass_new] Step 1 Exception 2023-11-14 08:23:50.833 DEBUG (SyncWorker_3) [custom_components.fordpass.fordpass_new] Response from URL was invalid 2023-11-14 08:23:50.833 DEBUG (SyncWorker_3) [custom_components.fordpass.fordpass_new] New System 2023-11-14 08:23:50.833 DEBUG (SyncWorker_3) [custom_components.fordpass.fordpass_new] 6 2023-11-14 08:23:50.833 DEBUG (SyncWorker_3) [custom_components.fordpass.fordpass_new] Running Step1 2023-11-14 08:23:50.875 DEBUG (SyncWorker_7) [custom_components.fordpass.fordpass_new] Incorrect response from URL 2023-11-14 08:23:50.875 DEBUG (SyncWorker_7) [custom_components.fordpass.fordpass_new] Step 1 Exception 2023-11-14 08:23:50.875 DEBUG (SyncWorker_7) [custom_components.fordpass.fordpass_new] Response from URL was invalid 2023-11-14 08:23:50.875 DEBUG (SyncWorker_7) [custom_components.fordpass.fordpass_new] New System 2023-11-14 08:23:50.875 DEBUG (SyncWorker_7) [custom_components.fordpass.fordpass_new] 6 2023-11-14 08:23:50.875 DEBUG (SyncWorker_7) [custom_components.fordpass.fordpass_new] Running Step1 2023-11-14 08:23:50.918 DEBUG (SyncWorker_3) [custom_components.fordpass.fordpass_new] Incorrect response from URL 2023-11-14 08:23:50.918 DEBUG (SyncWorker_3) [custom_components.fordpass.fordpass_new] Step 1 Exception 2023-11-14 08:23:50.918 DEBUG (SyncWorker_3) [custom_components.fordpass.fordpass_new] Response from URL was invalid 2023-11-14 08:23:50.918 DEBUG (SyncWorker_3) [custom_components.fordpass.fordpass_new] New System 2023-11-14 08:23:50.918 DEBUG (SyncWorker_3) [custom_components.fordpass.fordpass_new] 7 2023-11-14 08:23:50.918 DEBUG (SyncWorker_3) [custom_components.fordpass.fordpass_new] Running Step1 2023-11-14 08:23:50.956 DEBUG (SyncWorker_7) [custom_components.fordpass.fordpass_new] Incorrect response from URL 2023-11-14 08:23:50.957 DEBUG (SyncWorker_7) [custom_components.fordpass.fordpass_new] Step 1 Exception 2023-11-14 08:23:50.957 DEBUG (SyncWorker_7) [custom_components.fordpass.fordpass_new] Response from URL was invalid 2023-11-14 08:23:50.957 DEBUG (SyncWorker_7) [custom_components.fordpass.fordpass_new] New System 2023-11-14 08:23:50.957 DEBUG (SyncWorker_7) [custom_components.fordpass.fordpass_new] 7 2023-11-14 08:23:50.957 DEBUG (SyncWorker_7) [custom_components.fordpass.fordpass_new] Running Step1 2023-11-14 08:23:50.999 DEBUG (SyncWorker_3) [custom_components.fordpass.fordpass_new] Incorrect response from URL 2023-11-14 08:23:50.999 DEBUG (SyncWorker_3) [custom_components.fordpass.fordpass_new] Step 1 Exception 2023-11-14 08:23:50.999 DEBUG (SyncWorker_3) [custom_components.fordpass.fordpass_new] Response from URL was invalid 2023-11-14 08:23:50.999 DEBUG (SyncWorker_3) [custom_components.fordpass.fordpass_new] New System 2023-11-14 08:23:51.000 DEBUG (SyncWorker_3) [custom_components.fordpass.fordpass_new] 8 2023-11-14 08:23:51.000 DEBUG (SyncWorker_3) [custom_components.fordpass.fordpass_new] Running Step1 2023-11-14 08:23:51.054 DEBUG (SyncWorker_7) [custom_components.fordpass.fordpass_new] Incorrect response from URL 2023-11-14 08:23:51.054 DEBUG (SyncWorker_7) [custom_components.fordpass.fordpass_new] Step 1 Exception 2023-11-14 08:23:51.054 DEBUG (SyncWorker_7) [custom_components.fordpass.fordpass_new] Response from URL was invalid 2023-11-14 08:23:51.054 DEBUG (SyncWorker_7) [custom_components.fordpass.fordpass_new] New System 2023-11-14 08:23:51.054 DEBUG (SyncWorker_7) [custom_components.fordpass.fordpass_new] 8 2023-11-14 08:23:51.054 DEBUG (SyncWorker_7) [custom_components.fordpass.fordpass_new] Running Step1 2023-11-14 08:23:51.079 DEBUG (SyncWorker_3) [custom_components.fordpass.fordpass_new] Incorrect response from URL 2023-11-14 08:23:51.079 DEBUG (SyncWorker_3) [custom_components.fordpass.fordpass_new] Step 1 Exception 2023-11-14 08:23:51.079 DEBUG (SyncWorker_3) [custom_components.fordpass.fordpass_new] Response from URL was invalid 2023-11-14 08:23:51.079 DEBUG (SyncWorker_3) [custom_components.fordpass.fordpass_new] New System 2023-11-14 08:23:51.079 DEBUG (SyncWorker_3) [custom_components.fordpass.fordpass_new] 9 2023-11-14 08:23:51.079 DEBUG (SyncWorker_3) [custom_components.fordpass.fordpass_new] Running Step1 2023-11-14 08:23:51.135 DEBUG (SyncWorker_7) [custom_components.fordpass.fordpass_new] Incorrect response from URL 2023-11-14 08:23:51.135 DEBUG (SyncWorker_7) [custom_components.fordpass.fordpass_new] Step 1 Exception 2023-11-14 08:23:51.135 DEBUG (SyncWorker_7) [custom_components.fordpass.fordpass_new] Response from URL was invalid 2023-11-14 08:23:51.135 DEBUG (SyncWorker_7) [custom_components.fordpass.fordpass_new] New System 2023-11-14 08:23:51.135 DEBUG (SyncWorker_7) [custom_components.fordpass.fordpass_new] 9 2023-11-14 08:23:51.135 DEBUG (SyncWorker_7) [custom_components.fordpass.fordpass_new] Running Step1 2023-11-14 08:23:51.155 DEBUG (SyncWorker_3) [custom_components.fordpass.fordpass_new] Incorrect response from URL 2023-11-14 08:23:51.155 DEBUG (SyncWorker_3) [custom_components.fordpass.fordpass_new] Step 1 Exception 2023-11-14 08:23:51.155 DEBUG (SyncWorker_3) [custom_components.fordpass.fordpass_new] Response from URL was invalid 2023-11-14 08:23:51.155 DEBUG (SyncWorker_3) [custom_components.fordpass.fordpass_new] New System 2023-11-14 08:23:51.155 DEBUG (SyncWorker_3) [custom_components.fordpass.fordpass_new] 10 2023-11-14 08:23:51.155 DEBUG (SyncWorker_3) [custom_components.fordpass.fordpass_new] Running Step1 2023-11-14 08:23:51.321 DEBUG (SyncWorker_7) [custom_components.fordpass.fordpass_new] Incorrect response from URL 2023-11-14 08:23:51.321 DEBUG (SyncWorker_7) [custom_components.fordpass.fordpass_new] Step 1 Exception 2023-11-14 08:23:51.321 DEBUG (SyncWorker_7) [custom_components.fordpass.fordpass_new] Response from URL was invalid 2023-11-14 08:23:51.321 DEBUG (SyncWorker_7) [custom_components.fordpass.fordpass_new] New System 2023-11-14 08:23:51.321 DEBUG (SyncWorker_7) [custom_components.fordpass.fordpass_new] 10 2023-11-14 08:23:51.321 DEBUG (SyncWorker_7) [custom_components.fordpass.fordpass_new] Running Step1 2023-11-14 08:23:51.330 DEBUG (SyncWorker_3) [custom_components.fordpass.fordpass_new] Incorrect response from URL 2023-11-14 08:23:51.330 DEBUG (SyncWorker_3) [custom_components.fordpass.fordpass_new] Step 1 Exception 2023-11-14 08:23:51.330 DEBUG (SyncWorker_3) [custom_components.fordpass.fordpass_new] Response from URL was invalid 2023-11-14 08:23:51.403 WARNING (MainThread) [custom_components.fordpass] Step 1 has reached error limit 2023-11-14 08:23:51.403 WARNING (MainThread) [custom_components.fordpass] Error communicating with FordPass for <MACH-E VIN> 2023-11-14 08:23:51.403 WARNING (MainThread) [custom_components.fordpass] Returning Stale data to prevent unavaliable status 2023-11-14 08:23:51.403 ERROR (MainThread) [custom_components.fordpass] Error fetching fordpass data: Error communicating with FordPass for <MACH-E VIN> 2023-11-14 08:23:51.403 DEBUG (MainThread) [custom_components.fordpass] Finished fetching fordpass data in 1.371 seconds (success: False) 2023-11-14 08:23:51.410 DEBUG (SyncWorker_7) [custom_components.fordpass.fordpass_new] Incorrect response from URL 2023-11-14 08:23:51.410 DEBUG (SyncWorker_7) [custom_components.fordpass.fordpass_new] Step 1 Exception 2023-11-14 08:23:51.410 DEBUG (SyncWorker_7) [custom_components.fordpass.fordpass_new] Response from URL was invalid 2023-11-14 08:23:51.418 WARNING (MainThread) [custom_components.fordpass] Step 1 has reached error limit 2023-11-14 08:23:51.418 WARNING (MainThread) [custom_components.fordpass] Error communicating with FordPass for <F150 VIN> 2023-11-14 08:23:51.418 WARNING (MainThread) [custom_components.fordpass] Returning Stale data to prevent unavaliable status 2023-11-14 08:23:51.418 ERROR (MainThread) [custom_components.fordpass] Error fetching fordpass data: Error communicating with FordPass for <F150 VIN> 2023-11-14 08:23:51.418 DEBUG (MainThread) [custom_components.fordpass] Finished fetching fordpass data in 1.386 seconds (success: False)

I have not yet deleted either vehicle (because that's a PIA for renaming to my system), but if I attempt to add a new vehicle using my FordPass account, it indicates the credentials are invalid, but with no other details. If I visit ford.com and login with those credentials, they authenticate without issue. Note this is a second FordPass Account setup for my vehicles that I use just for accessing them via HA in case Ford decides to block access due to attempts or something...luckily that doesn't look like the case.

Is this the same issue or do I need open a new ticket?

[tcc0]

For what it's worth;

Running 1.63 Beta 1 since 14:03 and still able to lock, update, etc without errors, it's 16:41 now. Will keep you posted if it fails or continue to work.

Thanks for your time

[tcc0]

Still work ing without a single hickup, very stable for me 👌🏼

[MartyTremblay]

Same here. Solid as a rock for the past 2 days!

[SquidBytes]

Looks like this was resolved at the time. Thins may have changed due to recent issues - but for now I'm going to close this specific issue