Test Report : TEST-last_will_test-20240505094754.xml
Test Suite: last_will_test-20240505094754
Results
| Duration | 4.071 sec |
| Tests | 1 |
| Failures | 0 |
Tests
last_will_test
| Test case: | test |
| Outcome: | Passed |
| Duration: | 4.071 sec |
| Failed | None |
None
Suite stdout:
[1714902474489] [INFO] DEV-3996365522 Device 3996365522 (type: 1) has been created
[1714902474490] [INFO] FW-UPD Initialized
[1714902474490] [DBG] FW-UPD enter <function device_base.set_hub at 0x7f20f65ebf60> (<uclient.hub.HUB object at 0x7f20f703aad0>,)
[1714902474490] [DBG] FW-UPD exit <function device_base.set_hub at 0x7f20f65ebf60> ret: None
[1714902474490] [DBG] HUB enter <function HUB.register_root_cb at 0x7f20f63e2020> ('>user/dev', <bound method user_device.on_user_dev of <uclient.fwupd.fwupd_device object at 0x7f20f64d5ed0>>)
[1714902474490] [DBG] HUB exit <function HUB.register_root_cb at 0x7f20f63e2020> ret: None
[1714902474490] [DBG] MQTT enter <function mqtt_transport.set_lastwill at 0x7f20f65ea980> ('<48:3f:da:55:07:5c/status', '-1')
[1714902474490] [DBG] MQTT exit <function mqtt_transport.set_lastwill at 0x7f20f65ea980> ret: None
[1714902474490] [DBG] MQTT enter <function mqtt_transport.on_connect at 0x7f20f65ea700> (<bound method log.dbg_wr.<locals>.wrapper of <uclient.hub.HUB object at 0x7f20f703aad0>>,)
[1714902474490] [DBG] MQTT exit <function mqtt_transport.on_connect at 0x7f20f65ea700> ret: None
[1714902474490] [DBG] MQTT enter <function mqtt_transport.on_disconnect at 0x7f20f65ea840> (<bound method log.dbg_wr.<locals>.wrapper of <uclient.hub.HUB object at 0x7f20f703aad0>>,)
[1714902474490] [DBG] MQTT exit <function mqtt_transport.on_disconnect at 0x7f20f65ea840> ret: None
[1714902474490] [DBG] HUB enter <function HUB.connect at 0x7f20f63e28e0> ()
[1714902474490] [WARN] HUB Try to connect without uri-schema
[1714902474490] [DBG] MQTT enter <function mqtt_transport.connect at 0x7f20f65ea0c0> ('x.ks.ua',)
[1714902475494] [DBG] HUB enter <function HUB.__on_connect at 0x7f20f63e19e0> ()
[1714902475494] [INFO] HUB Connected
[1714902475494] [DBG] MQTT enter <function mqtt_transport.subscribe at 0x7f20f65ea340> ('>hub', <bound method log.dbg_wr.<locals>.wrapper of <uclient.hub.HUB object at 0x7f20f703aad0>>)
[1714902475494] [DBG] MQTT exit <function mqtt_transport.subscribe at 0x7f20f65ea340> ret: None
[1714902475494] [DBG] MQTT enter <function mqtt_transport.subscribe at 0x7f20f65ea340> ('>user/dev', <bound method log.dbg_wr.<locals>.wrapper of <uclient.hub.HUB object at 0x7f20f703aad0>>)
[1714902475494] [DBG] MQTT exit <function mqtt_transport.subscribe at 0x7f20f65ea340> ret: None
[1714902475494] [DBG] HUB enter <function HUB.subscribe_hub at 0x7f20f63e1120> ('time', '/')
[1714902475494] [INFO] HUB (HUB) Subscribe to : {topic: /48:3f:da:55:07:5c/time }
[1714902475494] [DBG] MQTT enter <function mqtt_transport.subscribe at 0x7f20f65ea340> ('/48:3f:da:55:07:5c/time', <bound method log.dbg_wr.<locals>.wrapper of <uclient.hub.HUB object at 0x7f20f703aad0>>)
[1714902475494] [DBG] MQTT exit <function mqtt_transport.subscribe at 0x7f20f65ea340> ret: None
[1714902475494] [DBG] HUB exit <function HUB.subscribe_hub at 0x7f20f63e1120> ret: None
[1714902475494] [DBG] HUB enter <function HUB.subscribe_hub at 0x7f20f63e1120> ('lifetime', '>')
[1714902475494] [INFO] HUB (HUB) Subscribe to : {topic: >48:3f:da:55:07:5c/lifetime }
[1714902475494] [DBG] MQTT enter <function mqtt_transport.subscribe at 0x7f20f65ea340> ('>48:3f:da:55:07:5c/lifetime', <bound method log.dbg_wr.<locals>.wrapper of <uclient.hub.HUB object at 0x7f20f703aad0>>)
[1714902475494] [DBG] MQTT exit <function mqtt_transport.subscribe at 0x7f20f65ea340> ret: None
[1714902475494] [DBG] HUB exit <function HUB.subscribe_hub at 0x7f20f63e1120> ret: None
[1714902475495] [DBG] HUB enter <function HUB.subscribe_hub at 0x7f20f63e1120> ('error', '>')
[1714902475495] [INFO] HUB (HUB) Subscribe to : {topic: >48:3f:da:55:07:5c/error }
[1714902475495] [DBG] MQTT enter <function mqtt_transport.subscribe at 0x7f20f65ea340> ('>48:3f:da:55:07:5c/error', <bound method log.dbg_wr.<locals>.wrapper of <uclient.hub.HUB object at 0x7f20f703aad0>>)
[1714902475495] [DBG] MQTT exit <function mqtt_transport.subscribe at 0x7f20f65ea340> ret: None
[1714902475495] [DBG] HUB exit <function HUB.subscribe_hub at 0x7f20f63e1120> ret: None
[1714902475495] [DBG] HUB enter <function HUB.subscribe_hub at 0x7f20f63e1120> ('ping', '>')
[1714902475495] [INFO] HUB (HUB) Subscribe to : {topic: >48:3f:da:55:07:5c/ping }
[1714902475495] [DBG] MQTT enter <function mqtt_transport.subscribe at 0x7f20f65ea340> ('>48:3f:da:55:07:5c/ping', <bound method log.dbg_wr.<locals>.wrapper of <uclient.hub.HUB object at 0x7f20f703aad0>>)
[1714902475495] [DBG] MQTT exit <function mqtt_transport.subscribe at 0x7f20f65ea340> ret: None
[1714902475495] [DBG] HUB exit <function HUB.subscribe_hub at 0x7f20f63e1120> ret: None
[1714902475495] [DBG] HUB enter <function HUB.subscribe_hub at 0x7f20f63e1120> ('version', '>')
[1714902475495] [INFO] HUB (HUB) Subscribe to : {topic: >48:3f:da:55:07:5c/version }
[1714902475495] [DBG] MQTT enter <function mqtt_transport.subscribe at 0x7f20f65ea340> ('>48:3f:da:55:07:5c/version', <bound method log.dbg_wr.<locals>.wrapper of <uclient.hub.HUB object at 0x7f20f703aad0>>)
[1714902475495] [DBG] MQTT exit <function mqtt_transport.subscribe at 0x7f20f65ea340> ret: None
[1714902475495] [DBG] HUB exit <function HUB.subscribe_hub at 0x7f20f63e1120> ret: None
[1714902475495] [DBG] HUB exit <function HUB.__on_connect at 0x7f20f63e19e0> ret: None
[1714902475495] [DBG] MQTT exit <function mqtt_transport.connect at 0x7f20f65ea0c0> ret: None
[1714902475495] [DBG] HUB exit <function HUB.connect at 0x7f20f63e28e0> ret: None
[1714902475506] [DBG] HUB Step, state: 0 (next: 1714902476506)
[1714902475506] [DBG] HUB enter <function HUB.__send_reg at 0x7f20f63e18a0> ()
[1714902475506] [INFO] HUB Publish reg token: 48:3f:da:55:07:5c
[1714902475506] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f20f65ea200> ('/reg', '48:3f:da:55:07:5c')
[1714902475506] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f20f65ea200> ret: None
[1714902475506] [DBG] HUB exit <function HUB.__send_reg at 0x7f20f63e18a0> ret: None
[1714902476512] [DBG] HUB Step, state: 0 (next: 1714902477512)
[1714902476512] [DBG] HUB enter <function HUB.__send_reg at 0x7f20f63e18a0> ()
[1714902476512] [INFO] HUB Publish reg token: 48:3f:da:55:07:5c
[1714902476512] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f20f65ea200> ('/reg', '48:3f:da:55:07:5c')
[1714902476512] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f20f65ea200> ret: None
[1714902476512] [DBG] HUB exit <function HUB.__send_reg at 0x7f20f63e18a0> ret: None
[1714902476567] [DBG] HUB enter <function HUB.__on_message at 0x7f20f63e1da0> ('/48:3f:da:55:07:5c/time', b'1714902476566')
[1714902476567] [INFO] HUB Message: {topic: /48:3f:da:55:07:5c/time, value: 1714902476566 }
[1714902476567] [DBG] HUB enter <function HUB.__time_hnd at 0x7f20f63e1260> ('1714902476566',)
[1714902476567] [INFO] HUB Registration finish, time: 1714902476566
[1714902476567] [DBG] FW-UPD enter <function device_base.register at 0x7f20f63e04a0> (1714902476,)
[1714902476567] [INFO] FW-UPD Device 3996365522 registration on the server @ 1714902476
[1714902476567] [DBG] HUB enter <function HUB.subscribe_hub at 0x7f20f63e1120> ('3996365522/#', '>')
[1714902476567] [INFO] HUB (HUB) Subscribe to : {topic: >48:3f:da:55:07:5c/3996365522/# }
[1714902476567] [DBG] MQTT enter <function mqtt_transport.subscribe at 0x7f20f65ea340> ('>48:3f:da:55:07:5c/3996365522/#', <bound method log.dbg_wr.<locals>.wrapper of <uclient.hub.HUB object at 0x7f20f703aad0>>)
[1714902476567] [DBG] MQTT exit <function mqtt_transport.subscribe at 0x7f20f65ea340> ret: None
[1714902476567] [DBG] HUB exit <function HUB.subscribe_hub at 0x7f20f63e1120> ret: None
[1714902476567] [DBG] FW-UPD exit <function device_base.register at 0x7f20f63e04a0> ret: None
[1714902476567] [DBG] HUB exit <function HUB.__time_hnd at 0x7f20f63e1260> ret: None
[1714902476567] [DBG] HUB exit <function HUB.__on_message at 0x7f20f63e1da0> ret: None
[1714902477514] [DBG] HUB Step, state: 1 (next: 1714902478514)
[1714902477515] [DBG] FW-UPD enter <function device_base.info_req at 0x7f20f63e0d60> ()
[1714902477515] [DBG] FW-UPD exit <function device_base.info_req at 0x7f20f63e0d60> ret: {'s': 3996365522, 't': 1, 'r': {0: 3996365522, 1: 1714902476}}
[1714902477515] [DBG] HUB enter <function HUB.pub_hub at 0x7f20f63e0fe0> ('info', '{"mac": "48:3f:da:55:07:5c", "version": "R240505;master;1bc93cf09952cae1e1905f746731ac58c1190052", "type": "mpy", "prot": 2, "devices": [{"s": 3996365522, "t": 1, "r": {"0": 3996365522, "1": 1714902476}}]}', '/')
[1714902477515] [INFO] HUB Publish message: { topic: info, value: {"mac": "48:3f:da:55:07:5c", "version": "R240505;master;1bc93cf09952cae1e1905f746731ac58c1190052", "type": "mpy", "prot": 2, "devices": [{"s": 3996365522, "t": 1, "r": {"0": 3996365522, "1": 1714902476}}]} }
[1714902477515] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f20f65ea200> ('/48:3f:da:55:07:5c/info', '{"mac": "48:3f:da:55:07:5c", "version": "R240505;master;1bc93cf09952cae1e1905f746731ac58c1190052", "type": "mpy", "prot": 2, "devices": [{"s": 3996365522, "t": 1, "r": {"0": 3996365522, "1": 1714902476}}]}')
[1714902477516] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f20f65ea200> ret: None
[1714902477516] [DBG] HUB exit <function HUB.pub_hub at 0x7f20f63e0fe0> ret: None
Suite stderr:
2024-05-05 09:47:57,535 - TEST - INFO - OP take: 2038.927 ms
2024-05-05 09:47:57,539 - TEST - INFO - Connected with result code: 0
2024-05-05 09:47:57,546 - TEST - INFO - OP take: 10.098 ms
File "/actions-runner/_work/esp32-mpy-uclient/esp32-mpy-uclient/tests/test_tpl.py", line 85, in _ucl_step_thread
self._uclient.step()
File "/actions-runner/_work/esp32-mpy-uclient/esp32-mpy-uclient/src/uclient/hub.py", line 260, in step
self.client.step()
File "/actions-runner/_work/esp32-mpy-uclient/esp32-mpy-uclient/src/uclient/mqtt_transport.py", line 149, in step
self.client.check_msg()
File "/actions-runner/_work/esp32-mpy-uclient/esp32-mpy-uclient/src/net/mqtt.py", line 255, in check_msg
return self.wait_msg()
^^^^^^^^^^^^^^^
File "/actions-runner/_work/esp32-mpy-uclient/esp32-mpy-uclient/src/net/mqtt.py", line 182, in wait_msg
sock, _, _ = select.select((self.sock,),(),(), 0.01)
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
2024-05-05 09:47:58,557 - TEST - INFO - OP take: 10.291 ms
2024-05-05 09:47:58,558 - TEST - WARNING - Disconecting from broker
2024-05-05 09:47:58,567 - TEST - WARNING - Disconecting from broker
2024-05-05 09:47:58,572 - TEST - INFO - Connected with result code: 0