TEST-user_list_test-20240505094048.xml

Test Report : TEST-user_list_test-20240505094048.xml

user_list_test
- test

Test Suite: user_list_test-20240505094048

Results

Duration	4.167 sec
Tests	1
Failures	0

Tests

user_list_test

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

None

Suite stdout:

[1714902048579] [INFO] DEV-3996365522 Device 3996365522 (type: 1) has been created [1714902048579] [DBG] DEV-3996365522 enter <function device_base.set_hub at 0x7fdec1a33c40> (<uclient.hub.HUB object at 0x7fdec0d73fd0>,) [1714902048579] [DBG] DEV-3996365522 exit <function device_base.set_hub at 0x7fdec1a33c40> ret: None [1714902048579] [DBG] HUB enter <function HUB.register_root_cb at 0x7fdec0f04a40> ('>user/dev', <bound method user_device.on_user_dev of <uclient.userdev.user_device object at 0x7fdec0d728d0>>) [1714902048579] [DBG] HUB exit <function HUB.register_root_cb at 0x7fdec0f04a40> ret: None [1714902048580] [DBG] MQTT enter <function mqtt_transport.set_lastwill at 0x7fdec0f06160> ('<48:3f:da:55:07:5c/status', '-1') [1714902048580] [DBG] MQTT exit <function mqtt_transport.set_lastwill at 0x7fdec0f06160> ret: None [1714902048580] [DBG] MQTT enter <function mqtt_transport.on_connect at 0x7fdec0f063e0> (<bound method log.dbg_wr.<locals>.wrapper of <uclient.hub.HUB object at 0x7fdec0d73fd0>>,) [1714902048580] [DBG] MQTT exit <function mqtt_transport.on_connect at 0x7fdec0f063e0> ret: None [1714902048580] [DBG] MQTT enter <function mqtt_transport.on_disconnect at 0x7fdec0f062a0> (<bound method log.dbg_wr.<locals>.wrapper of <uclient.hub.HUB object at 0x7fdec0d73fd0>>,) [1714902048580] [DBG] MQTT exit <function mqtt_transport.on_disconnect at 0x7fdec0f062a0> ret: None [1714902048580] [DBG] HUB enter <function HUB.connect at 0x7fdec0f59a80> () [1714902048580] [WARN] HUB Try to connect without uri-schema [1714902048580] [DBG] MQTT enter <function mqtt_transport.connect at 0x7fdec0f06a20> ('x.ks.ua',) [1714902049585] [DBG] HUB enter <function HUB.__on_connect at 0x7fdec0f05080> () [1714902049585] [INFO] HUB Connected [1714902049585] [DBG] MQTT enter <function mqtt_transport.subscribe at 0x7fdec0f067a0> ('>hub', <bound method log.dbg_wr.<locals>.wrapper of <uclient.hub.HUB object at 0x7fdec0d73fd0>>) [1714902049585] [DBG] MQTT exit <function mqtt_transport.subscribe at 0x7fdec0f067a0> ret: None [1714902049585] [DBG] MQTT enter <function mqtt_transport.subscribe at 0x7fdec0f067a0> ('>user/dev', <bound method log.dbg_wr.<locals>.wrapper of <uclient.hub.HUB object at 0x7fdec0d73fd0>>) [1714902049585] [DBG] MQTT exit <function mqtt_transport.subscribe at 0x7fdec0f067a0> ret: None [1714902049586] [DBG] HUB enter <function HUB.subscribe_hub at 0x7fdec0f05940> ('time', '/') [1714902049586] [INFO] HUB (HUB) Subscribe to : {topic: /48:3f:da:55:07:5c/time } [1714902049586] [DBG] MQTT enter <function mqtt_transport.subscribe at 0x7fdec0f067a0> ('/48:3f:da:55:07:5c/time', <bound method log.dbg_wr.<locals>.wrapper of <uclient.hub.HUB object at 0x7fdec0d73fd0>>) [1714902049586] [DBG] MQTT exit <function mqtt_transport.subscribe at 0x7fdec0f067a0> ret: None [1714902049586] [DBG] HUB exit <function HUB.subscribe_hub at 0x7fdec0f05940> ret: None [1714902049586] [DBG] HUB enter <function HUB.subscribe_hub at 0x7fdec0f05940> ('lifetime', '>') [1714902049586] [INFO] HUB (HUB) Subscribe to : {topic: >48:3f:da:55:07:5c/lifetime } [1714902049586] [DBG] MQTT enter <function mqtt_transport.subscribe at 0x7fdec0f067a0> ('>48:3f:da:55:07:5c/lifetime', <bound method log.dbg_wr.<locals>.wrapper of <uclient.hub.HUB object at 0x7fdec0d73fd0>>) [1714902049586] [DBG] MQTT exit <function mqtt_transport.subscribe at 0x7fdec0f067a0> ret: None [1714902049586] [DBG] HUB exit <function HUB.subscribe_hub at 0x7fdec0f05940> ret: None [1714902049586] [DBG] HUB enter <function HUB.subscribe_hub at 0x7fdec0f05940> ('error', '>') [1714902049586] [INFO] HUB (HUB) Subscribe to : {topic: >48:3f:da:55:07:5c/error } [1714902049586] [DBG] MQTT enter <function mqtt_transport.subscribe at 0x7fdec0f067a0> ('>48:3f:da:55:07:5c/error', <bound method log.dbg_wr.<locals>.wrapper of <uclient.hub.HUB object at 0x7fdec0d73fd0>>) [1714902049586] [DBG] MQTT exit <function mqtt_transport.subscribe at 0x7fdec0f067a0> ret: None [1714902049586] [DBG] HUB exit <function HUB.subscribe_hub at 0x7fdec0f05940> ret: None [1714902049586] [DBG] HUB enter <function HUB.subscribe_hub at 0x7fdec0f05940> ('ping', '>') [1714902049586] [INFO] HUB (HUB) Subscribe to : {topic: >48:3f:da:55:07:5c/ping } [1714902049586] [DBG] MQTT enter <function mqtt_transport.subscribe at 0x7fdec0f067a0> ('>48:3f:da:55:07:5c/ping', <bound method log.dbg_wr.<locals>.wrapper of <uclient.hub.HUB object at 0x7fdec0d73fd0>>) [1714902049586] [DBG] MQTT exit <function mqtt_transport.subscribe at 0x7fdec0f067a0> ret: None [1714902049586] [DBG] HUB exit <function HUB.subscribe_hub at 0x7fdec0f05940> ret: None [1714902049586] [DBG] HUB enter <function HUB.subscribe_hub at 0x7fdec0f05940> ('version', '>') [1714902049586] [INFO] HUB (HUB) Subscribe to : {topic: >48:3f:da:55:07:5c/version } [1714902049586] [DBG] MQTT enter <function mqtt_transport.subscribe at 0x7fdec0f067a0> ('>48:3f:da:55:07:5c/version', <bound method log.dbg_wr.<locals>.wrapper of <uclient.hub.HUB object at 0x7fdec0d73fd0>>) [1714902049586] [DBG] MQTT exit <function mqtt_transport.subscribe at 0x7fdec0f067a0> ret: None [1714902049586] [DBG] HUB exit <function HUB.subscribe_hub at 0x7fdec0f05940> ret: None [1714902049586] [DBG] HUB exit <function HUB.__on_connect at 0x7fdec0f05080> ret: None [1714902049586] [DBG] MQTT exit <function mqtt_transport.connect at 0x7fdec0f06a20> ret: None [1714902049586] [DBG] HUB exit <function HUB.connect at 0x7fdec0f59a80> ret: None [1714902049597] [DBG] HUB Step, state: 0 (next: 1714902050597) [1714902049597] [DBG] HUB enter <function HUB.__send_reg at 0x7fdec0f051c0> () [1714902049597] [INFO] HUB Publish reg token: 48:3f:da:55:07:5c [1714902049597] [DBG] MQTT enter <function mqtt_transport.publish at 0x7fdec0f068e0> ('/reg', '48:3f:da:55:07:5c') [1714902049597] [DBG] MQTT exit <function mqtt_transport.publish at 0x7fdec0f068e0> ret: None [1714902049597] [DBG] HUB exit <function HUB.__send_reg at 0x7fdec0f051c0> ret: None [1714902050603] [DBG] HUB Step, state: 0 (next: 1714902051603) [1714902050603] [DBG] HUB enter <function HUB.__send_reg at 0x7fdec0f051c0> () [1714902050603] [INFO] HUB Publish reg token: 48:3f:da:55:07:5c [1714902050603] [DBG] MQTT enter <function mqtt_transport.publish at 0x7fdec0f068e0> ('/reg', '48:3f:da:55:07:5c') [1714902050604] [DBG] MQTT exit <function mqtt_transport.publish at 0x7fdec0f068e0> ret: None [1714902050604] [DBG] HUB exit <function HUB.__send_reg at 0x7fdec0f051c0> ret: None [1714902050651] [DBG] HUB enter <function HUB.__on_message at 0x7fdec0f04cc0> ('/48:3f:da:55:07:5c/time', b'1714902050650') [1714902050651] [INFO] HUB Message: {topic: /48:3f:da:55:07:5c/time, value: 1714902050650 } [1714902050651] [DBG] HUB enter <function HUB.__time_hnd at 0x7fdec0f05800> ('1714902050650',) [1714902050651] [INFO] HUB Registration finish, time: 1714902050650 [1714902050651] [DBG] DEV-3996365522 enter <function device_base.register at 0x7fdec1a54180> (1714902050,) [1714902050651] [INFO] DEV-3996365522 Device 3996365522 registration on the server @ 1714902050 [1714902050651] [DBG] HUB enter <function HUB.subscribe_hub at 0x7fdec0f05940> ('3996365522/#', '>') [1714902050651] [INFO] HUB (HUB) Subscribe to : {topic: >48:3f:da:55:07:5c/3996365522/# } [1714902050651] [DBG] MQTT enter <function mqtt_transport.subscribe at 0x7fdec0f067a0> ('>48:3f:da:55:07:5c/3996365522/#', <bound method log.dbg_wr.<locals>.wrapper of <uclient.hub.HUB object at 0x7fdec0d73fd0>>) [1714902050652] [DBG] MQTT exit <function mqtt_transport.subscribe at 0x7fdec0f067a0> ret: None [1714902050652] [DBG] HUB exit <function HUB.subscribe_hub at 0x7fdec0f05940> ret: None [1714902050652] [DBG] DEV-3996365522 exit <function device_base.register at 0x7fdec1a54180> ret: None [1714902050652] [DBG] HUB exit <function HUB.__time_hnd at 0x7fdec0f05800> ret: None [1714902050652] [DBG] HUB exit <function HUB.__on_message at 0x7fdec0f04cc0> ret: None [1714902051605] [DBG] HUB Step, state: 1 (next: 1714902052605) [1714902051606] [DBG] DEV-3996365522 enter <function device_base.info_req at 0x7fdec1a54a40> () [1714902051606] [DBG] DEV-3996365522 exit <function device_base.info_req at 0x7fdec1a54a40> ret: {'s': 3996365522, 't': 1, 'r': {0: 3996365522, 1: 1714902050}} [1714902051606] [DBG] HUB enter <function HUB.pub_hub at 0x7fdec0f05a80> ('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": 1714902050}}]}', '/') [1714902051606] [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": 1714902050}}]} } [1714902051606] [DBG] MQTT enter <function mqtt_transport.publish at 0x7fdec0f068e0> ('/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": 1714902050}}]}') [1714902051606] [DBG] MQTT exit <function mqtt_transport.publish at 0x7fdec0f068e0> ret: None [1714902051606] [DBG] HUB exit <function HUB.pub_hub at 0x7fdec0f05a80> ret: None [1714902051639] [DBG] HUB enter <function HUB.__on_message at 0x7fdec0f04cc0> ('>48:3f:da:55:07:5c/3996365522/user/add', b'"J8GTl7SsleUnuPB7dDFeuC8H9p0DqRakOESA2TMzPdt87U7HJ6xID8J+Pl1Yor/PRyw5Sg9xDF9ssU76TnMeSdU6CAUEj513Bn7xmNXaPaW9fd+mhgp2UthablkMIRPr7QGz0Lw+YXRLzpJmVpisNg==.6KMI62AT1YzWAQ4SWOxESxwfDhoAm1+JBIBvUQsvuco="') [1714902051639] [INFO] HUB Message: {topic: >48:3f:da:55:07:5c/3996365522/user/add, value: "J8GTl7SsleUnuPB7dDFeuC8H9p0DqRakOESA2TMzPdt87U7HJ6xID8J+Pl1Yor/PRyw5Sg9xDF9ssU76TnMeSdU6CAUEj513Bn7xmNXaPaW9fd+mhgp2UthablkMIRPr7QGz0Lw+YXRLzpJmVpisNg==.6KMI62AT1YzWAQ4SWOxESxwfDhoAm1+JBIBvUQsvuco=" } [1714902051640] [INFO] DEV-3996365522 User created. User count: 1 [1714902051640] [DBG] HUB enter <function HUB.pub at 0x7fdec0f05bc0> ('3996365522/user/add', '"hdMU2nT5by40zEY21b1Ufg==.F1SYOOcOwzmUSeNJDfOJjHHt6JMjw/o3mwEREqPbwWE="') [1714902051640] [DBG] HUB enter <function HUB.pub_hub at 0x7fdec0f05a80> ('3996365522/user/add', '"hdMU2nT5by40zEY21b1Ufg==.F1SYOOcOwzmUSeNJDfOJjHHt6JMjw/o3mwEREqPbwWE="') [1714902051640] [INFO] HUB Publish message: { topic: 3996365522/user/add, value: "hdMU2nT5by40zEY21b1Ufg==.F1SYOOcOwzmUSeNJDfOJjHHt6JMjw/o3mwEREqPbwWE=" } [1714902051640] [DBG] MQTT enter <function mqtt_transport.publish at 0x7fdec0f068e0> ('<48:3f:da:55:07:5c/3996365522/user/add', '"hdMU2nT5by40zEY21b1Ufg==.F1SYOOcOwzmUSeNJDfOJjHHt6JMjw/o3mwEREqPbwWE="') [1714902051640] [DBG] MQTT exit <function mqtt_transport.publish at 0x7fdec0f068e0> ret: None [1714902051640] [DBG] HUB exit <function HUB.pub_hub at 0x7fdec0f05a80> ret: None [1714902051640] [DBG] HUB exit <function HUB.pub at 0x7fdec0f05bc0> ret: True [1714902051640] [DBG] HUB exit <function HUB.__on_message at 0x7fdec0f04cc0> ret: None [1714902052693] [DBG] HUB enter <function HUB.__on_message at 0x7fdec0f04cc0> ('>user/dev', b'yt2q8P3UwdnRsQHRD9VS9TKrGx0aaSfbDOXC7m1xjHY=') [1714902052693] [INFO] HUB Message: {topic: >user/dev, value: yt2q8P3UwdnRsQHRD9VS9TKrGx0aaSfbDOXC7m1xjHY= } [1714902052693] [DBG] MQTT enter <function mqtt_transport.publish at 0x7fdec0f068e0> ('<user/dev', '48:3f:da:55:07:5c/3996365522') [1714902052695] [DBG] MQTT exit <function mqtt_transport.publish at 0x7fdec0f068e0> ret: None [1714902052695] [DBG] HUB exit <function HUB.__on_message at 0x7fdec0f04cc0> ret: None [1714902052744] [DBG] MQTT enter <function mqtt_transport.disconnect at 0x7fdec0f06520> () [1714902052745] [DBG] MQTT exit <function mqtt_transport.disconnect at 0x7fdec0f06520> ret: None

Suite stderr:

2024-05-05 09:40:51,622 - TEST - INFO - OP take: 2034.845 ms 2024-05-05 09:40:51,629 - TEST - INFO - Connected with result code: 0 2024-05-05 09:40:51,636 - TEST - INFO - OP take: 10.086 ms 2024-05-05 09:40:51,636 - TEST - INFO - Create user: admin@admin.com pwd: 11223344 user_id: fb81c4cc20a3d5d1c700b89c4ebaecf786ea76c0518c7592119b6949f912d44e 2024-05-05 09:40:51,636 - TEST - INFO - [dev] => { 'user/add' : 'J8GTl7SsleUnuPB7dDFeuC8H9p0DqRak' } 2024-05-05 09:40:51,687 - TEST - INFO - OP take: 50.604 ms 2024-05-05 09:40:51,688 - TEST - INFO - User created: "OK" 2024-05-05 09:40:52,690 - TEST - INFO - User-ID hash: yt2q8P3UwdnRsQHRD9VS9TKrGx0aaSfbDOXC7m1xjHY= File "/actions-runner/_work/esp32-mpy-uclient/esp32-mpy-uclient/tests/test_tpl.py", line 85, in _ucl_step_thread self._uclient.step() File "/actions-runner/_work/esp32-mpy-uclient/esp32-mpy-uclient/src/uclient/hub.py", line 260, in step self.client.step() File "/actions-runner/_work/esp32-mpy-uclient/esp32-mpy-uclient/src/uclient/mqtt_transport.py", line 149, in step self.client.check_msg() File "/actions-runner/_work/esp32-mpy-uclient/esp32-mpy-uclient/src/net/mqtt.py", line 255, in check_msg return self.wait_msg() ^^^^^^^^^^^^^^^ File "/actions-runner/_work/esp32-mpy-uclient/esp32-mpy-uclient/src/net/mqtt.py", line 217, in wait_msg assert sz == b"\x02" ^^^^^^^^^^^^^ 2024-05-05 09:40:52,744 - TEST - INFO - OP take: 51.01 ms 2024-05-05 09:40:52,744 - TEST - INFO - ===> Found device: 48:3f:da:55:07:5c/3996365522 2024-05-05 09:40:52,746 - TEST - WARNING - Disconecting from broker