Délai entre commande et execution

Bonjour,

Je vois un délai entre le moment où une commande est actionnée (via l’interface) et l’action au niveau de somfy, quelqu’un a une idée sur le sujet?

Voici le log:

[2024-09-28 17:07:03] DEBUG  : +- Method: SomfyUnified\UnifiedAPI::sendActionToOverkizAPI($serverName: somfy_developer_mode - $arguments (json_encode): {"apiAction":"get_setup","importDataAsJson":true})
[2024-09-28 17:07:03] DEBUG  : +- Method: SomfyUnified\GetFileContent::fileGetContents - Succeeded to read file (/var/www/html/plugins/SomfyUnified/userData/localAuth/authTokens_xxxxxxxxxxxxxx.json)
[2024-09-28 17:07:10] INFO  : |Un| [serv11] action: execute_commands - result[0] = "2beeb905-434f-4298-9798-b1c2d1d11f0a"
[2024-09-28 17:07:10] DEBUG  : |Un| Command exec() executed - Output= not empty - Exit code= 0 -> Command executed successfully
[2024-09-28 17:07:10] INFO  : ..........
[2024-09-28 17:07:10] INFO  : Execute Cmd: serv11 - {"label":"setClosure","actions":[{"commands":[{"name":"setClosure","parameters":[40]}],"deviceURL":"io:\/\/xxxxxxxxxxxxxx\/5485159"}]}
[2024-09-28 17:07:10] INFO  : executionId: 2beeb905-434f-4298-9798-b1c2d1d11f0a
[2024-09-28 17:07:10] INFO  : ..........
[2024-09-28 17:07:11] DEBUG  : |INC| Succeeded to load SomfyUnified\UtilsLib
[2024-09-28 17:07:11] INFO  : |Re| Message from OverkizApi received in PHP (json_encode): {"server":"somfy_developer_mode","events":"[{\"name\": \"ExecutionRegisteredEvent\", \"timestamp\": null, \"setupoid\": \"<<non-serializable: _CountingAttr>>\", \"owner_key\": null, \"type\": null, \"sub_type\": null, \"time_to_next_state\": null, \"failed_commands\": [], \"failure_type_code\": null, \"failure_type\": null, \"condition_groupoid\": null, \"place_oid\": null, \"label\": null, \"metadata\": null, \"camera_id\": null, \"deleted_raw_devices_count\": null, \"protocol_type\": null, \"gateway_id\": null, \"exec_id\": \"2beeb905-434f-4298-9798-b1c2d1d11f0a\", \"device_url\": null, \"device_states\": [], \"old_state\": null, \"new_state\": null}, {\"name\": \"ExecutionStateChangedEvent\", \"timestamp\": null, \"setupoid\": \"<<non-serializable: _CountingAttr>>\", \"owner_key\": null, \"type\": null, \"sub_type\": null, \"time_to_next_state\": null, \"failed_commands\": [], \"failure_type_code\": null, \"failure_type\": null, \"condition_groupoid\": null, \"place_oid\": null, \"label\": null, \"metadata\": null, \"camera_id\": null, \"deleted_raw_devices_count\": null, \"protocol_type\": null, \"gateway_id\": null, \"exec_id\": \"2beeb905-434f-4298-9798-b1c2d1d11f0a\", \"device_url\": null, \"device_states\": [], \"old_state\": \"INITIALIZED\", \"new_state\": \"IN_PROGRESS\"}]"}
[2024-09-28 17:07:11] DEBUG  : |INC| Succeeded to load SomfyUnified\SupportedServers
[2024-09-28 17:07:11] DEBUG  : + Method: SomfyUnified::manageEvents ($serverIdent (json_encode): "serv11" $events: Array)
[2024-09-28 17:07:11] DEBUG  : +
[2024-09-28 17:07:11] DEBUG  : event[serv11][0][name]= "ExecutionRegisteredEvent"
[2024-09-28 17:07:11] DEBUG  : event[serv11][0][timestamp]= null
[2024-09-28 17:07:11] DEBUG  : event[serv11][0][setupoid]="<<non-serializable: _CountingAttr>>"
[2024-09-28 17:07:11] DEBUG  : event[serv11][0][owner_key]= null
[2024-09-28 17:07:11] DEBUG  : event[serv11][0][type]= null
[2024-09-28 17:07:11] DEBUG  : event[serv11][0][sub_type]= null
[2024-09-28 17:07:11] DEBUG  : event[serv11][0][time_to_next_state]= null
[2024-09-28 17:07:11] DEBUG  : event[serv11][0][failed_commands]= []
[2024-09-28 17:07:11] DEBUG  : event[serv11][0][failure_type_code]= null
[2024-09-28 17:07:11] DEBUG  : event[serv11][0][failure_type]= null
[2024-09-28 17:07:11] DEBUG  : event[serv11][0][condition_groupoid]= null
[2024-09-28 17:07:11] DEBUG  : event[serv11][0][place_oid]= null
[2024-09-28 17:07:11] DEBUG  : event[serv11][0][label]= null
[2024-09-28 17:07:11] DEBUG  : event[serv11][0][metadata]= null
[2024-09-28 17:07:11] DEBUG  : event[serv11][0][camera_id]= null
[2024-09-28 17:07:11] DEBUG  : event[serv11][0][deleted_raw_devices_count]= null
[2024-09-28 17:07:11] DEBUG  : event[serv11][0][protocol_type]= null
[2024-09-28 17:07:11] DEBUG  : event[serv11][0][gateway_id]= null
[2024-09-28 17:07:11] DEBUG  : event[serv11][0][exec_id]= "2beeb905-434f-4298-9798-b1c2d1d11f0a"
[2024-09-28 17:07:11] DEBUG  : event[serv11][0][device_url]= null
[2024-09-28 17:07:11] DEBUG  : event[serv11][0][device_states]= []
[2024-09-28 17:07:11] DEBUG  : event[serv11][0][old_state]= null
[2024-09-28 17:07:11] DEBUG  : event[serv11][0][new_state]= null
[2024-09-28 17:07:11] INFO  : |
[2024-09-28 17:07:11] INFO  : |*** event[serv11][0][name]= "ExecutionRegisteredEvent"
[2024-09-28 17:07:11] INFO  : |    event[serv11][0][timestamp]= null
[2024-09-28 17:07:11] INFO  : |    event[serv11][0][setupoid]= "<<non-serializable: _CountingAttr>>"
[2024-09-28 17:07:11] INFO  : |    event[serv11][0][type]= null
[2024-09-28 17:07:11] INFO  : |    event[serv11][0][sub_type]= null
[2024-09-28 17:07:11] INFO  : |    event[serv11][0][label]= null
[2024-09-28 17:07:11] INFO  : |    event[serv11][0][exec_id]= "2beeb905-434f-4298-9798-b1c2d1d11f0a"
[2024-09-28 17:07:11] DEBUG  : +
[2024-09-28 17:07:11] DEBUG  : event[serv11][1][name]= "ExecutionStateChangedEvent"
[2024-09-28 17:07:11] DEBUG  : event[serv11][1][timestamp]= null
[2024-09-28 17:07:11] DEBUG  : event[serv11][1][setupoid]="<<non-serializable: _CountingAttr>>"
[2024-09-28 17:07:11] DEBUG  : event[serv11][1][owner_key]= null
[2024-09-28 17:07:11] DEBUG  : event[serv11][1][type]= null
[2024-09-28 17:07:11] DEBUG  : event[serv11][1][sub_type]= null
[2024-09-28 17:07:11] DEBUG  : event[serv11][1][time_to_next_state]= null
[2024-09-28 17:07:11] DEBUG  : event[serv11][1][failed_commands]= []
[2024-09-28 17:07:11] DEBUG  : event[serv11][1][failure_type_code]= null
[2024-09-28 17:07:11] DEBUG  : event[serv11][1][failure_type]= null
[2024-09-28 17:07:11] DEBUG  : event[serv11][1][condition_groupoid]= null
[2024-09-28 17:07:11] DEBUG  : event[serv11][1][place_oid]= null
[2024-09-28 17:07:11] DEBUG  : event[serv11][1][label]= null
[2024-09-28 17:07:11] DEBUG  : event[serv11][1][metadata]= null
[2024-09-28 17:07:11] DEBUG  : event[serv11][1][camera_id]= null
[2024-09-28 17:07:11] DEBUG  : event[serv11][1][deleted_raw_devices_count]= null
[2024-09-28 17:07:11] DEBUG  : event[serv11][1][protocol_type]= null
[2024-09-28 17:07:11] DEBUG  : event[serv11][1][gateway_id]= null
[2024-09-28 17:07:11] DEBUG  : event[serv11][1][exec_id]= "2beeb905-434f-4298-9798-b1c2d1d11f0a"
[2024-09-28 17:07:11] DEBUG  : event[serv11][1][device_url]= null
[2024-09-28 17:07:11] DEBUG  : event[serv11][1][device_states]= []
[2024-09-28 17:07:11] DEBUG  : event[serv11][1][old_state]= "INITIALIZED"
[2024-09-28 17:07:11] DEBUG  : event[serv11][1][new_state]= "IN_PROGRESS"
[2024-09-28 17:07:11] INFO  : |
[2024-09-28 17:07:11] INFO  : |*** event[serv11][1][name]= "ExecutionStateChangedEvent"
[2024-09-28 17:07:11] INFO  : |    event[serv11][1][timestamp]= null
[2024-09-28 17:07:11] INFO  : |    event[serv11][1][setupoid]= "<<non-serializable: _CountingAttr>>"
[2024-09-28 17:07:11] INFO  : |    event[serv11][1][owner_key]= null
[2024-09-28 17:07:11] INFO  : |    event[serv11][1][type]= null
[2024-09-28 17:07:11] INFO  : |    event[serv11][1][sub_type]= null
[2024-09-28 17:07:11] INFO  : |    event[serv11][1][time_to_next_state]= null
[2024-09-28 17:07:11] INFO  : |    event[serv11][1][failed_commands][0][rank]= null
[2024-09-28 17:07:11] INFO  : |    event[serv11][1][failed_commands][0][device_url]= null
[2024-09-28 17:07:11] INFO  : |    event[serv11][1][failed_commands][0][failure_type]= null
[2024-09-28 17:07:11] INFO  : |    event[serv11][1][failure_type_code]= null
[2024-09-28 17:07:11] INFO  : |    event[serv11][1][failure_type]= null
[2024-09-28 17:07:11] INFO  : |    event[serv11][1][exec_id]= "2beeb905-434f-4298-9798-b1c2d1d11f0a"
[2024-09-28 17:07:11] INFO  : |    event[serv11][1][old_state]= "INITIALIZED"
[2024-09-28 17:07:11] INFO  : |    event[serv11][1][new_state]= "IN_PROGRESS"
[2024-09-28 17:07:11] INFO  : |

