TEST-reg_value_exchange_test-20240430184201.xml

Test Report : TEST-reg_value_exchange_test-20240430184201.xml

reg_value_exchange_test
- test

Test Suite: reg_value_exchange_test-20240430184201

Results

Duration	6.089 sec
Tests	1
Failures	0

Tests

reg_value_exchange_test

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

None

Suite stdout:

[1714502521227] [INFO] DEV-3996365522 Device 3996365522 (type: 1) has been created [1714502521228] [INFO] FW-UPD Initialized [1714502521228] [DBG] FW-UPD enter <function device_base.set_hub at 0x7f7ebbbb4720> (<uclient.hub.HUB object at 0x7f7ebba58f90>,) [1714502521228] [DBG] FW-UPD exit <function device_base.set_hub at 0x7f7ebbbb4720> ret: None [1714502521228] [DBG] HUB enter <function HUB.register_root_cb at 0x7f7ebbbb67a0> ('>user/dev', <bound method user_device.on_user_dev of <uclient.fwupd.fwupd_device object at 0x7f7ebc9fe210>>) [1714502521228] [DBG] HUB exit <function HUB.register_root_cb at 0x7f7ebbbb67a0> ret: None [1714502521228] [DBG] MQTT enter <function mqtt_transport.set_lastwill at 0x7f7ebbe2b060> ('<48:3f:da:55:07:5c/status', '-1') [1714502521228] [DBG] MQTT exit <function mqtt_transport.set_lastwill at 0x7f7ebbe2b060> ret: None [1714502521228] [DBG] MQTT enter <function mqtt_transport.on_connect at 0x7f7ebbe2ade0> (<bound method log.dbg_wr.<locals>.wrapper of <uclient.hub.HUB object at 0x7f7ebba58f90>>,) [1714502521228] [DBG] MQTT exit <function mqtt_transport.on_connect at 0x7f7ebbe2ade0> ret: None [1714502521228] [DBG] MQTT enter <function mqtt_transport.on_disconnect at 0x7f7ebbe2af20> (<bound method log.dbg_wr.<locals>.wrapper of <uclient.hub.HUB object at 0x7f7ebba58f90>>,) [1714502521228] [DBG] MQTT exit <function mqtt_transport.on_disconnect at 0x7f7ebbe2af20> ret: None [1714502521228] [DBG] HUB enter <function HUB.connect at 0x7f7ebbbb7060> () [1714502521228] [WARN] HUB Try to connect without uri-schema [1714502521228] [DBG] MQTT enter <function mqtt_transport.connect at 0x7f7ebbe2a7a0> ('x.ks.ua',) [1714502522234] [DBG] HUB enter <function HUB.__on_connect at 0x7f7ebbbb6160> () [1714502522234] [INFO] HUB Connected [1714502522234] [DBG] MQTT enter <function mqtt_transport.subscribe at 0x7f7ebbe2aa20> ('>hub', <bound method log.dbg_wr.<locals>.wrapper of <uclient.hub.HUB object at 0x7f7ebba58f90>>) [1714502522234] [DBG] MQTT exit <function mqtt_transport.subscribe at 0x7f7ebbe2aa20> ret: None [1714502522234] [DBG] MQTT enter <function mqtt_transport.subscribe at 0x7f7ebbe2aa20> ('>user/dev', <bound method log.dbg_wr.<locals>.wrapper of <uclient.hub.HUB object at 0x7f7ebba58f90>>) [1714502522234] [DBG] MQTT exit <function mqtt_transport.subscribe at 0x7f7ebbe2aa20> ret: None [1714502522234] [DBG] HUB enter <function HUB.subscribe_hub at 0x7f7ebbbb58a0> ('time', '/') [1714502522234] [INFO] HUB (HUB) Subscribe to : {topic: /48:3f:da:55:07:5c/time } [1714502522234] [DBG] MQTT enter <function mqtt_transport.subscribe at 0x7f7ebbe2aa20> ('/48:3f:da:55:07:5c/time', <bound method log.dbg_wr.<locals>.wrapper of <uclient.hub.HUB object at 0x7f7ebba58f90>>) [1714502522234] [DBG] MQTT exit <function mqtt_transport.subscribe at 0x7f7ebbe2aa20> ret: None [1714502522234] [DBG] HUB exit <function HUB.subscribe_hub at 0x7f7ebbbb58a0> ret: None [1714502522234] [DBG] HUB enter <function HUB.subscribe_hub at 0x7f7ebbbb58a0> ('lifetime', '>') [1714502522234] [INFO] HUB (HUB) Subscribe to : {topic: >48:3f:da:55:07:5c/lifetime } [1714502522234] [DBG] MQTT enter <function mqtt_transport.subscribe at 0x7f7ebbe2aa20> ('>48:3f:da:55:07:5c/lifetime', <bound method log.dbg_wr.<locals>.wrapper of <uclient.hub.HUB object at 0x7f7ebba58f90>>) [1714502522234] [DBG] MQTT exit <function mqtt_transport.subscribe at 0x7f7ebbe2aa20> ret: None [1714502522234] [DBG] HUB exit <function HUB.subscribe_hub at 0x7f7ebbbb58a0> ret: None [1714502522234] [DBG] HUB enter <function HUB.subscribe_hub at 0x7f7ebbbb58a0> ('error', '>') [1714502522234] [INFO] HUB (HUB) Subscribe to : {topic: >48:3f:da:55:07:5c/error } [1714502522234] [DBG] MQTT enter <function mqtt_transport.subscribe at 0x7f7ebbe2aa20> ('>48:3f:da:55:07:5c/error', <bound method log.dbg_wr.<locals>.wrapper of <uclient.hub.HUB object at 0x7f7ebba58f90>>) [1714502522235] [DBG] MQTT exit <function mqtt_transport.subscribe at 0x7f7ebbe2aa20> ret: None [1714502522235] [DBG] HUB exit <function HUB.subscribe_hub at 0x7f7ebbbb58a0> ret: None [1714502522235] [DBG] HUB enter <function HUB.subscribe_hub at 0x7f7ebbbb58a0> ('ping', '>') [1714502522235] [INFO] HUB (HUB) Subscribe to : {topic: >48:3f:da:55:07:5c/ping } [1714502522235] [DBG] MQTT enter <function mqtt_transport.subscribe at 0x7f7ebbe2aa20> ('>48:3f:da:55:07:5c/ping', <bound method log.dbg_wr.<locals>.wrapper of <uclient.hub.HUB object at 0x7f7ebba58f90>>) [1714502522235] [DBG] MQTT exit <function mqtt_transport.subscribe at 0x7f7ebbe2aa20> ret: None [1714502522235] [DBG] HUB exit <function HUB.subscribe_hub at 0x7f7ebbbb58a0> ret: None [1714502522235] [DBG] HUB enter <function HUB.subscribe_hub at 0x7f7ebbbb58a0> ('version', '>') [1714502522235] [INFO] HUB (HUB) Subscribe to : {topic: >48:3f:da:55:07:5c/version } [1714502522235] [DBG] MQTT enter <function mqtt_transport.subscribe at 0x7f7ebbe2aa20> ('>48:3f:da:55:07:5c/version', <bound method log.dbg_wr.<locals>.wrapper of <uclient.hub.HUB object at 0x7f7ebba58f90>>) [1714502522235] [DBG] MQTT exit <function mqtt_transport.subscribe at 0x7f7ebbe2aa20> ret: None [1714502522235] [DBG] HUB exit <function HUB.subscribe_hub at 0x7f7ebbbb58a0> ret: None [1714502522235] [DBG] HUB exit <function HUB.__on_connect at 0x7f7ebbbb6160> ret: None [1714502522235] [DBG] MQTT exit <function mqtt_transport.connect at 0x7f7ebbe2a7a0> ret: None [1714502522235] [DBG] HUB exit <function HUB.connect at 0x7f7ebbbb7060> ret: None [1714502522246] [DBG] HUB Step, state: 0 (next: 1714502523246) [1714502522246] [DBG] HUB enter <function HUB.__send_reg at 0x7f7ebbbb6020> () [1714502522246] [INFO] HUB Publish reg token: 48:3f:da:55:07:5c [1714502522246] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f7ebbe2a8e0> ('/reg', '48:3f:da:55:07:5c') [1714502522246] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f7ebbe2a8e0> ret: None [1714502522246] [DBG] HUB exit <function HUB.__send_reg at 0x7f7ebbbb6020> ret: None [1714502522282] [DBG] HUB enter <function HUB.__on_message at 0x7f7ebbbb6520> ('/48:3f:da:55:07:5c/time', b'1714502522279') [1714502522282] [INFO] HUB Message: {topic: /48:3f:da:55:07:5c/time, value: 1714502522279 } [1714502522282] [DBG] HUB enter <function HUB.__time_hnd at 0x7f7ebbbb59e0> ('1714502522279',) [1714502522282] [INFO] HUB Registration finish, time: 1714502522279 [1714502522282] [DBG] FW-UPD enter <function device_base.register at 0x7f7ebbbb4c20> (1714502522,) [1714502522282] [INFO] FW-UPD Device 3996365522 registration on the server @ 1714502522 [1714502522282] [DBG] HUB enter <function HUB.subscribe_hub at 0x7f7ebbbb58a0> ('3996365522/#', '>') [1714502522282] [INFO] HUB (HUB) Subscribe to : {topic: >48:3f:da:55:07:5c/3996365522/# } [1714502522282] [DBG] MQTT enter <function mqtt_transport.subscribe at 0x7f7ebbe2aa20> ('>48:3f:da:55:07:5c/3996365522/#', <bound method log.dbg_wr.<locals>.wrapper of <uclient.hub.HUB object at 0x7f7ebba58f90>>) [1714502522282] [DBG] MQTT exit <function mqtt_transport.subscribe at 0x7f7ebbe2aa20> ret: None [1714502522282] [DBG] HUB exit <function HUB.subscribe_hub at 0x7f7ebbbb58a0> ret: None [1714502522282] [DBG] FW-UPD exit <function device_base.register at 0x7f7ebbbb4c20> ret: None [1714502522282] [DBG] HUB exit <function HUB.__time_hnd at 0x7f7ebbbb59e0> ret: None [1714502522282] [DBG] HUB exit <function HUB.__on_message at 0x7f7ebbbb6520> ret: None [1714502523250] [DBG] HUB Step, state: 1 (next: 1714502524250) [1714502523250] [DBG] FW-UPD enter <function device_base.info_req at 0x7f7ebbbb54e0> () [1714502523250] [DBG] FW-UPD exit <function device_base.info_req at 0x7f7ebbbb54e0> ret: {'s': 3996365522, 't': 1, 'r': {0: 3996365522, 1: 1714502522}} [1714502523250] [DBG] HUB enter <function HUB.pub_hub at 0x7f7ebbbb5760> ('info', '{"mac": "48:3f:da:55:07:5c", "version": "R240430;master;82e78ab3cb504ee2727a21589ce1ba8e1629dbc4", "type": "mpy", "prot": 2, "devices": [{"s": 3996365522, "t": 1, "r": {"0": 3996365522, "1": 1714502522}}]}', '/') [1714502523250] [INFO] HUB Publish message: { topic: info, value: {"mac": "48:3f:da:55:07:5c", "version": "R240430;master;82e78ab3cb504ee2727a21589ce1ba8e1629dbc4", "type": "mpy", "prot": 2, "devices": [{"s": 3996365522, "t": 1, "r": {"0": 3996365522, "1": 1714502522}}]} } [1714502523250] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f7ebbe2a8e0> ('/48:3f:da:55:07:5c/info', '{"mac": "48:3f:da:55:07:5c", "version": "R240430;master;82e78ab3cb504ee2727a21589ce1ba8e1629dbc4", "type": "mpy", "prot": 2, "devices": [{"s": 3996365522, "t": 1, "r": {"0": 3996365522, "1": 1714502522}}]}') [1714502523251] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f7ebbe2a8e0> ret: None [1714502523251] [DBG] HUB exit <function HUB.pub_hub at 0x7f7ebbbb5760> ret: None [1714502524275] [DBG] HUB enter <function HUB.__on_message at 0x7f7ebbbb6520> ('>48:3f:da:55:07:5c/3996365522/8', b'19825') [1714502524275] [INFO] HUB Message: {topic: >48:3f:da:55:07:5c/3996365522/8, value: 19825 } [1714502524275] [DBG] FW-UPD enter <function device_base.hnd_msg at 0x7f7ebbbb4d60> ('8', 19825) [1714502524275] [INFO] FW-UPD Set REG[8] = 19825 [1714502524275] [DBG] FW-UPD exit <function device_base.hnd_msg at 0x7f7ebbbb4d60> ret: None [1714502524275] [DBG] HUB exit <function HUB.__on_message at 0x7f7ebbbb6520> ret: None [1714502525287] [DBG] FW-UPD enter <function device_base.set_reg at 0x7f7ebbbb49a0> (8, 23073) [1714502525287] [DBG] HUB enter <function HUB.pub at 0x7f7ebbbb4040> ('3996365522/8', '23073') [1714502525287] [DBG] HUB enter <function HUB.pub_hub at 0x7f7ebbbb5760> ('3996365522/8', '23073') [1714502525287] [INFO] HUB Publish message: { topic: 3996365522/8, value: 23073 } [1714502525287] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f7ebbe2a8e0> ('<48:3f:da:55:07:5c/3996365522/8', '23073') [1714502525289] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f7ebbe2a8e0> ret: None [1714502525289] [DBG] HUB exit <function HUB.pub_hub at 0x7f7ebbbb5760> ret: None [1714502525289] [DBG] HUB exit <function HUB.pub at 0x7f7ebbbb4040> ret: True [1714502525289] [DBG] FW-UPD exit <function device_base.set_reg at 0x7f7ebbbb49a0> ret: None [1714502526292] [DBG] HUB enter <function HUB.__on_message at 0x7f7ebbbb6520> ('>48:3f:da:55:07:5c/3996365522/9', b'{"rnd-a": 59873, "rnd-b": 20035}') [1714502526292] [INFO] HUB Message: {topic: >48:3f:da:55:07:5c/3996365522/9, value: {"rnd-a": 59873, "rnd-b": 20035} } [1714502526292] [DBG] FW-UPD enter <function device_base.hnd_msg at 0x7f7ebbbb4d60> ('9', {'rnd-a': 59873, 'rnd-b': 20035}) [1714502526292] [INFO] FW-UPD Set REG[9] = {'rnd-a': 59873, 'rnd-b': 20035} [1714502526292] [DBG] FW-UPD exit <function device_base.hnd_msg at 0x7f7ebbbb4d60> ret: None [1714502526292] [DBG] HUB exit <function HUB.__on_message at 0x7f7ebbbb6520> ret: None [1714502527302] [DBG] FW-UPD enter <function device_base.set_reg at 0x7f7ebbbb49a0> (9, {'rnd-a': 7541, 'rnd-b': 38633}) [1714502527302] [DBG] HUB enter <function HUB.pub at 0x7f7ebbbb4040> ('3996365522/9', '{"rnd-a": 7541, "rnd-b": 38633}') [1714502527302] [DBG] HUB enter <function HUB.pub_hub at 0x7f7ebbbb5760> ('3996365522/9', '{"rnd-a": 7541, "rnd-b": 38633}') [1714502527302] [INFO] HUB Publish message: { topic: 3996365522/9, value: {"rnd-a": 7541, "rnd-b": 38633} } [1714502527302] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f7ebbe2a8e0> ('<48:3f:da:55:07:5c/3996365522/9', '{"rnd-a": 7541, "rnd-b": 38633}') [1714502527303] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f7ebbe2a8e0> ret: None [1714502527303] [DBG] HUB exit <function HUB.pub_hub at 0x7f7ebbbb5760> ret: None [1714502527303] [DBG] HUB exit <function HUB.pub at 0x7f7ebbbb4040> ret: True [1714502527303] [DBG] FW-UPD exit <function device_base.set_reg at 0x7f7ebbbb49a0> ret: None [1714502527314] [DBG] MQTT enter <function mqtt_transport.disconnect at 0x7f7ebbe2aca0> () [1714502527315] [DBG] MQTT exit <function mqtt_transport.disconnect at 0x7f7ebbe2aca0> ret: None

Suite stderr:

2024-04-30 18:42:03,260 - TEST - INFO - OP take: 1024.666 ms 2024-04-30 18:42:03,263 - TEST - INFO - Connected with result code: 0 2024-04-30 18:42:03,271 - TEST - INFO - OP take: 10.087 ms 2024-04-30 18:42:04,272 - TEST - INFO - ------- 1. Set register 8 to value 19825 from server side 2024-04-30 18:42:04,272 - TEST - INFO - [dev] => { '8' : '19825' } 2024-04-30 18:42:04,285 - TEST - INFO - OP take: 10.188 ms 2024-04-30 18:42:05,286 - TEST - INFO - ------- 2. Set register 8 to value 23073 from device side 2024-04-30 18:42:05,289 - TEST - INFO - OP take: 0.002 ms 2024-04-30 18:42:06,289 - TEST - INFO - ------- 3. Set register 9 to value {'rnd-a': 59873, 'rnd-b': 20035} from server side 2024-04-30 18:42:06,289 - TEST - INFO - [dev] => { '9' : '{'rnd-a': 59873, 'rnd-b': 20035}' } 2024-04-30 18:42:06,300 - TEST - INFO - OP take: 10.248 ms 2024-04-30 18:42:07,301 - TEST - INFO - ------- 4. Set register 9 to value {'rnd-a': 7541, 'rnd-b': 38633} from device side 2024-04-30 18:42:07,313 - TEST - INFO - OP take: 10.183 ms 2024-04-30 18:42:07,315 - TEST - WARNING - Disconecting from broker