TEST-lifetime_test-20240413183100.xml

Test Report : TEST-lifetime_test-20240413183100.xml

lifetime_test
- test

Test Suite: lifetime_test-20240413183100

Results

Duration	362.377 sec
Tests	1
Failures	0

Tests

lifetime_test

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

None

Suite stdout:

[1713033060675] [INFO] DEV-3996365522 Device 3996365522 (type: 1) has been created [1713033060676] [INFO] FW-UPD Initialized [1713033060676] [DBG] FW-UPD enter <function device_base.set_hub at 0x7f292e263e20> (<uclient.hub.HUB object at 0x7f292de6c8d0>,) [1713033060676] [DBG] FW-UPD exit <function device_base.set_hub at 0x7f292e263e20> ret: None [1713033060676] [DBG] MQTT enter <function mqtt_transport.set_lastwill at 0x7f292e2627a0> ('<48:3f:da:55:07:5b/status', '-1') [1713033060676] [DBG] MQTT exit <function mqtt_transport.set_lastwill at 0x7f292e2627a0> ret: None [1713033060676] [DBG] MQTT enter <function mqtt_transport.on_connect at 0x7f292e262520> (<bound method HUB.__on_connect of <uclient.hub.HUB object at 0x7f292de6c8d0>>,) [1713033060676] [DBG] MQTT exit <function mqtt_transport.on_connect at 0x7f292e262520> ret: None [1713033060676] [DBG] MQTT enter <function mqtt_transport.on_disconnect at 0x7f292e262660> (<bound method HUB.__on_disconnect of <uclient.hub.HUB object at 0x7f292de6c8d0>>,) [1713033060676] [DBG] MQTT exit <function mqtt_transport.on_disconnect at 0x7f292e262660> ret: None [1713033060676] [WARN] HUB Try to connect without uri-schema [1713033060676] [DBG] MQTT enter <function mqtt_transport.connect at 0x7f292e261ee0> ('x.ks.ua',) [1713033061679] [INFO] HUB Connected [1713033061679] [DBG] MQTT enter <function mqtt_transport.subscribe at 0x7f292e262160> ('>hub', <bound method HUB.__on_message of <uclient.hub.HUB object at 0x7f292de6c8d0>>) [1713033061722] [DBG] MQTT exit <function mqtt_transport.subscribe at 0x7f292e262160> ret: None [1713033061722] [DBG] MQTT enter <function mqtt_transport.subscribe at 0x7f292e262160> ('>user/dev', <bound method HUB.__on_message of <uclient.hub.HUB object at 0x7f292de6c8d0>>) [1713033061766] [DBG] MQTT exit <function mqtt_transport.subscribe at 0x7f292e262160> ret: None [1713033061766] [INFO] HUB (HUB) Subscribe to : {topic: /48:3f:da:55:07:5b/time } [1713033061766] [DBG] MQTT enter <function mqtt_transport.subscribe at 0x7f292e262160> ('/48:3f:da:55:07:5b/time', <bound method HUB.__on_message of <uclient.hub.HUB object at 0x7f292de6c8d0>>) [1713033061810] [DBG] MQTT exit <function mqtt_transport.subscribe at 0x7f292e262160> ret: None [1713033061810] [INFO] HUB (HUB) Subscribe to : {topic: >48:3f:da:55:07:5b/lifetime } [1713033061810] [DBG] MQTT enter <function mqtt_transport.subscribe at 0x7f292e262160> ('>48:3f:da:55:07:5b/lifetime', <bound method HUB.__on_message of <uclient.hub.HUB object at 0x7f292de6c8d0>>) [1713033061855] [DBG] MQTT exit <function mqtt_transport.subscribe at 0x7f292e262160> ret: None [1713033061855] [INFO] HUB (HUB) Subscribe to : {topic: >48:3f:da:55:07:5b/error } [1713033061855] [DBG] MQTT enter <function mqtt_transport.subscribe at 0x7f292e262160> ('>48:3f:da:55:07:5b/error', <bound method HUB.__on_message of <uclient.hub.HUB object at 0x7f292de6c8d0>>) [1713033061898] [DBG] MQTT exit <function mqtt_transport.subscribe at 0x7f292e262160> ret: None [1713033061898] [INFO] HUB (HUB) Subscribe to : {topic: >48:3f:da:55:07:5b/ping } [1713033061898] [DBG] MQTT enter <function mqtt_transport.subscribe at 0x7f292e262160> ('>48:3f:da:55:07:5b/ping', <bound method HUB.__on_message of <uclient.hub.HUB object at 0x7f292de6c8d0>>) [1713033061942] [DBG] MQTT exit <function mqtt_transport.subscribe at 0x7f292e262160> ret: None [1713033061942] [INFO] HUB (HUB) Subscribe to : {topic: >48:3f:da:55:07:5b/version } [1713033061942] [DBG] MQTT enter <function mqtt_transport.subscribe at 0x7f292e262160> ('>48:3f:da:55:07:5b/version', <bound method HUB.__on_message of <uclient.hub.HUB object at 0x7f292de6c8d0>>) [1713033061986] [DBG] MQTT exit <function mqtt_transport.subscribe at 0x7f292e262160> ret: None [1713033061986] [DBG] MQTT exit <function mqtt_transport.connect at 0x7f292e261ee0> ret: None [1713033061987] [DBG] HUB Step, state: 0 (next: 1713033062987) [1713033061987] [INFO] HUB Publish reg token: 48:3f:da:55:07:5b [1713033061987] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f292e262020> ('/reg', '48:3f:da:55:07:5b') [1713033062030] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f292e262020> ret: None [1713033062074] [INFO] HUB Message: {topic: /48:3f:da:55:07:5b/time, value: 1713033062036 } [1713033062074] [INFO] HUB Registration finish, time: 1713033062036 [1713033062074] [DBG] FW-UPD enter <function device_base.register at 0x7f292dff0360> (1713033062,) [1713033062074] [INFO] FW-UPD Device 3996365522 registration on the server @ 1713033062 [1713033062074] [INFO] HUB (HUB) Subscribe to : {topic: >48:3f:da:55:07:5b/3996365522/# } [1713033062074] [DBG] MQTT enter <function mqtt_transport.subscribe at 0x7f292e262160> ('>48:3f:da:55:07:5b/3996365522/#', <bound method HUB.__on_message of <uclient.hub.HUB object at 0x7f292de6c8d0>>) [1713033062118] [DBG] MQTT exit <function mqtt_transport.subscribe at 0x7f292e262160> ret: None [1713033062118] [DBG] FW-UPD exit <function device_base.register at 0x7f292dff0360> ret: None [1713033062987] [DBG] HUB Step, state: 1 (next: 1713033063987) [1713033062987] [DBG] FW-UPD enter <function device_base.info_req at 0x7f292dff0c20> () [1713033062987] [DBG] FW-UPD exit <function device_base.info_req at 0x7f292dff0c20> ret: {'s': 3996365522, 't': 1, 'r': {0: 3996365522, 1: 1713033062}} [1713033062987] [INFO] HUB Publish message: { topic: info, value: {"mac": "48:3f:da:55:07:5b", "version": "R240413;master;3ad924fe4d0ad95a2a5e5eda31858f370b1d89ff", "type": "mpy", "prot": 2, "devices": [{"s": 3996365522, "t": 1, "r": {"0": 3996365522, "1": 1713033062}}]} } [1713033062987] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f292e262020> ('/48:3f:da:55:07:5b/info', '{"mac": "48:3f:da:55:07:5b", "version": "R240413;master;3ad924fe4d0ad95a2a5e5eda31858f370b1d89ff", "type": "mpy", "prot": 2, "devices": [{"s": 3996365522, "t": 1, "r": {"0": 3996365522, "1": 1713033062}}]}') [1713033062987] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f292e262020> ret: None Waiting for status: 61 s [1713033122987] [DBG] HUB Step, state: 2 (next: 1713033182987) [1713033122987] [INFO] HUB Publish message: { topic: status, value: 0 } [1713033122987] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f292e262020> ('/48:3f:da:55:07:5b/status', 0) [1713033122987] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f292e262020> ret: None [1713033122987] [DBG] FW-UPD enter <function device_base.publish_status at 0x7f292dff0220> () [1713033122987] [INFO] HUB Publish message: { topic: 3996365522/status, value: 0 } [1713033122987] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f292e262020> ('<48:3f:da:55:07:5b/3996365522/status', 0) [1713033122987] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f292e262020> ret: None [1713033122987] [DBG] FW-UPD exit <function device_base.publish_status at 0x7f292dff0220> ret: None Start: 1713033123.0477502 [1713033123053] [DBG] FW-UPD enter <function device_base.set_reg at 0x7f292dff00e0> (8, 0) [1713033123053] [INFO] HUB Publish message: { topic: 3996365522/8, value: 0 } [1713033123053] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f292e262020> ('<48:3f:da:55:07:5b/3996365522/8', '0') [1713033123054] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f292e262020> ret: None [1713033123054] [DBG] FW-UPD exit <function device_base.set_reg at 0x7f292dff00e0> ret: None [1713033124056] [DBG] FW-UPD enter <function device_base.set_reg at 0x7f292dff00e0> (8, 1) [1713033124056] [INFO] HUB Publish message: { topic: 3996365522/8, value: 1 } [1713033124056] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f292e262020> ('<48:3f:da:55:07:5b/3996365522/8', '1') [1713033124058] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f292e262020> ret: None [1713033124058] [DBG] FW-UPD exit <function device_base.set_reg at 0x7f292dff00e0> ret: None [1713033125060] [DBG] FW-UPD enter <function device_base.set_reg at 0x7f292dff00e0> (8, 2) [1713033125060] [INFO] HUB Publish message: { topic: 3996365522/8, value: 2 } [1713033125060] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f292e262020> ('<48:3f:da:55:07:5b/3996365522/8', '2') [1713033125060] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f292e262020> ret: None [1713033125065] [DBG] FW-UPD exit <function device_base.set_reg at 0x7f292dff00e0> ret: None [1713033126067] [DBG] FW-UPD enter <function device_base.set_reg at 0x7f292dff00e0> (8, 3) [1713033126067] [INFO] HUB Publish message: { topic: 3996365522/8, value: 3 } [1713033126067] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f292e262020> ('<48:3f:da:55:07:5b/3996365522/8', '3') [1713033126067] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f292e262020> ret: None [1713033126069] [DBG] FW-UPD exit <function device_base.set_reg at 0x7f292dff00e0> ret: None [1713033127071] [DBG] FW-UPD enter <function device_base.set_reg at 0x7f292dff00e0> (8, 4) [1713033127072] [INFO] HUB Publish message: { topic: 3996365522/8, value: 4 } [1713033127072] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f292e262020> ('<48:3f:da:55:07:5b/3996365522/8', '4') [1713033127072] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f292e262020> ret: None [1713033127074] [DBG] FW-UPD exit <function device_base.set_reg at 0x7f292dff00e0> ret: None [1713033128076] [DBG] FW-UPD enter <function device_base.set_reg at 0x7f292dff00e0> (8, 5) [1713033128076] [INFO] HUB Publish message: { topic: 3996365522/8, value: 5 } [1713033128076] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f292e262020> ('<48:3f:da:55:07:5b/3996365522/8', '5') [1713033128076] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f292e262020> ret: None [1713033128076] [DBG] FW-UPD exit <function device_base.set_reg at 0x7f292dff00e0> ret: None [1713033129078] [DBG] FW-UPD enter <function device_base.set_reg at 0x7f292dff00e0> (8, 6) [1713033129078] [INFO] HUB Publish message: { topic: 3996365522/8, value: 6 } [1713033129078] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f292e262020> ('<48:3f:da:55:07:5b/3996365522/8', '6') [1713033129078] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f292e262020> ret: None [1713033129078] [DBG] FW-UPD exit <function device_base.set_reg at 0x7f292dff00e0> ret: None [1713033130080] [DBG] FW-UPD enter <function device_base.set_reg at 0x7f292dff00e0> (8, 7) [1713033130080] [INFO] HUB Publish message: { topic: 3996365522/8, value: 7 } [1713033130080] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f292e262020> ('<48:3f:da:55:07:5b/3996365522/8', '7') [1713033130081] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f292e262020> ret: None [1713033130083] [DBG] FW-UPD exit <function device_base.set_reg at 0x7f292dff00e0> ret: None [1713033131085] [DBG] FW-UPD enter <function device_base.set_reg at 0x7f292dff00e0> (8, 8) [1713033131085] [INFO] HUB Publish message: { topic: 3996365522/8, value: 8 } [1713033131085] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f292e262020> ('<48:3f:da:55:07:5b/3996365522/8', '8') [1713033131086] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f292e262020> ret: None [1713033131088] [DBG] FW-UPD exit <function device_base.set_reg at 0x7f292dff00e0> ret: None [1713033132090] [DBG] FW-UPD enter <function device_base.set_reg at 0x7f292dff00e0> (8, 9) [1713033132090] [INFO] HUB Publish message: { topic: 3996365522/8, value: 9 } [1713033132090] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f292e262020> ('<48:3f:da:55:07:5b/3996365522/8', '9') [1713033132091] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f292e262020> ret: None [1713033132091] [DBG] FW-UPD exit <function device_base.set_reg at 0x7f292dff00e0> ret: None [1713033133095] [DBG] FW-UPD enter <function device_base.set_reg at 0x7f292dff00e0> (8, 10) [1713033133095] [INFO] HUB Publish message: { topic: 3996365522/8, value: 10 } [1713033133095] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f292e262020> ('<48:3f:da:55:07:5b/3996365522/8', '10') [1713033133095] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f292e262020> ret: None [1713033133097] [DBG] FW-UPD exit <function device_base.set_reg at 0x7f292dff00e0> ret: None [1713033134098] [DBG] FW-UPD enter <function device_base.set_reg at 0x7f292dff00e0> (8, 11) [1713033134098] [INFO] HUB Publish message: { topic: 3996365522/8, value: 11 } [1713033134098] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f292e262020> ('<48:3f:da:55:07:5b/3996365522/8', '11') [1713033134098] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f292e262020> ret: None [1713033134098] [DBG] FW-UPD exit <function device_base.set_reg at 0x7f292dff00e0> ret: None [1713033135100] [DBG] FW-UPD enter <function device_base.set_reg at 0x7f292dff00e0> (8, 12) [1713033135100] [INFO] HUB Publish message: { topic: 3996365522/8, value: 12 } [1713033135100] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f292e262020> ('<48:3f:da:55:07:5b/3996365522/8', '12') [1713033135101] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f292e262020> ret: None [1713033135101] [DBG] FW-UPD exit <function device_base.set_reg at 0x7f292dff00e0> ret: None [1713033136105] [DBG] FW-UPD enter <function device_base.set_reg at 0x7f292dff00e0> (8, 13) [1713033136105] [INFO] HUB Publish message: { topic: 3996365522/8, value: 13 } [1713033136105] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f292e262020> ('<48:3f:da:55:07:5b/3996365522/8', '13') [1713033136106] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f292e262020> ret: None [1713033136106] [DBG] FW-UPD exit <function device_base.set_reg at 0x7f292dff00e0> ret: None [1713033137107] [DBG] FW-UPD enter <function device_base.set_reg at 0x7f292dff00e0> (8, 14) [1713033137107] [INFO] HUB Publish message: { topic: 3996365522/8, value: 14 } [1713033137107] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f292e262020> ('<48:3f:da:55:07:5b/3996365522/8', '14') [1713033137107] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f292e262020> ret: None [1713033137107] [DBG] FW-UPD exit <function device_base.set_reg at 0x7f292dff00e0> ret: None [1713033138109] [DBG] FW-UPD enter <function device_base.set_reg at 0x7f292dff00e0> (8, 15) [1713033138110] [INFO] HUB Publish message: { topic: 3996365522/8, value: 15 } [1713033138110] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f292e262020> ('<48:3f:da:55:07:5b/3996365522/8', '15') [1713033138110] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f292e262020> ret: None [1713033138112] [DBG] FW-UPD exit <function device_base.set_reg at 0x7f292dff00e0> ret: None [1713033139113] [DBG] FW-UPD enter <function device_base.set_reg at 0x7f292dff00e0> (8, 16) [1713033139113] [INFO] HUB Publish message: { topic: 3996365522/8, value: 16 } [1713033139113] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f292e262020> ('<48:3f:da:55:07:5b/3996365522/8', '16') [1713033139114] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f292e262020> ret: None [1713033139114] [DBG] FW-UPD exit <function device_base.set_reg at 0x7f292dff00e0> ret: None [1713033140117] [DBG] FW-UPD enter <function device_base.set_reg at 0x7f292dff00e0> (8, 17) [1713033140117] [INFO] HUB Publish message: { topic: 3996365522/8, value: 17 } [1713033140117] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f292e262020> ('<48:3f:da:55:07:5b/3996365522/8', '17') [1713033140117] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f292e262020> ret: None [1713033140120] [DBG] FW-UPD exit <function device_base.set_reg at 0x7f292dff00e0> ret: None [1713033141121] [DBG] FW-UPD enter <function device_base.set_reg at 0x7f292dff00e0> (8, 18) [1713033141121] [INFO] HUB Publish message: { topic: 3996365522/8, value: 18 } [1713033141121] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f292e262020> ('<48:3f:da:55:07:5b/3996365522/8', '18') [1713033141121] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f292e262020> ret: None [1713033141121] [DBG] FW-UPD exit <function device_base.set_reg at 0x7f292dff00e0> ret: None [1713033142123] [DBG] FW-UPD enter <function device_base.set_reg at 0x7f292dff00e0> (8, 19) [1713033142123] [INFO] HUB Publish message: { topic: 3996365522/8, value: 19 } [1713033142123] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f292e262020> ('<48:3f:da:55:07:5b/3996365522/8', '19') [1713033142123] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f292e262020> ret: None [1713033142125] [DBG] FW-UPD exit <function device_base.set_reg at 0x7f292dff00e0> ret: None [1713033143126] [DBG] FW-UPD enter <function device_base.set_reg at 0x7f292dff00e0> (8, 20) [1713033143126] [INFO] HUB Publish message: { topic: 3996365522/8, value: 20 } [1713033143126] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f292e262020> ('<48:3f:da:55:07:5b/3996365522/8', '20') [1713033143127] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f292e262020> ret: None [1713033143127] [DBG] FW-UPD exit <function device_base.set_reg at 0x7f292dff00e0> ret: None [1713033144129] [DBG] FW-UPD enter <function device_base.set_reg at 0x7f292dff00e0> (8, 21) [1713033144129] [INFO] HUB Publish message: { topic: 3996365522/8, value: 21 } [1713033144129] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f292e262020> ('<48:3f:da:55:07:5b/3996365522/8', '21') [1713033144129] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f292e262020> ret: None [1713033144132] [DBG] FW-UPD exit <function device_base.set_reg at 0x7f292dff00e0> ret: None [1713033145133] [DBG] FW-UPD enter <function device_base.set_reg at 0x7f292dff00e0> (8, 22) [1713033145133] [INFO] HUB Publish message: { topic: 3996365522/8, value: 22 } [1713033145133] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f292e262020> ('<48:3f:da:55:07:5b/3996365522/8', '22') [1713033145133] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f292e262020> ret: None [1713033145133] [DBG] FW-UPD exit <function device_base.set_reg at 0x7f292dff00e0> ret: None [1713033146135] [DBG] FW-UPD enter <function device_base.set_reg at 0x7f292dff00e0> (8, 23) [1713033146135] [INFO] HUB Publish message: { topic: 3996365522/8, value: 23 } [1713033146135] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f292e262020> ('<48:3f:da:55:07:5b/3996365522/8', '23') [1713033146136] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f292e262020> ret: None [1713033146136] [DBG] FW-UPD exit <function device_base.set_reg at 0x7f292dff00e0> ret: None [1713033147138] [DBG] FW-UPD enter <function device_base.set_reg at 0x7f292dff00e0> (8, 24) [1713033147138] [INFO] HUB Publish message: { topic: 3996365522/8, value: 24 } [1713033147138] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f292e262020> ('<48:3f:da:55:07:5b/3996365522/8', '24') [1713033147139] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f292e262020> ret: None [1713033147141] [DBG] FW-UPD exit <function device_base.set_reg at 0x7f292dff00e0> ret: None [1713033148143] [DBG] FW-UPD enter <function device_base.set_reg at 0x7f292dff00e0> (8, 25) [1713033148143] [INFO] HUB Publish message: { topic: 3996365522/8, value: 25 } [1713033148143] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f292e262020> ('<48:3f:da:55:07:5b/3996365522/8', '25') [1713033148144] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f292e262020> ret: None [1713033148146] [DBG] FW-UPD exit <function device_base.set_reg at 0x7f292dff00e0> ret: None [1713033149150] [DBG] FW-UPD enter <function device_base.set_reg at 0x7f292dff00e0> (8, 26) [1713033149150] [INFO] HUB Publish message: { topic: 3996365522/8, value: 26 } [1713033149150] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f292e262020> ('<48:3f:da:55:07:5b/3996365522/8', '26') [1713033149150] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f292e262020> ret: None [1713033149150] [DBG] FW-UPD exit <function device_base.set_reg at 0x7f292dff00e0> ret: None [1713033150152] [DBG] FW-UPD enter <function device_base.set_reg at 0x7f292dff00e0> (8, 27) [1713033150152] [INFO] HUB Publish message: { topic: 3996365522/8, value: 27 } [1713033150152] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f292e262020> ('<48:3f:da:55:07:5b/3996365522/8', '27') [1713033150152] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f292e262020> ret: None [1713033150152] [DBG] FW-UPD exit <function device_base.set_reg at 0x7f292dff00e0> ret: None [1713033151156] [DBG] FW-UPD enter <function device_base.set_reg at 0x7f292dff00e0> (8, 28) [1713033151156] [INFO] HUB Publish message: { topic: 3996365522/8, value: 28 } [1713033151156] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f292e262020> ('<48:3f:da:55:07:5b/3996365522/8', '28') [1713033151156] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f292e262020> ret: None [1713033151158] [DBG] FW-UPD exit <function device_base.set_reg at 0x7f292dff00e0> ret: None [1713033152160] [DBG] FW-UPD enter <function device_base.set_reg at 0x7f292dff00e0> (8, 29) [1713033152160] [INFO] HUB Publish message: { topic: 3996365522/8, value: 29 } [1713033152160] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f292e262020> ('<48:3f:da:55:07:5b/3996365522/8', '29') [1713033152160] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f292e262020> ret: None [1713033152160] [DBG] FW-UPD exit <function device_base.set_reg at 0x7f292dff00e0> ret: None Waiting for status: 61 s [1713033182987] [DBG] HUB Step, state: 2 (next: 1713033242987) [1713033182987] [INFO] HUB Publish message: { topic: status, value: 30 } [1713033182987] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f292e262020> ('/48:3f:da:55:07:5b/status', 30) [1713033182988] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f292e262020> ret: None [1713033182988] [DBG] FW-UPD enter <function device_base.publish_status at 0x7f292dff0220> () [1713033182988] [INFO] HUB Publish message: { topic: 3996365522/status, value: 30 } [1713033182988] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f292e262020> ('<48:3f:da:55:07:5b/3996365522/status', 30) [1713033182988] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f292e262020> ret: None [1713033182988] [DBG] FW-UPD exit <function device_base.publish_status at 0x7f292dff0220> ret: None Stop: 1713033183.0080438; diff: 59.96029353141785 [1713033183020] [INFO] HUB Message: {topic: >48:3f:da:55:07:5b/lifetime, value: 120 } [1713033183020] [INFO] HUB Set new lifetime: 120 Waiting for status: 121 s [1713033302987] [DBG] HUB Step, state: 2 (next: 1713033422987) [1713033302987] [INFO] HUB Publish message: { topic: status, value: 30 } [1713033302987] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f292e262020> ('/48:3f:da:55:07:5b/status', 30) [1713033302987] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f292e262020> ret: None [1713033302987] [DBG] FW-UPD enter <function device_base.publish_status at 0x7f292dff0220> () [1713033302987] [INFO] HUB Publish message: { topic: 3996365522/status, value: 30 } [1713033302987] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f292e262020> ('<48:3f:da:55:07:5b/3996365522/status', 30) [1713033302987] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f292e262020> ret: None [1713033302987] [DBG] FW-UPD exit <function device_base.publish_status at 0x7f292dff0220> ret: None Start: 1713033303.0487034 [1713033303051] [DBG] FW-UPD enter <function device_base.set_reg at 0x7f292dff00e0> (8, 0) [1713033303051] [INFO] HUB Publish message: { topic: 3996365522/8, value: 0 } [1713033303051] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f292e262020> ('<48:3f:da:55:07:5b/3996365522/8', '0') [1713033303052] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f292e262020> ret: None [1713033303052] [DBG] FW-UPD exit <function device_base.set_reg at 0x7f292dff00e0> ret: None [1713033304053] [DBG] FW-UPD enter <function device_base.set_reg at 0x7f292dff00e0> (8, 1) [1713033304053] [INFO] HUB Publish message: { topic: 3996365522/8, value: 1 } [1713033304053] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f292e262020> ('<48:3f:da:55:07:5b/3996365522/8', '1') [1713033304058] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f292e262020> ret: None [1713033304058] [DBG] FW-UPD exit <function device_base.set_reg at 0x7f292dff00e0> ret: None [1713033305060] [DBG] FW-UPD enter <function device_base.set_reg at 0x7f292dff00e0> (8, 2) [1713033305061] [INFO] HUB Publish message: { topic: 3996365522/8, value: 2 } [1713033305061] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f292e262020> ('<48:3f:da:55:07:5b/3996365522/8', '2') [1713033305061] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f292e262020> ret: None [1713033305061] [DBG] FW-UPD exit <function device_base.set_reg at 0x7f292dff00e0> ret: None [1713033306063] [DBG] FW-UPD enter <function device_base.set_reg at 0x7f292dff00e0> (8, 3) [1713033306063] [INFO] HUB Publish message: { topic: 3996365522/8, value: 3 } [1713033306063] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f292e262020> ('<48:3f:da:55:07:5b/3996365522/8', '3') [1713033306064] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f292e262020> ret: None [1713033306064] [DBG] FW-UPD exit <function device_base.set_reg at 0x7f292dff00e0> ret: None [1713033307066] [DBG] FW-UPD enter <function device_base.set_reg at 0x7f292dff00e0> (8, 4) [1713033307066] [INFO] HUB Publish message: { topic: 3996365522/8, value: 4 } [1713033307066] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f292e262020> ('<48:3f:da:55:07:5b/3996365522/8', '4') [1713033307066] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f292e262020> ret: None [1713033307066] [DBG] FW-UPD exit <function device_base.set_reg at 0x7f292dff00e0> ret: None [1713033308068] [DBG] FW-UPD enter <function device_base.set_reg at 0x7f292dff00e0> (8, 5) [1713033308068] [INFO] HUB Publish message: { topic: 3996365522/8, value: 5 } [1713033308068] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f292e262020> ('<48:3f:da:55:07:5b/3996365522/8', '5') [1713033308070] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f292e262020> ret: None [1713033308070] [DBG] FW-UPD exit <function device_base.set_reg at 0x7f292dff00e0> ret: None [1713033309070] [DBG] FW-UPD enter <function device_base.set_reg at 0x7f292dff00e0> (8, 6) [1713033309070] [INFO] HUB Publish message: { topic: 3996365522/8, value: 6 } [1713033309070] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f292e262020> ('<48:3f:da:55:07:5b/3996365522/8', '6') [1713033309070] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f292e262020> ret: None [1713033309070] [DBG] FW-UPD exit <function device_base.set_reg at 0x7f292dff00e0> ret: None [1713033310073] [DBG] FW-UPD enter <function device_base.set_reg at 0x7f292dff00e0> (8, 7) [1713033310073] [INFO] HUB Publish message: { topic: 3996365522/8, value: 7 } [1713033310073] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f292e262020> ('<48:3f:da:55:07:5b/3996365522/8', '7') [1713033310073] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f292e262020> ret: None [1713033310076] [DBG] FW-UPD exit <function device_base.set_reg at 0x7f292dff00e0> ret: None [1713033311077] [DBG] FW-UPD enter <function device_base.set_reg at 0x7f292dff00e0> (8, 8) [1713033311077] [INFO] HUB Publish message: { topic: 3996365522/8, value: 8 } [1713033311077] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f292e262020> ('<48:3f:da:55:07:5b/3996365522/8', '8') [1713033311077] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f292e262020> ret: None [1713033311077] [DBG] FW-UPD exit <function device_base.set_reg at 0x7f292dff00e0> ret: None [1713033312079] [DBG] FW-UPD enter <function device_base.set_reg at 0x7f292dff00e0> (8, 9) [1713033312079] [INFO] HUB Publish message: { topic: 3996365522/8, value: 9 } [1713033312079] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f292e262020> ('<48:3f:da:55:07:5b/3996365522/8', '9') [1713033312079] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f292e262020> ret: None [1713033312079] [DBG] FW-UPD exit <function device_base.set_reg at 0x7f292dff00e0> ret: None [1713033313084] [DBG] FW-UPD enter <function device_base.set_reg at 0x7f292dff00e0> (8, 10) [1713033313084] [INFO] HUB Publish message: { topic: 3996365522/8, value: 10 } [1713033313085] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f292e262020> ('<48:3f:da:55:07:5b/3996365522/8', '10') [1713033313085] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f292e262020> ret: None [1713033313087] [DBG] FW-UPD exit <function device_base.set_reg at 0x7f292dff00e0> ret: None [1713033314089] [DBG] FW-UPD enter <function device_base.set_reg at 0x7f292dff00e0> (8, 11) [1713033314089] [INFO] HUB Publish message: { topic: 3996365522/8, value: 11 } [1713033314090] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f292e262020> ('<48:3f:da:55:07:5b/3996365522/8', '11') [1713033314093] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f292e262020> ret: None [1713033314093] [DBG] FW-UPD exit <function device_base.set_reg at 0x7f292dff00e0> ret: None [1713033315094] [DBG] FW-UPD enter <function device_base.set_reg at 0x7f292dff00e0> (8, 12) [1713033315094] [INFO] HUB Publish message: { topic: 3996365522/8, value: 12 } [1713033315094] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f292e262020> ('<48:3f:da:55:07:5b/3996365522/8', '12') [1713033315094] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f292e262020> ret: None [1713033315094] [DBG] FW-UPD exit <function device_base.set_reg at 0x7f292dff00e0> ret: None [1713033316096] [DBG] FW-UPD enter <function device_base.set_reg at 0x7f292dff00e0> (8, 13) [1713033316096] [INFO] HUB Publish message: { topic: 3996365522/8, value: 13 } [1713033316096] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f292e262020> ('<48:3f:da:55:07:5b/3996365522/8', '13') [1713033316099] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f292e262020> ret: None [1713033316099] [DBG] FW-UPD exit <function device_base.set_reg at 0x7f292dff00e0> ret: None [1713033317101] [DBG] FW-UPD enter <function device_base.set_reg at 0x7f292dff00e0> (8, 14) [1713033317101] [INFO] HUB Publish message: { topic: 3996365522/8, value: 14 } [1713033317101] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f292e262020> ('<48:3f:da:55:07:5b/3996365522/8', '14') [1713033317102] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f292e262020> ret: None [1713033317104] [DBG] FW-UPD exit <function device_base.set_reg at 0x7f292dff00e0> ret: None [1713033318107] [DBG] FW-UPD enter <function device_base.set_reg at 0x7f292dff00e0> (8, 15) [1713033318107] [INFO] HUB Publish message: { topic: 3996365522/8, value: 15 } [1713033318107] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f292e262020> ('<48:3f:da:55:07:5b/3996365522/8', '15') [1713033318107] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f292e262020> ret: None [1713033318109] [DBG] FW-UPD exit <function device_base.set_reg at 0x7f292dff00e0> ret: None [1713033319112] [DBG] FW-UPD enter <function device_base.set_reg at 0x7f292dff00e0> (8, 16) [1713033319112] [INFO] HUB Publish message: { topic: 3996365522/8, value: 16 } [1713033319112] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f292e262020> ('<48:3f:da:55:07:5b/3996365522/8', '16') [1713033319112] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f292e262020> ret: None [1713033319114] [DBG] FW-UPD exit <function device_base.set_reg at 0x7f292dff00e0> ret: None [1713033320116] [DBG] FW-UPD enter <function device_base.set_reg at 0x7f292dff00e0> (8, 17) [1713033320116] [INFO] HUB Publish message: { topic: 3996365522/8, value: 17 } [1713033320116] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f292e262020> ('<48:3f:da:55:07:5b/3996365522/8', '17') [1713033320117] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f292e262020> ret: None [1713033320119] [DBG] FW-UPD exit <function device_base.set_reg at 0x7f292dff00e0> ret: None [1713033321121] [DBG] FW-UPD enter <function device_base.set_reg at 0x7f292dff00e0> (8, 18) [1713033321121] [INFO] HUB Publish message: { topic: 3996365522/8, value: 18 } [1713033321121] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f292e262020> ('<48:3f:da:55:07:5b/3996365522/8', '18') [1713033321121] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f292e262020> ret: None [1713033321125] [DBG] FW-UPD exit <function device_base.set_reg at 0x7f292dff00e0> ret: None [1713033322126] [DBG] FW-UPD enter <function device_base.set_reg at 0x7f292dff00e0> (8, 19) [1713033322126] [INFO] HUB Publish message: { topic: 3996365522/8, value: 19 } [1713033322126] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f292e262020> ('<48:3f:da:55:07:5b/3996365522/8', '19') [1713033322126] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f292e262020> ret: None [1713033322128] [DBG] FW-UPD exit <function device_base.set_reg at 0x7f292dff00e0> ret: None [1713033323131] [DBG] FW-UPD enter <function device_base.set_reg at 0x7f292dff00e0> (8, 20) [1713033323131] [INFO] HUB Publish message: { topic: 3996365522/8, value: 20 } [1713033323131] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f292e262020> ('<48:3f:da:55:07:5b/3996365522/8', '20') [1713033323131] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f292e262020> ret: None [1713033323133] [DBG] FW-UPD exit <function device_base.set_reg at 0x7f292dff00e0> ret: None [1713033324134] [DBG] FW-UPD enter <function device_base.set_reg at 0x7f292dff00e0> (8, 21) [1713033324134] [INFO] HUB Publish message: { topic: 3996365522/8, value: 21 } [1713033324134] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f292e262020> ('<48:3f:da:55:07:5b/3996365522/8', '21') [1713033324135] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f292e262020> ret: None [1713033324135] [DBG] FW-UPD exit <function device_base.set_reg at 0x7f292dff00e0> ret: None [1713033325137] [DBG] FW-UPD enter <function device_base.set_reg at 0x7f292dff00e0> (8, 22) [1713033325137] [INFO] HUB Publish message: { topic: 3996365522/8, value: 22 } [1713033325137] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f292e262020> ('<48:3f:da:55:07:5b/3996365522/8', '22') [1713033325138] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f292e262020> ret: None [1713033325140] [DBG] FW-UPD exit <function device_base.set_reg at 0x7f292dff00e0> ret: None [1713033326144] [DBG] FW-UPD enter <function device_base.set_reg at 0x7f292dff00e0> (8, 23) [1713033326145] [INFO] HUB Publish message: { topic: 3996365522/8, value: 23 } [1713033326145] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f292e262020> ('<48:3f:da:55:07:5b/3996365522/8', '23') [1713033326145] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f292e262020> ret: None [1713033326145] [DBG] FW-UPD exit <function device_base.set_reg at 0x7f292dff00e0> ret: None [1713033327147] [DBG] FW-UPD enter <function device_base.set_reg at 0x7f292dff00e0> (8, 24) [1713033327147] [INFO] HUB Publish message: { topic: 3996365522/8, value: 24 } [1713033327147] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f292e262020> ('<48:3f:da:55:07:5b/3996365522/8', '24') [1713033327148] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f292e262020> ret: None [1713033327148] [DBG] FW-UPD exit <function device_base.set_reg at 0x7f292dff00e0> ret: None [1713033328153] [DBG] FW-UPD enter <function device_base.set_reg at 0x7f292dff00e0> (8, 25) [1713033328153] [INFO] HUB Publish message: { topic: 3996365522/8, value: 25 } [1713033328153] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f292e262020> ('<48:3f:da:55:07:5b/3996365522/8', '25') [1713033328153] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f292e262020> ret: None [1713033328153] [DBG] FW-UPD exit <function device_base.set_reg at 0x7f292dff00e0> ret: None [1713033329156] [DBG] FW-UPD enter <function device_base.set_reg at 0x7f292dff00e0> (8, 26) [1713033329156] [INFO] HUB Publish message: { topic: 3996365522/8, value: 26 } [1713033329156] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f292e262020> ('<48:3f:da:55:07:5b/3996365522/8', '26') [1713033329157] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f292e262020> ret: None [1713033329159] [DBG] FW-UPD exit <function device_base.set_reg at 0x7f292dff00e0> ret: None [1713033330161] [DBG] FW-UPD enter <function device_base.set_reg at 0x7f292dff00e0> (8, 27) [1713033330161] [INFO] HUB Publish message: { topic: 3996365522/8, value: 27 } [1713033330161] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f292e262020> ('<48:3f:da:55:07:5b/3996365522/8', '27') [1713033330161] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f292e262020> ret: None [1713033330161] [DBG] FW-UPD exit <function device_base.set_reg at 0x7f292dff00e0> ret: None [1713033331166] [DBG] FW-UPD enter <function device_base.set_reg at 0x7f292dff00e0> (8, 28) [1713033331166] [INFO] HUB Publish message: { topic: 3996365522/8, value: 28 } [1713033331166] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f292e262020> ('<48:3f:da:55:07:5b/3996365522/8', '28') [1713033331166] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f292e262020> ret: None [1713033331166] [DBG] FW-UPD exit <function device_base.set_reg at 0x7f292dff00e0> ret: None [1713033332171] [DBG] FW-UPD enter <function device_base.set_reg at 0x7f292dff00e0> (8, 29) [1713033332171] [INFO] HUB Publish message: { topic: 3996365522/8, value: 29 } [1713033332171] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f292e262020> ('<48:3f:da:55:07:5b/3996365522/8', '29') [1713033332171] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f292e262020> ret: None [1713033332174] [DBG] FW-UPD exit <function device_base.set_reg at 0x7f292dff00e0> ret: None Waiting for status: 121 s [1713033422987] [DBG] HUB Step, state: 2 (next: 1713033542987) [1713033422987] [INFO] HUB Publish message: { topic: status, value: 60 } [1713033422987] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f292e262020> ('/48:3f:da:55:07:5b/status', 60) [1713033422987] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f292e262020> ret: None [1713033422987] [DBG] FW-UPD enter <function device_base.publish_status at 0x7f292dff0220> () [1713033422987] [INFO] HUB Publish message: { topic: 3996365522/status, value: 60 } [1713033422987] [DBG] MQTT enter <function mqtt_transport.publish at 0x7f292e262020> ('<48:3f:da:55:07:5b/3996365522/status', 60) [1713033422987] [DBG] MQTT exit <function mqtt_transport.publish at 0x7f292e262020> ret: None [1713033422987] [DBG] FW-UPD exit <function device_base.publish_status at 0x7f292dff0220> ret: None Stop: 1713033423.0383546; diff: 119.98965120315552 Lifetime: 240.01820707321167 [1713033423039] [DBG] MQTT enter <function mqtt_transport.disconnect at 0x7f292e2623e0> () [1713033423040] [DBG] MQTT exit <function mqtt_transport.disconnect at 0x7f292e2623e0> ret: None [1713033423040] [WARN] HUB Disconecting from broker

Suite stderr:

2024-04-13 18:31:02,992 - TEST - INFO - OP take: 1005.21 ms 2024-04-13 18:31:03,001 - TEST - INFO - Connected with result code: 0 2024-04-13 18:31:03,005 - TEST - INFO - OP take: 10.098 ms 2024-04-13 18:32:03,048 - TEST - INFO - OP take: 59042.524 ms 2024-04-13 18:33:03,017 - TEST - INFO - OP take: 29856.928 ms 2024-04-13 18:33:03,019 - TEST - INFO - [hub] => { 'lifetime' : '120' } 2024-04-13 18:35:03,049 - TEST - INFO - OP take: 119027.197 ms 2024-04-13 18:37:03,037 - TEST - INFO - OP take: 89863.477 ms 2024-04-13 18:37:03,045 - TEST - WARNING - Disconecting from broker 2024-04-13 18:37:03,058 - TEST - WARNING - Disconecting from broker