comme vous le voyez sur les logs il y a rien qui se passe entre 17:08:03 et 17:07:11

Merci d’avance


Informations Jeedom

Core : 4.4.17 (master)
DNS Jeedom : non

Plugin : SomfyUnified
Version : 2024-09-24 21:49:37 (stable)
Statut Démon : Démarré - (2024-09-28 17:05:31)

On peut voir la page santé

Je peux prendre un screenshot, mais c’est tout vert!

Ce n’est pas la couleur qui intéresse, mais bien les informations que cela contient !

Hulk tout vert aussi… C’est pas pour autant que tout allait bien

2 « J'aime »

Le voici:


Bonjour,

Eh bien désolé, non, je ne vois rien car les Logs fournis commencent et s’arrêtent à 17:07:11 …
Ce n’est pas ce que l’on peut appeler un intervalle de temps !!!

Si vous voulez que l’on essaye de comprendre ce qui se passe, il faut fournir des informations solides.
Le Log complet entre l’instant ou la commande est lancée et l’instant ou l’action est complètement terminée.

Merci

Bonjour,

Merci, je vais vous fournir l’entièreté des logs entre le lancement de la commande et le moment où les volets se mettent en action.

Bonne fin de journée

Après analyse des derniers Logs que vous m’avez transmis en MP et dans lesquels vous avez lancé 2 commandes, il apparait clairement qu’il existe un délai d’environ 20 secondes entre le moment ou la commande est envoyée à votre box et le moment ou elle retourne une réponse OK à cette commande.

Le plugin ne fait aucune intervention entre ces 2 instants.

Ce délai que je ne peux expliquer de mon coté est du au fonctionnement (ou mauvais fonctionnement) de votre box pour une raison que j’ignore.

Cela explique probablement aussi pourquoi vous m’aviez déja signalé le même soucis en utilisant un autre plugin.

Je vous remercie pour cette analyse et les précisions apportées, je ne saurais l’expliquer. Je vais devoir chercher ailleurs pour trouver une solution car via l’application TaHoma il n’y a aucun délai, je vais analyser le trafic réseau dans un premier temps et ensuite peut-être attaquer l’api en direct.

En tout cas merci et bonne soirée à vous

Ce sujet a été automatiquement fermé après 24 heures suivant le dernier commentaire. Aucune réponse n’est permise dorénavant.