TEST-reg_value_exchange_test-20240503193657.xml

Test Report : TEST-reg_value_exchange_test-20240503193657.xml

reg_value_exchange_test
- test

Test Suite: reg_value_exchange_test-20240503193657

Results

Duration	7.461 sec
Tests	1
Failures	0

Tests

reg_value_exchange_test

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

None

Suite stdout:

[1714765017030] [INFO] DEV-3996365522 Device 3996365522 (type: 1) has been created [1714765017030] [INFO] FW-UPD Initialized [1714765017031] [DBG] FW-UPD enter <function device_base.set_hub at 0x7f5e4ea6c720> (<uclient.hub.HUB object at 0x7f5e4e8ecf50>,) [1714765017031] [DBG] FW-UPD exit <function device_base.set_hub at 0x7f5e4ea6c720> ret: None [1714765017031] [DBG] HUB enter <function HUB.register_root_cb at 0x7f5e4ea6e7a0> ('>user/dev', <bound method user_device.on_user_dev of <uclient.fwupd.fwupd_device object at 0x7f5e4e8ece50>>) [1714765017031] [DBG] HUB exit <function HUB.register_root_cb at 0x7f5e4ea6e7a0> ret: None [1714765017031] [DBG] MQTT enter <function mqtt_transport.set_lastwill at 0x7f5e4ec7f060> ('<48:3f:da:55:07:5c/status', '-1') [1714765017031] [DBG] MQTT exit <function mqtt_transport.set_lastwill at 0x7f5e4ec7f060> ret: None [1714765017031] [DBG] MQTT enter <function mqtt_transport.on_connect at 0x7f5e4ec7ede0> (<bound method log.dbg_wr.<locals>.wrapper of <uclient.hub.HUB object at 0x7f5e4e8ecf50>>,) [1714765017031] [DBG] MQTT exit <function mqtt_transport.on_connect at 0x7f5e4ec7ede0> ret: None [1714765017031] [DBG] MQTT enter <function mqtt_transport.on_disconnect at 0x7f5e4ec7ef20> (<bound method log.dbg_wr.<locals>.wrapper of <uclient.hub.HUB object at 0x7f5e4e8ecf50>>,) [1714765017031] [DBG] MQTT exit <function mqtt_transport.on_disconnect at 0x7f5e4ec7ef20> ret: None [1714765017031] [DBG] HUB enter <function HUB.connect at 0x7f5e4ea6f060> () [1714765017031] [WARN] HUB Try to connect without uri-schema [1714765017031] [DBG] MQTT enter <function mqtt_transport.connect at 0x7f5e4ec7e7a0> ('x.ks.ua',) [1714765018192] [DBG] HUB enter <function HUB.__on_connect at 0x7f5e4ea6e160> () [1714765018192] [INFO] HUB Connected [1714765018192] [DBG] MQTT enter <function mqtt_transport.subscribe at 0x7f5e4ec7ea20> ('>hub', <bound method log.dbg_wr.<locals>.wrapper of <uclient.hub.HUB object at 0x7f5e4e8ecf50>>) [1714765018192] [DBG] MQTT exit <function mqtt_transport.subscribe at 0x7f5e4ec7ea20> ret: None [1714765018192] [DBG] MQTT enter <function mqtt_transport.subscribe at 0x7f5e4ec7ea20> ('>user/dev', <bound method log.dbg_wr.<locals>.wrapper of <uclient.hub.HUB object at 0x7f5e4e8ecf50>>) [1714765018192] [DBG] MQTT exit <function mqtt_transport.subscribe at 0x7f5e4ec7ea20> ret: None [1714765018192] [DBG] HUB enter <function HUB.subscribe_hub at 0x7f5e4ea6d8a0> ('time', '/') [1714765018192] [INFO] HUB (HUB) Subscribe to : {topic: /48:3f:da:55:07:5c/time } [1714765018192] [DBG] MQTT enter <function mqtt_transport.subscribe at 0x7f5e4ec7ea20> ('/48:3f:da:55:07:5c/time', <bound method log.dbg_wr.<locals>.wrapper of <uclient.hub.HUB object at 0x7f5e4e8ecf50>>) [1714765018192] [DBG] MQTT exit <function mqtt_transport.subscribe at 0x7f5e4ec7ea20> ret: None [1714765018192] [DBG] HUB exit <function HUB.subscribe_hub at 0x7f5e4ea6d8a0> ret: None [1714765018193] [DBG] HUB enter <function HUB.subscribe_hub at 0x7f5e4ea6d8a0> ('lifetime', '>') [1714765018193] [INFO] HUB (HUB) Subscribe to : {topic: >48:3f:da:55:07:5c/lifetime } [1714765018193] [DBG] MQTT enter <function mqtt_transport.subscribe at 0x7f5e4ec7ea20> ('>48:3f:da:55:07:5c/lifetime', <bound method log.dbg_wr.<locals>.wrapper of <uclient.hub.HUB object at 0x7f5e4e8ecf50>>) [1714765018193] [DBG] MQTT exit <function mqtt_transport.subscribe at 0x7f5e4ec7ea20> ret: None [1714765018193] [DBG] HUB exit <function HUB.subscribe_hub at 0x7f5e4ea6d8a0> ret: None [1714765018193] [DBG] HUB enter <function HUB.subscribe_hub at 0x7f5e4ea6d8a0> ('error', '>') [1714765018193] [INFO] HUB (HUB) Subscribe to : {topic: >48:3f:da:55:07:5c/error } [1714765018193] [DBG] MQTT enter <function mqtt_transport.subscribe at 0x7f5e4ec7ea20> ('>48:3f:da:55:07:5c/error', <bound method log.dbg_wr.<locals>.wrapper of <uclient.hub.HUB object at 0x7f5e4e8ecf50>>) [1714765018193] [DBG] MQTT exit <function mqtt_transport.subscribe at 0x7f5e4ec7ea20> ret: None [1714765018193] [DBG] HUB exit <function HUB.subscribe_hub at 0x7f5e4ea6d8a0> ret: None [1714765018193] [DBG] HUB enter <function HUB.subscribe_hub at 0x7f5e4ea6d8a0> ('ping', '>') [1714765018193] [INFO] HUB (HUB) Subscribe to : {topic: >48:3f:da:55:07:5c/ping } [1714765018193] [DBG] MQTT enter <function mqtt_transport.subscribe at 0x7f5e4ec7ea20> ('>48:3f:da:55:07:5c/ping', <bound method log.dbg_wr.<locals>.wrapper of <uclient.hub.HUB object at 0x7f5e4e8ecf50>>) [1714765018193] [DBG] MQTT exit <function mqtt_transport.subscribe at 0x7f5e4ec7ea20> ret: None [1714765018193] [DBG] HUB exit <function HUB.subscribe_hub at 0x7f5e4ea6d8a0> ret: None [1714765018193] [DBG] HUB enter <function HUB.subscribe_hub at 0x7f5e4ea6d8a0> ('version', '>') [1714765018193] [INFO] HUB (HUB) Subscribe to : {topic: >48:3f:da:55:07:5c/version } [1714765018193] [DBG] MQTT enter <function mqtt_transport.subscribe at 0x7f5e4ec7ea20> ('>48:3f:da:55:07:5c/version', <bound method log.dbg_wr.<locals>.wrapper of <uclient.hub.HUB object at 0x7f5e4e8ecf50>>) [1714765018193] [DBG] MQTT exit <function mqtt_transport.subscribe at 0x7f5e4ec7ea20> ret: None [1714765018193] [DBG] HUB exit <function HUB.subscribe_hub at 0x7f5e4ea6d8a0> ret: None [1714765018193] [DBG] HUB exit <function HUB.__on_connect at 0x7f5e4ea6e160> ret: None [1714765018193] [DBG] MQTT exit <function mqtt_transport.connect at 0x7f5e4ec7e7a0> ret: None [1714765018193] [DBG] HUB exit <function HUB.connect at 0x7f5e4ea6f060> ret: None [1714765018204] [DBG] HUB Step, state: 0 (next: 1714765019204) [1714765018205] [DBG] HUB enter <function HUB.__send_reg at 0x7f5e4ea6e020> () [1714765018205] [INFO] HUB Publish reg token: 48:3f:da:55:07:5c [1714765018205] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f5e4ec7e8e0> ('/reg', '48:3f:da:55:07:5c') [1714765018205] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f5e4ec7e8e0> ret: None [1714765018205] [DBG] HUB exit <function HUB.__send_reg at 0x7f5e4ea6e020> ret: None [1714765019212] [DBG] HUB Step, state: 0 (next: 1714765020212) [1714765019212] [DBG] HUB enter <function HUB.__send_reg at 0x7f5e4ea6e020> () [1714765019212] [INFO] HUB Publish reg token: 48:3f:da:55:07:5c [1714765019212] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f5e4ec7e8e0> ('/reg', '48:3f:da:55:07:5c') [1714765019212] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f5e4ec7e8e0> ret: None [1714765019212] [DBG] HUB exit <function HUB.__send_reg at 0x7f5e4ea6e020> ret: None [1714765019260] [DBG] HUB enter <function HUB.__on_message at 0x7f5e4ea6e520> ('/48:3f:da:55:07:5c/time', b'1714765019259') [1714765019260] [INFO] HUB Message: {topic: /48:3f:da:55:07:5c/time, value: 1714765019259 } [1714765019260] [DBG] HUB enter <function HUB.__time_hnd at 0x7f5e4ea6d9e0> ('1714765019259',) [1714765019260] [INFO] HUB Registration finish, time: 1714765019259 [1714765019260] [DBG] FW-UPD enter <function device_base.register at 0x7f5e4ea6cc20> (1714765019,) [1714765019260] [INFO] FW-UPD Device 3996365522 registration on the server @ 1714765019 [1714765019261] [DBG] HUB enter <function HUB.subscribe_hub at 0x7f5e4ea6d8a0> ('3996365522/#', '>') [1714765019261] [INFO] HUB (HUB) Subscribe to : {topic: >48:3f:da:55:07:5c/3996365522/# } [1714765019261] [DBG] MQTT enter <function mqtt_transport.subscribe at 0x7f5e4ec7ea20> ('>48:3f:da:55:07:5c/3996365522/#', <bound method log.dbg_wr.<locals>.wrapper of <uclient.hub.HUB object at 0x7f5e4e8ecf50>>) [1714765019261] [DBG] MQTT exit <function mqtt_transport.subscribe at 0x7f5e4ec7ea20> ret: None [1714765019261] [DBG] HUB exit <function HUB.subscribe_hub at 0x7f5e4ea6d8a0> ret: None [1714765019261] [DBG] FW-UPD exit <function device_base.register at 0x7f5e4ea6cc20> ret: None [1714765019261] [DBG] HUB exit <function HUB.__time_hnd at 0x7f5e4ea6d9e0> ret: None [1714765019261] [DBG] HUB exit <function HUB.__on_message at 0x7f5e4ea6e520> ret: None [1714765020215] [DBG] HUB Step, state: 1 (next: 1714765021215) [1714765020215] [DBG] FW-UPD enter <function device_base.info_req at 0x7f5e4ea6d4e0> () [1714765020215] [DBG] FW-UPD exit <function device_base.info_req at 0x7f5e4ea6d4e0> ret: {'s': 3996365522, 't': 1, 'r': {0: 3996365522, 1: 1714765019}} [1714765020216] [DBG] HUB enter <function HUB.pub_hub at 0x7f5e4ea6d760> ('info', '{"mac": "48:3f:da:55:07:5c", "version": "R240430;master;38274a5b8a83c5fa684f71a958848479413f7085", "type": "mpy", "prot": 2, "devices": [{"s": 3996365522, "t": 1, "r": {"0": 3996365522, "1": 1714765019}}]}', '/') [1714765020216] [INFO] HUB Publish message: { topic: info, value: {"mac": "48:3f:da:55:07:5c", "version": "R240430;master;38274a5b8a83c5fa684f71a958848479413f7085", "type": "mpy", "prot": 2, "devices": [{"s": 3996365522, "t": 1, "r": {"0": 3996365522, "1": 1714765019}}]} } [1714765020216] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f5e4ec7e8e0> ('/48:3f:da:55:07:5c/info', '{"mac": "48:3f:da:55:07:5c", "version": "R240430;master;38274a5b8a83c5fa684f71a958848479413f7085", "type": "mpy", "prot": 2, "devices": [{"s": 3996365522, "t": 1, "r": {"0": 3996365522, "1": 1714765019}}]}') [1714765020216] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f5e4ec7e8e0> ret: None [1714765020216] [DBG] HUB exit <function HUB.pub_hub at 0x7f5e4ea6d760> ret: None [1714765021438] [DBG] HUB enter <function HUB.__on_message at 0x7f5e4ea6e520> ('>48:3f:da:55:07:5c/3996365522/8', b'29055') [1714765021438] [INFO] HUB Message: {topic: >48:3f:da:55:07:5c/3996365522/8, value: 29055 } [1714765021438] [DBG] FW-UPD enter <function device_base.hnd_msg at 0x7f5e4ea6cd60> ('8', 29055) [1714765021439] [INFO] FW-UPD Set REG[8] = 29055 [1714765021439] [DBG] FW-UPD exit <function device_base.hnd_msg at 0x7f5e4ea6cd60> ret: None [1714765021439] [DBG] HUB exit <function HUB.__on_message at 0x7f5e4ea6e520> ret: None [1714765022450] [DBG] FW-UPD enter <function device_base.set_reg at 0x7f5e4ea6c9a0> (8, 32341) [1714765022450] [DBG] HUB enter <function HUB.pub at 0x7f5e4ea6c040> ('3996365522/8', '32341') [1714765022450] [DBG] HUB enter <function HUB.pub_hub at 0x7f5e4ea6d760> ('3996365522/8', '32341') [1714765022450] [INFO] HUB Publish message: { topic: 3996365522/8, value: 32341 } [1714765022450] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f5e4ec7e8e0> ('<48:3f:da:55:07:5c/3996365522/8', '32341') [1714765022450] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f5e4ec7e8e0> ret: None [1714765022450] [DBG] HUB exit <function HUB.pub_hub at 0x7f5e4ea6d760> ret: None [1714765022450] [DBG] HUB exit <function HUB.pub at 0x7f5e4ea6c040> ret: True [1714765022450] [DBG] FW-UPD exit <function device_base.set_reg at 0x7f5e4ea6c9a0> ret: None [1714765023462] [DBG] HUB enter <function HUB.__on_message at 0x7f5e4ea6e520> ('>48:3f:da:55:07:5c/3996365522/9', b'{"rnd-a": 28005, "rnd-b": 61964}') [1714765023462] [INFO] HUB Message: {topic: >48:3f:da:55:07:5c/3996365522/9, value: {"rnd-a": 28005, "rnd-b": 61964} } [1714765023462] [DBG] FW-UPD enter <function device_base.hnd_msg at 0x7f5e4ea6cd60> ('9', {'rnd-a': 28005, 'rnd-b': 61964}) [1714765023462] [INFO] FW-UPD Set REG[9] = {'rnd-a': 28005, 'rnd-b': 61964} [1714765023462] [DBG] FW-UPD exit <function device_base.hnd_msg at 0x7f5e4ea6cd60> ret: None [1714765023462] [DBG] HUB exit <function HUB.__on_message at 0x7f5e4ea6e520> ret: None [1714765024474] [DBG] FW-UPD enter <function device_base.set_reg at 0x7f5e4ea6c9a0> (9, {'rnd-a': 26930, 'rnd-b': 63926}) [1714765024475] [DBG] HUB enter <function HUB.pub at 0x7f5e4ea6c040> ('3996365522/9', '{"rnd-a": 26930, "rnd-b": 63926}') [1714765024475] [DBG] HUB enter <function HUB.pub_hub at 0x7f5e4ea6d760> ('3996365522/9', '{"rnd-a": 26930, "rnd-b": 63926}') [1714765024475] [INFO] HUB Publish message: { topic: 3996365522/9, value: {"rnd-a": 26930, "rnd-b": 63926} } [1714765024475] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f5e4ec7e8e0> ('<48:3f:da:55:07:5c/3996365522/9', '{"rnd-a": 26930, "rnd-b": 63926}') [1714765024475] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f5e4ec7e8e0> ret: None [1714765024475] [DBG] HUB exit <function HUB.pub_hub at 0x7f5e4ea6d760> ret: None [1714765024475] [DBG] HUB exit <function HUB.pub at 0x7f5e4ea6c040> ret: True [1714765024475] [DBG] FW-UPD exit <function device_base.set_reg at 0x7f5e4ea6c9a0> ret: None [1714765024486] [DBG] MQTT enter <function mqtt_transport.disconnect at 0x7f5e4ec7eca0> () [1714765024489] [DBG] MQTT exit <function mqtt_transport.disconnect at 0x7f5e4ec7eca0> ret: None

Suite stderr:

2024-05-03 19:37:00,239 - TEST - INFO - OP take: 2044.524 ms 2024-05-03 19:37:00,433 - TEST - INFO - Connected with result code: 0 2024-05-03 19:37:00,435 - TEST - INFO - OP take: 194.781 ms 2024-05-03 19:37:01,435 - TEST - INFO - ------- 1. Set register 8 to value 29055 from server side 2024-05-03 19:37:01,436 - TEST - INFO - [dev] => { '8' : '29055' } 2024-05-03 19:37:01,447 - TEST - INFO - OP take: 10.314 ms 2024-05-03 19:37:02,448 - TEST - INFO - ------- 2. Set register 8 to value 32341 from device side 2024-05-03 19:37:02,461 - TEST - INFO - OP take: 10.187 ms 2024-05-03 19:37:03,461 - TEST - INFO - ------- 3. Set register 9 to value {'rnd-a': 28005, 'rnd-b': 61964} from server side 2024-05-03 19:37:03,461 - TEST - INFO - [dev] => { '9' : '{'rnd-a': 28005, 'rnd-b': 61964}' } 2024-05-03 19:37:03,472 - TEST - INFO - OP take: 10.124 ms 2024-05-03 19:37:04,473 - TEST - INFO - ------- 4. Set register 9 to value {'rnd-a': 26930, 'rnd-b': 63926} from device side 2024-05-03 19:37:04,486 - TEST - INFO - OP take: 10.157 ms 2024-05-03 19:37:04,489 - TEST - WARNING - Disconecting from broker 2024-05-03 19:37:04,495 - TEST - WARNING - Disconecting from broker