TEST-ping_topic_test-20240503194217.xml

Test Report : TEST-ping_topic_test-20240503194217.xml

ping_topic_test
- test

Test Suite: ping_topic_test-20240503194217

Results

Duration	4.057 sec
Tests	1
Failures	0

Tests

ping_topic_test

Test case:	test
Outcome:	Passed
Duration:	4.057 sec
Failed	None

None

Suite stdout:

[1714765337096] [INFO] DEV-3996365522 Device 3996365522 (type: 1) has been created [1714765337097] [INFO] FW-UPD Initialized [1714765337097] [DBG] FW-UPD enter <function device_base.set_hub at 0x7f55bdbf8680> (<uclient.hub.HUB object at 0x7f55bda74950>,) [1714765337097] [DBG] FW-UPD exit <function device_base.set_hub at 0x7f55bdbf8680> ret: None [1714765337097] [DBG] HUB enter <function HUB.register_root_cb at 0x7f55bdbfa700> ('>user/dev', <bound method user_device.on_user_dev of <uclient.fwupd.fwupd_device object at 0x7f55bdd2aad0>>) [1714765337097] [DBG] HUB exit <function HUB.register_root_cb at 0x7f55bdbfa700> ret: None [1714765337097] [DBG] MQTT enter <function mqtt_transport.set_lastwill at 0x7f55bde02fc0> ('<48:3f:da:55:07:5c/status', '-1') [1714765337097] [DBG] MQTT exit <function mqtt_transport.set_lastwill at 0x7f55bde02fc0> ret: None [1714765337097] [DBG] MQTT enter <function mqtt_transport.on_connect at 0x7f55bde02d40> (<bound method log.dbg_wr.<locals>.wrapper of <uclient.hub.HUB object at 0x7f55bda74950>>,) [1714765337097] [DBG] MQTT exit <function mqtt_transport.on_connect at 0x7f55bde02d40> ret: None [1714765337097] [DBG] MQTT enter <function mqtt_transport.on_disconnect at 0x7f55bde02e80> (<bound method log.dbg_wr.<locals>.wrapper of <uclient.hub.HUB object at 0x7f55bda74950>>,) [1714765337097] [DBG] MQTT exit <function mqtt_transport.on_disconnect at 0x7f55bde02e80> ret: None [1714765337097] [DBG] HUB enter <function HUB.connect at 0x7f55bdbfafc0> () [1714765337097] [WARN] HUB Try to connect without uri-schema [1714765337097] [DBG] MQTT enter <function mqtt_transport.connect at 0x7f55bde02700> ('x.ks.ua',) [1714765338102] [DBG] HUB enter <function HUB.__on_connect at 0x7f55bdbfa0c0> () [1714765338102] [INFO] HUB Connected [1714765338102] [DBG] MQTT enter <function mqtt_transport.subscribe at 0x7f55bde02980> ('>hub', <bound method log.dbg_wr.<locals>.wrapper of <uclient.hub.HUB object at 0x7f55bda74950>>) [1714765338102] [DBG] MQTT exit <function mqtt_transport.subscribe at 0x7f55bde02980> ret: None [1714765338102] [DBG] MQTT enter <function mqtt_transport.subscribe at 0x7f55bde02980> ('>user/dev', <bound method log.dbg_wr.<locals>.wrapper of <uclient.hub.HUB object at 0x7f55bda74950>>) [1714765338102] [DBG] MQTT exit <function mqtt_transport.subscribe at 0x7f55bde02980> ret: None [1714765338102] [DBG] HUB enter <function HUB.subscribe_hub at 0x7f55bdbf9800> ('time', '/') [1714765338102] [INFO] HUB (HUB) Subscribe to : {topic: /48:3f:da:55:07:5c/time } [1714765338102] [DBG] MQTT enter <function mqtt_transport.subscribe at 0x7f55bde02980> ('/48:3f:da:55:07:5c/time', <bound method log.dbg_wr.<locals>.wrapper of <uclient.hub.HUB object at 0x7f55bda74950>>) [1714765338102] [DBG] MQTT exit <function mqtt_transport.subscribe at 0x7f55bde02980> ret: None [1714765338102] [DBG] HUB exit <function HUB.subscribe_hub at 0x7f55bdbf9800> ret: None [1714765338102] [DBG] HUB enter <function HUB.subscribe_hub at 0x7f55bdbf9800> ('lifetime', '>') [1714765338102] [INFO] HUB (HUB) Subscribe to : {topic: >48:3f:da:55:07:5c/lifetime } [1714765338102] [DBG] MQTT enter <function mqtt_transport.subscribe at 0x7f55bde02980> ('>48:3f:da:55:07:5c/lifetime', <bound method log.dbg_wr.<locals>.wrapper of <uclient.hub.HUB object at 0x7f55bda74950>>) [1714765338102] [DBG] MQTT exit <function mqtt_transport.subscribe at 0x7f55bde02980> ret: None [1714765338102] [DBG] HUB exit <function HUB.subscribe_hub at 0x7f55bdbf9800> ret: None [1714765338102] [DBG] HUB enter <function HUB.subscribe_hub at 0x7f55bdbf9800> ('error', '>') [1714765338102] [INFO] HUB (HUB) Subscribe to : {topic: >48:3f:da:55:07:5c/error } [1714765338102] [DBG] MQTT enter <function mqtt_transport.subscribe at 0x7f55bde02980> ('>48:3f:da:55:07:5c/error', <bound method log.dbg_wr.<locals>.wrapper of <uclient.hub.HUB object at 0x7f55bda74950>>) [1714765338102] [DBG] MQTT exit <function mqtt_transport.subscribe at 0x7f55bde02980> ret: None [1714765338102] [DBG] HUB exit <function HUB.subscribe_hub at 0x7f55bdbf9800> ret: None [1714765338102] [DBG] HUB enter <function HUB.subscribe_hub at 0x7f55bdbf9800> ('ping', '>') [1714765338102] [INFO] HUB (HUB) Subscribe to : {topic: >48:3f:da:55:07:5c/ping } [1714765338102] [DBG] MQTT enter <function mqtt_transport.subscribe at 0x7f55bde02980> ('>48:3f:da:55:07:5c/ping', <bound method log.dbg_wr.<locals>.wrapper of <uclient.hub.HUB object at 0x7f55bda74950>>) [1714765338102] [DBG] MQTT exit <function mqtt_transport.subscribe at 0x7f55bde02980> ret: None [1714765338102] [DBG] HUB exit <function HUB.subscribe_hub at 0x7f55bdbf9800> ret: None [1714765338102] [DBG] HUB enter <function HUB.subscribe_hub at 0x7f55bdbf9800> ('version', '>') [1714765338102] [INFO] HUB (HUB) Subscribe to : {topic: >48:3f:da:55:07:5c/version } [1714765338102] [DBG] MQTT enter <function mqtt_transport.subscribe at 0x7f55bde02980> ('>48:3f:da:55:07:5c/version', <bound method log.dbg_wr.<locals>.wrapper of <uclient.hub.HUB object at 0x7f55bda74950>>) [1714765338103] [DBG] MQTT exit <function mqtt_transport.subscribe at 0x7f55bde02980> ret: None [1714765338103] [DBG] HUB exit <function HUB.subscribe_hub at 0x7f55bdbf9800> ret: None [1714765338103] [DBG] HUB exit <function HUB.__on_connect at 0x7f55bdbfa0c0> ret: None [1714765338103] [DBG] MQTT exit <function mqtt_transport.connect at 0x7f55bde02700> ret: None [1714765338103] [DBG] HUB exit <function HUB.connect at 0x7f55bdbfafc0> ret: None [1714765338113] [DBG] HUB Step, state: 0 (next: 1714765339113) [1714765338113] [DBG] HUB enter <function HUB.__send_reg at 0x7f55bdbf9f80> () [1714765338113] [INFO] HUB Publish reg token: 48:3f:da:55:07:5c [1714765338113] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f55bde02840> ('/reg', '48:3f:da:55:07:5c') [1714765338113] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f55bde02840> ret: None [1714765338113] [DBG] HUB exit <function HUB.__send_reg at 0x7f55bdbf9f80> ret: None [1714765339114] [DBG] HUB Step, state: 0 (next: 1714765340114) [1714765339114] [DBG] HUB enter <function HUB.__send_reg at 0x7f55bdbf9f80> () [1714765339114] [INFO] HUB Publish reg token: 48:3f:da:55:07:5c [1714765339114] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f55bde02840> ('/reg', '48:3f:da:55:07:5c') [1714765339115] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f55bde02840> ret: None [1714765339115] [DBG] HUB exit <function HUB.__send_reg at 0x7f55bdbf9f80> ret: None [1714765339159] [DBG] HUB enter <function HUB.__on_message at 0x7f55bdbfa480> ('/48:3f:da:55:07:5c/time', b'1714765339158') [1714765339159] [INFO] HUB Message: {topic: /48:3f:da:55:07:5c/time, value: 1714765339158 } [1714765339159] [DBG] HUB enter <function HUB.__time_hnd at 0x7f55bdbf9940> ('1714765339158',) [1714765339159] [INFO] HUB Registration finish, time: 1714765339158 [1714765339159] [DBG] FW-UPD enter <function device_base.register at 0x7f55bdbf8b80> (1714765339,) [1714765339159] [INFO] FW-UPD Device 3996365522 registration on the server @ 1714765339 [1714765339159] [DBG] HUB enter <function HUB.subscribe_hub at 0x7f55bdbf9800> ('3996365522/#', '>') [1714765339159] [INFO] HUB (HUB) Subscribe to : {topic: >48:3f:da:55:07:5c/3996365522/# } [1714765339159] [DBG] MQTT enter <function mqtt_transport.subscribe at 0x7f55bde02980> ('>48:3f:da:55:07:5c/3996365522/#', <bound method log.dbg_wr.<locals>.wrapper of <uclient.hub.HUB object at 0x7f55bda74950>>) [1714765339160] [DBG] MQTT exit <function mqtt_transport.subscribe at 0x7f55bde02980> ret: None [1714765339160] [DBG] HUB exit <function HUB.subscribe_hub at 0x7f55bdbf9800> ret: None [1714765339160] [DBG] FW-UPD exit <function device_base.register at 0x7f55bdbf8b80> ret: None [1714765339160] [DBG] HUB exit <function HUB.__time_hnd at 0x7f55bdbf9940> ret: None [1714765339160] [DBG] HUB exit <function HUB.__on_message at 0x7f55bdbfa480> ret: None [1714765340115] [DBG] HUB Step, state: 1 (next: 1714765341115) [1714765340115] [DBG] FW-UPD enter <function device_base.info_req at 0x7f55bdbf9440> () [1714765340115] [DBG] FW-UPD exit <function device_base.info_req at 0x7f55bdbf9440> ret: {'s': 3996365522, 't': 1, 'r': {0: 3996365522, 1: 1714765339}} [1714765340117] [DBG] HUB enter <function HUB.pub_hub at 0x7f55bdbf96c0> ('info', '{"mac": "48:3f:da:55:07:5c", "version": "R240503;master;c2667ff72f2b1f6acb109be9b5c2675332675736", "type": "mpy", "prot": 2, "devices": [{"s": 3996365522, "t": 1, "r": {"0": 3996365522, "1": 1714765339}}]}', '/') [1714765340117] [INFO] HUB Publish message: { topic: info, value: {"mac": "48:3f:da:55:07:5c", "version": "R240503;master;c2667ff72f2b1f6acb109be9b5c2675332675736", "type": "mpy", "prot": 2, "devices": [{"s": 3996365522, "t": 1, "r": {"0": 3996365522, "1": 1714765339}}]} } [1714765340117] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f55bde02840> ('/48:3f:da:55:07:5c/info', '{"mac": "48:3f:da:55:07:5c", "version": "R240503;master;c2667ff72f2b1f6acb109be9b5c2675332675736", "type": "mpy", "prot": 2, "devices": [{"s": 3996365522, "t": 1, "r": {"0": 3996365522, "1": 1714765339}}]}') [1714765340117] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f55bde02840> ret: None [1714765340117] [DBG] HUB exit <function HUB.pub_hub at 0x7f55bdbf96c0> ret: None [1714765341141] [DBG] HUB enter <function HUB.__on_message at 0x7f55bdbfa480> ('>48:3f:da:55:07:5c/ping', b'ping') [1714765341141] [INFO] HUB Message: {topic: >48:3f:da:55:07:5c/ping, value: ping } [1714765341141] [DBG] HUB enter <function HUB.__ping_hnd at 0x7f55bdbf9d00> ('ping',) [1714765341141] [INFO] HUB Ping command [1714765341141] [DBG] HUB enter <function HUB.pub_hub at 0x7f55bdbf96c0> ('ping', 'OK') [1714765341141] [INFO] HUB Publish message: { topic: ping, value: OK } [1714765341141] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f55bde02840> ('<48:3f:da:55:07:5c/ping', 'OK') [1714765341142] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f55bde02840> ret: None [1714765341142] [DBG] HUB exit <function HUB.pub_hub at 0x7f55bdbf96c0> ret: None [1714765341142] [DBG] HUB exit <function HUB.__ping_hnd at 0x7f55bdbf9d00> ret: None [1714765341142] [DBG] HUB exit <function HUB.__on_message at 0x7f55bdbfa480> ret: None [1714765341152] [DBG] MQTT enter <function mqtt_transport.disconnect at 0x7f55bde02c00> () [1714765341152] [DBG] MQTT exit <function mqtt_transport.disconnect at 0x7f55bde02c00> ret: None

Suite stderr:

2024-05-03 19:42:20,127 - TEST - INFO - OP take: 2024.012 ms 2024-05-03 19:42:20,130 - TEST - INFO - Connected with result code: 0 2024-05-03 19:42:20,138 - TEST - INFO - OP take: 10.128 ms 2024-05-03 19:42:21,139 - TEST - INFO - [hub] => { 'ping' : 'ping' } 2024-05-03 19:42:21,151 - TEST - INFO - OP take: 10.203 ms 2024-05-03 19:42:21,152 - TEST - WARNING - Disconecting from broker