TEST-reg_value_exchange_test-20240505093619.xml

Test Report : TEST-reg_value_exchange_test-20240505093619.xml

reg_value_exchange_test
- test

Test Suite: reg_value_exchange_test-20240505093619

Results

Duration	6.229 sec
Tests	1
Failures	0

Tests

reg_value_exchange_test

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

None

Suite stdout:

[1714901779079] [INFO] DEV-3996365522 Device 3996365522 (type: 1) has been created [1714901779080] [INFO] FW-UPD Initialized [1714901779080] [DBG] FW-UPD enter <function device_base.set_hub at 0x7f38e93d4900> (<uclient.hub.HUB object at 0x7f38e9254e50>,) [1714901779080] [DBG] FW-UPD exit <function device_base.set_hub at 0x7f38e93d4900> ret: None [1714901779080] [DBG] HUB enter <function HUB.register_root_cb at 0x7f38e93d6980> ('>user/dev', <bound method user_device.on_user_dev of <uclient.fwupd.fwupd_device object at 0x7f38e9254d50>>) [1714901779080] [DBG] HUB exit <function HUB.register_root_cb at 0x7f38e93d6980> ret: None [1714901779080] [DBG] MQTT enter <function mqtt_transport.set_lastwill at 0x7f38e95e72e0> ('<48:3f:da:55:07:5c/status', '-1') [1714901779080] [DBG] MQTT exit <function mqtt_transport.set_lastwill at 0x7f38e95e72e0> ret: None [1714901779080] [DBG] MQTT enter <function mqtt_transport.on_connect at 0x7f38e95e7060> (<bound method log.dbg_wr.<locals>.wrapper of <uclient.hub.HUB object at 0x7f38e9254e50>>,) [1714901779080] [DBG] MQTT exit <function mqtt_transport.on_connect at 0x7f38e95e7060> ret: None [1714901779080] [DBG] MQTT enter <function mqtt_transport.on_disconnect at 0x7f38e95e71a0> (<bound method log.dbg_wr.<locals>.wrapper of <uclient.hub.HUB object at 0x7f38e9254e50>>,) [1714901779080] [DBG] MQTT exit <function mqtt_transport.on_disconnect at 0x7f38e95e71a0> ret: None [1714901779080] [DBG] HUB enter <function HUB.connect at 0x7f38e93d7240> () [1714901779080] [WARN] HUB Try to connect without uri-schema [1714901779080] [DBG] MQTT enter <function mqtt_transport.connect at 0x7f38e95e6a20> ('x.ks.ua',) [1714901780086] [DBG] HUB enter <function HUB.__on_connect at 0x7f38e93d6340> () [1714901780086] [INFO] HUB Connected [1714901780086] [DBG] MQTT enter <function mqtt_transport.subscribe at 0x7f38e95e6ca0> ('>hub', <bound method log.dbg_wr.<locals>.wrapper of <uclient.hub.HUB object at 0x7f38e9254e50>>) [1714901780086] [DBG] MQTT exit <function mqtt_transport.subscribe at 0x7f38e95e6ca0> ret: None [1714901780086] [DBG] MQTT enter <function mqtt_transport.subscribe at 0x7f38e95e6ca0> ('>user/dev', <bound method log.dbg_wr.<locals>.wrapper of <uclient.hub.HUB object at 0x7f38e9254e50>>) [1714901780086] [DBG] MQTT exit <function mqtt_transport.subscribe at 0x7f38e95e6ca0> ret: None [1714901780086] [DBG] HUB enter <function HUB.subscribe_hub at 0x7f38e93d5a80> ('time', '/') [1714901780086] [INFO] HUB (HUB) Subscribe to : {topic: /48:3f:da:55:07:5c/time } [1714901780086] [DBG] MQTT enter <function mqtt_transport.subscribe at 0x7f38e95e6ca0> ('/48:3f:da:55:07:5c/time', <bound method log.dbg_wr.<locals>.wrapper of <uclient.hub.HUB object at 0x7f38e9254e50>>) [1714901780087] [DBG] MQTT exit <function mqtt_transport.subscribe at 0x7f38e95e6ca0> ret: None [1714901780087] [DBG] HUB exit <function HUB.subscribe_hub at 0x7f38e93d5a80> ret: None [1714901780087] [DBG] HUB enter <function HUB.subscribe_hub at 0x7f38e93d5a80> ('lifetime', '>') [1714901780087] [INFO] HUB (HUB) Subscribe to : {topic: >48:3f:da:55:07:5c/lifetime } [1714901780087] [DBG] MQTT enter <function mqtt_transport.subscribe at 0x7f38e95e6ca0> ('>48:3f:da:55:07:5c/lifetime', <bound method log.dbg_wr.<locals>.wrapper of <uclient.hub.HUB object at 0x7f38e9254e50>>) [1714901780087] [DBG] MQTT exit <function mqtt_transport.subscribe at 0x7f38e95e6ca0> ret: None [1714901780087] [DBG] HUB exit <function HUB.subscribe_hub at 0x7f38e93d5a80> ret: None [1714901780087] [DBG] HUB enter <function HUB.subscribe_hub at 0x7f38e93d5a80> ('error', '>') [1714901780087] [INFO] HUB (HUB) Subscribe to : {topic: >48:3f:da:55:07:5c/error } [1714901780087] [DBG] MQTT enter <function mqtt_transport.subscribe at 0x7f38e95e6ca0> ('>48:3f:da:55:07:5c/error', <bound method log.dbg_wr.<locals>.wrapper of <uclient.hub.HUB object at 0x7f38e9254e50>>) [1714901780087] [DBG] MQTT exit <function mqtt_transport.subscribe at 0x7f38e95e6ca0> ret: None [1714901780087] [DBG] HUB exit <function HUB.subscribe_hub at 0x7f38e93d5a80> ret: None [1714901780087] [DBG] HUB enter <function HUB.subscribe_hub at 0x7f38e93d5a80> ('ping', '>') [1714901780087] [INFO] HUB (HUB) Subscribe to : {topic: >48:3f:da:55:07:5c/ping } [1714901780087] [DBG] MQTT enter <function mqtt_transport.subscribe at 0x7f38e95e6ca0> ('>48:3f:da:55:07:5c/ping', <bound method log.dbg_wr.<locals>.wrapper of <uclient.hub.HUB object at 0x7f38e9254e50>>) [1714901780087] [DBG] MQTT exit <function mqtt_transport.subscribe at 0x7f38e95e6ca0> ret: None [1714901780087] [DBG] HUB exit <function HUB.subscribe_hub at 0x7f38e93d5a80> ret: None [1714901780087] [DBG] HUB enter <function HUB.subscribe_hub at 0x7f38e93d5a80> ('version', '>') [1714901780087] [INFO] HUB (HUB) Subscribe to : {topic: >48:3f:da:55:07:5c/version } [1714901780087] [DBG] MQTT enter <function mqtt_transport.subscribe at 0x7f38e95e6ca0> ('>48:3f:da:55:07:5c/version', <bound method log.dbg_wr.<locals>.wrapper of <uclient.hub.HUB object at 0x7f38e9254e50>>) [1714901780087] [DBG] MQTT exit <function mqtt_transport.subscribe at 0x7f38e95e6ca0> ret: None [1714901780087] [DBG] HUB exit <function HUB.subscribe_hub at 0x7f38e93d5a80> ret: None [1714901780087] [DBG] HUB exit <function HUB.__on_connect at 0x7f38e93d6340> ret: None [1714901780087] [DBG] MQTT exit <function mqtt_transport.connect at 0x7f38e95e6a20> ret: None [1714901780087] [DBG] HUB exit <function HUB.connect at 0x7f38e93d7240> ret: None [1714901780098] [DBG] HUB Step, state: 0 (next: 1714901781098) [1714901780098] [DBG] HUB enter <function HUB.__send_reg at 0x7f38e93d6200> () [1714901780098] [INFO] HUB Publish reg token: 48:3f:da:55:07:5c [1714901780098] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f38e95e6b60> ('/reg', '48:3f:da:55:07:5c') [1714901780098] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f38e95e6b60> ret: None [1714901780098] [DBG] HUB exit <function HUB.__send_reg at 0x7f38e93d6200> ret: None [1714901780130] [DBG] HUB enter <function HUB.__on_message at 0x7f38e93d6700> ('/48:3f:da:55:07:5c/time', b'1714901780130') [1714901780130] [INFO] HUB Message: {topic: /48:3f:da:55:07:5c/time, value: 1714901780130 } [1714901780130] [DBG] HUB enter <function HUB.__time_hnd at 0x7f38e93d5bc0> ('1714901780130',) [1714901780130] [INFO] HUB Registration finish, time: 1714901780130 [1714901780130] [DBG] FW-UPD enter <function device_base.register at 0x7f38e93d4e00> (1714901780,) [1714901780130] [INFO] FW-UPD Device 3996365522 registration on the server @ 1714901780 [1714901780130] [DBG] HUB enter <function HUB.subscribe_hub at 0x7f38e93d5a80> ('3996365522/#', '>') [1714901780130] [INFO] HUB (HUB) Subscribe to : {topic: >48:3f:da:55:07:5c/3996365522/# } [1714901780130] [DBG] MQTT enter <function mqtt_transport.subscribe at 0x7f38e95e6ca0> ('>48:3f:da:55:07:5c/3996365522/#', <bound method log.dbg_wr.<locals>.wrapper of <uclient.hub.HUB object at 0x7f38e9254e50>>) [1714901780130] [DBG] MQTT exit <function mqtt_transport.subscribe at 0x7f38e95e6ca0> ret: None [1714901780130] [DBG] HUB exit <function HUB.subscribe_hub at 0x7f38e93d5a80> ret: None [1714901780130] [DBG] FW-UPD exit <function device_base.register at 0x7f38e93d4e00> ret: None [1714901780130] [DBG] HUB exit <function HUB.__time_hnd at 0x7f38e93d5bc0> ret: None [1714901780130] [DBG] HUB exit <function HUB.__on_message at 0x7f38e93d6700> ret: None [1714901781103] [DBG] HUB Step, state: 1 (next: 1714901782103) [1714901781104] [DBG] FW-UPD enter <function device_base.info_req at 0x7f38e93d56c0> () [1714901781104] [DBG] FW-UPD exit <function device_base.info_req at 0x7f38e93d56c0> ret: {'s': 3996365522, 't': 1, 'r': {0: 3996365522, 1: 1714901780}} [1714901781104] [DBG] HUB enter <function HUB.pub_hub at 0x7f38e93d5940> ('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": 1714901780}}]}', '/') [1714901781104] [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": 1714901780}}]} } [1714901781104] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f38e95e6b60> ('/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": 1714901780}}]}') [1714901781106] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f38e95e6b60> ret: None [1714901781106] [DBG] HUB exit <function HUB.pub_hub at 0x7f38e93d5940> ret: None [1714901782268] [DBG] HUB enter <function HUB.__on_message at 0x7f38e93d6700> ('>48:3f:da:55:07:5c/3996365522/8', b'19624') [1714901782268] [INFO] HUB Message: {topic: >48:3f:da:55:07:5c/3996365522/8, value: 19624 } [1714901782268] [DBG] FW-UPD enter <function device_base.hnd_msg at 0x7f38e93d4f40> ('8', 19624) [1714901782268] [INFO] FW-UPD Set REG[8] = 19624 [1714901782268] [DBG] FW-UPD exit <function device_base.hnd_msg at 0x7f38e93d4f40> ret: None [1714901782268] [DBG] HUB exit <function HUB.__on_message at 0x7f38e93d6700> ret: None [1714901783278] [DBG] FW-UPD enter <function device_base.set_reg at 0x7f38e93d4b80> (8, 52669) [1714901783278] [DBG] HUB enter <function HUB.pub at 0x7f38e93d4220> ('3996365522/8', '52669') [1714901783278] [DBG] HUB enter <function HUB.pub_hub at 0x7f38e93d5940> ('3996365522/8', '52669') [1714901783278] [INFO] HUB Publish message: { topic: 3996365522/8, value: 52669 } [1714901783278] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f38e95e6b60> ('<48:3f:da:55:07:5c/3996365522/8', '52669') [1714901783278] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f38e95e6b60> ret: None [1714901783278] [DBG] HUB exit <function HUB.pub_hub at 0x7f38e93d5940> ret: None [1714901783278] [DBG] HUB exit <function HUB.pub at 0x7f38e93d4220> ret: True [1714901783278] [DBG] FW-UPD exit <function device_base.set_reg at 0x7f38e93d4b80> ret: None [1714901784292] [DBG] HUB enter <function HUB.__on_message at 0x7f38e93d6700> ('>48:3f:da:55:07:5c/3996365522/9', b'{"rnd-a": 27698, "rnd-b": 50049}') [1714901784292] [INFO] HUB Message: {topic: >48:3f:da:55:07:5c/3996365522/9, value: {"rnd-a": 27698, "rnd-b": 50049} } [1714901784292] [DBG] FW-UPD enter <function device_base.hnd_msg at 0x7f38e93d4f40> ('9', {'rnd-a': 27698, 'rnd-b': 50049}) [1714901784292] [INFO] FW-UPD Set REG[9] = {'rnd-a': 27698, 'rnd-b': 50049} [1714901784292] [DBG] FW-UPD exit <function device_base.hnd_msg at 0x7f38e93d4f40> ret: None [1714901784292] [DBG] HUB exit <function HUB.__on_message at 0x7f38e93d6700> ret: None [1714901785304] [DBG] FW-UPD enter <function device_base.set_reg at 0x7f38e93d4b80> (9, {'rnd-a': 27145, 'rnd-b': 6398}) [1714901785304] [DBG] HUB enter <function HUB.pub at 0x7f38e93d4220> ('3996365522/9', '{"rnd-a": 27145, "rnd-b": 6398}') [1714901785304] [DBG] HUB enter <function HUB.pub_hub at 0x7f38e93d5940> ('3996365522/9', '{"rnd-a": 27145, "rnd-b": 6398}') [1714901785304] [INFO] HUB Publish message: { topic: 3996365522/9, value: {"rnd-a": 27145, "rnd-b": 6398} } [1714901785305] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f38e95e6b60> ('<48:3f:da:55:07:5c/3996365522/9', '{"rnd-a": 27145, "rnd-b": 6398}') [1714901785306] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f38e95e6b60> ret: None [1714901785306] [DBG] HUB exit <function HUB.pub_hub at 0x7f38e93d5940> ret: None [1714901785306] [DBG] HUB exit <function HUB.pub at 0x7f38e93d4220> ret: True [1714901785306] [DBG] FW-UPD exit <function device_base.set_reg at 0x7f38e93d4b80> ret: None [1714901785307] [DBG] MQTT enter <function mqtt_transport.disconnect at 0x7f38e95e6f20> () [1714901785307] [DBG] MQTT exit <function mqtt_transport.disconnect at 0x7f38e95e6f20> ret: None

Suite stderr:

2024-05-05 09:36:21,129 - TEST - INFO - OP take: 1041.414 ms 2024-05-05 09:36:21,256 - TEST - INFO - Connected with result code: 0 2024-05-05 09:36:21,263 - TEST - INFO - OP take: 132.159 ms 2024-05-05 09:36:22,264 - TEST - INFO - ------- 1. Set register 8 to value 19624 from server side 2024-05-05 09:36:22,264 - TEST - INFO - [dev] => { '8' : '19624' } 2024-05-05 09:36:22,275 - TEST - INFO - OP take: 10.185 ms 2024-05-05 09:36:23,276 - TEST - INFO - ------- 2. Set register 8 to value 52669 from device side 2024-05-05 09:36:23,288 - TEST - INFO - OP take: 10.105 ms 2024-05-05 09:36:24,289 - TEST - INFO - ------- 3. Set register 9 to value {'rnd-a': 27698, 'rnd-b': 50049} from server side 2024-05-05 09:36:24,290 - TEST - INFO - [dev] => { '9' : '{'rnd-a': 27698, 'rnd-b': 50049}' } 2024-05-05 09:36:24,302 - TEST - INFO - OP take: 10.191 ms 2024-05-05 09:36:25,304 - TEST - INFO - ------- 4. Set register 9 to value {'rnd-a': 27145, 'rnd-b': 6398} from device side 2024-05-05 09:36:25,306 - TEST - INFO - OP take: 0.003 ms 2024-05-05 09:36:25,307 - TEST - WARNING - Disconecting from broker