g_client.c

D (27060) nvs: nvs_set_blob sta.apinfo 700
I (27126) wifi: state: init -> auth (b0)
I (27138) wifi: state: auth -> assoc (0)
D (27138) Brain: Processing Transaction
D (27138) Main: CPU-time_now lu
D (27138) Brain: Adding Energy State to Queue
I (27138) Brain: energy state size: 80, buffer free size: 568
I (27144) Brain: Size of item read : 80
I (27150) Brain: Size of read item ES : 80
D (27156) Brain: Processing Energy State
I (27156) [mqtt_tasks, 421]: System information, channel: 5, layer: 1, self mac: 24:6f:28:b0:3f:10, parent bssid: 3e:cd:5d:7c:02:e8, parent rssi: -44, node num: 1, free heap: 95408, min heap size : 77804
I (27162) wifi: state: assoc -> run (10)
D (27186) Brain: Updating Node Auditor
I (27186) Brain: Iteration 6 | Time: 0.000000 | last_time_delta: 0.000000 | Generated : 0.000000 Ws, Consumed : 0.000000 Ws, Transmitted : 0.000000 Ws, Received : 0.000000, Current Output : 0.000000, heap_size: 95072, min_free_heap : 77804
I (27186) wpa: <EAPOL>state:6
I (27210) wpa: <EAPOL>receiving the 1/4 EAPOL-Key, state:6
D (27222) Brain: Dispatching Energy State as Mesh Frame
I (27222) Brain: Encoded Message, bytes written: 65, encode_status: 1
I (27222) wpa: <EAPOL>state:7
I (27228) wpa: <EAPOL>receiving the 3/4 EAPOL-Key, state:7
I (27234) wifi: connected with dc1, channel 5, HT20
D (27234) nvs: nvs_set sta.chan 1 5
D (27240) nvs: nvs_set_blob sta.apinfo 700
I (27246) wifi: pm start, type: 0

D (27246) event: SYSTEM_EVENT_STA_CONNECTED, ssid:dc1, ssid_len:3, bssid:3e:cd:5d:7c:02:e8, channel:5, authmode:3
D (27258) tcpip_adapter: dhcp client init ip/mask/gw to all-0
D (27264) tcpip_adapter: if0 start ip lost tmr: enter
D (27270) tcpip_adapter: if0 start ip lost tmr: no need start because netif=0x3ffcaf00 interval=120 ip=0
D (27282) tcpip_adapter: dhcp client start successfully
I (27282) mesh: [scan]new scanning time:600ms
W (27288) wifi: [beacon]new interval:300ms
D (27294) nvs: nvs_set bcn.interval 2 300
D (27294) nvs: nvs_set_blob LAYER 1
I (27300) mesh: <nvs>write layer:1
D (27300) [mwifi, 131]: esp_mesh_event_cb event.id: 7
I (27306) [mwifi, 137]: Parent is connected
D (27312) tcpip_adapter: dhcp client already started
I (27312) [mqtt_tasks, 472]: event_loop_cb, event: 7
D (27318) [mwifi, 131]: esp_mesh_event_cb event.id: 11
I (27324) [mwifi, 231]: State represents: 0
I (27330) [mqtt_tasks, 481]: Parent is connected on station interface
D (27336) [mwifi, 131]: esp_mesh_event_cb event.id: 14
I (27342) [mqtt_tasks, 472]: event_loop_cb, event: 11
I (27348) [mqtt_tasks, 472]: event_loop_cb, event: 14
I (27348) wifi: n:5 1, o:5 1, ap:5 1, sta:5 0, prof:5
I (27360) wifi: station: a4:cf:12:99:f2:24 join, AID=1, bgn, 40U
D (27384) event: SYSTEM_EVENT_AP_STACONNECTED, mac:a4:cf:12:99:f2:24, aid:1
D (27384) [mwifi, 131]: esp_mesh_event_cb event.id: 5
I (27384) [mwifi, 220]: Routing table is changed by adding newly joined children add_num: 1, total_num: 2
I (27396) [mqtt_tasks, 472]: event_loop_cb, event: 5
D (27402) nvs: nvs_set_blob ASSOC 1
I (27402) [mqtt_tasks, 497]: MDF_EVENT_MWIFI_ROUTING_TABLE_ADD, total_num: 2
I (27408) mesh: <nvs>write assoc:1
I (27414) [mqtt_tasks, 522]: total_num: 2, add_num: 2
D (27420) [mwifi, 131]: esp_mesh_event_cb event.id: 3
E (27426) [mesh_mqtt, 82]: <MDF_ERR_INVALID_ARG> !(g_client)
D (27750) Main: CPU-time_now lu
D (27750) Brain: Adding Energy State to Queue
I (27750) Brain: energy state size: 80, buffer free size: 520
D (27930) TIME_SNTP: Calling broadcast_in_mesh function: Current Time Epoch = 28
D (27930) TIME_SNTP: Time broadcast
I (27930) [mqtt_tasks, 472]: event_loop_cb, event: 3
D (27936) [mwifi, 1098]: esp_mesh_recv, src_addr: 24:6f:28:b0:3f:10, size: 256, data: 28
E (27942) mqtt_tasks: TYPE IS 0
D (27942) [mqtt_tasks, 295]: I M ROOT
D (28098) Brain: Serial Transmission Queue Empty!
D (28098) Brain: Transaction Queue Empty!
I (28326) Brain: Size of item read : 80
I (28326) Brain: Size of read item ES : 80
D (28326) Brain: Processing Energy State
D (28326) Brain: Updating Node Auditor
I (28326) Brain: Iteration 7 | Time: 0.000000 | last_time_delta: 0.000000 | Generated : 0.000000 Ws, Consumed : 0.000000 Ws, Transmitted : 0.000000 Ws, Received : 0.000000, Current Output : 0.000000, heap_size: 92732, min_free_heap : 77716
D (28350) Main: CPU-time_now lu
D (28356) Brain: Dispatching Energy State as Mesh Frame
I (28356) Brain: Encoded Message, bytes written: 65, encode_status: 1
D (28362) Brain: Adding Energy State to Queue
I (28368) Brain: energy state size: 80, buffer free size: 608
D (28668) tcpip_adapter: if0 dhcpc cb
D (28668) tcpip_adapter: if0 ip changed=1
D (28668) [mwifi, 131]: esp_mesh_event_cb event.id: 17
D (28668) event: SYSTEM_EVENT_STA_GOT_IP, ip:192.168.43.182, mask:255.255.255.0, gw:192.168.43.1
I (28680) event: sta ip: 192.168.43.182, mask: 255.255.255.0, gw: 192.168.43.1
I (28692) [mqtt_tasks, 472]: event_loop_cb, event: 17
I (28692) [mqtt_tasks, 569]: Root obtains the IP address. It is posted by LwIP stack automatically
D (28704) nvs: nvs_open_from_partition certspace 1
D (28704) nvs: nvs_get_str_or_blob version
Run time:
D (28710) nvs: nvs_get_str_or_blob version
D (28716) nvs: nvs_close 11
E (28704) [mesh_mqtt, 276]: Current Firmware Version :0.0.1
I (28722) [mesh_mqtt, 298]: CLIENT ID IS: 24:6f:28:b0:3f:10
D (28728) MQTT_CLIENT: MQTT client_id=24:6f:28:b0:3f:10
D (28734) MQTT_CLIENT: Core selection disabled
I (28740) [mesh_mqtt, 247]: Other event id:7
D (28746) esp-tls: host:a1e7lyi19kctcn-ats.iot.ap-southeast-1.amazonaws.com: strlen 51
D (28974) Main: CPU-time_now lu
D (28974) Brain: Adding Energy State to Queue
I (28974) Brain: energy state size: 80, buffer free size: 608
D (29058) Brain: Node Control Transmission Queue Empty!
I (29328) Brain: Size of item read : 80
I (29328) Brain: Size of read item ES : 80
D (29328) Brain: Processing Energy State
D (29328) Brain: Updating Node Auditor
I (29334) Brain: Iteration 8 | Time: 0.000000 | last_time_delta: 0.000000 | Generated : 0.000000 Ws, Consumed : 0.000000 Ws, Transmitted : 0.000000 Ws, Received : 0.000000, Current Output : 0.000000, heap_size: 76944, min_free_heap : 75192
D (29352) Brain: Dispatching Energy State as Mesh Frame
I (29358) Brain: Encoded Message, bytes written: 65, encode_status: 1
W (29448) Brain: My Time -> 01-01-1970  00:00:30.357396
D (29448) [mqtt_tasks, 311]: Node receive: 24:6f:28:b0:3f:10, size: 256, data: 28
D (29574) Main: CPU-time_now lu
D (29574) Brain: Adding Energy State to Queue
D (29742) esp-tls: handshake in progress...fer free size: 632
D (30018) Brain: Serial Transmission Queue Empty!
D (30018) Brain: Hardware Connfig Transmission Queue Empty!
D (31938) Brain: Serial Transmission Queue Empty!
D (33858) Brain: Serial Transmission Queue Empty!
D (34578) Main: CPU-time_now lu
D (34578) Brain: Adding Energy State to Queue
I (34578) Brain: energy state size: 80, buffer free size: 632
D (34584) Brain: Processing Transaction
I (34584) Brain: Size of item read : 80
I (34590) Brain: Size of read item ES : 80
D (34596) Brain: Processing Energy State
D (34596) Brain: Updating Node Auditor
I (34608) Brain: Iteration 9 | Time: 0.000000 | last_time_delta: 0.000000 | Generated : 0.000000 Ws, Consumed : 0.000000 Ws, Transmitted : 0.000000 Ws, Received : 0.000000, Current Output : 0.000000, heap_size: 27608, min_free_heap : 16716
D (34626) Brain: Dispatching Energy State as Mesh Frame
I (34626) Brain: Encoded Message, bytes written: 65, encode_status: 1
D (35184) Main: CPU-time_now lu
D (35184) Brain: Adding Energy State to Queue
I (35184) Brain: energy state size: 80, buffer free size: 632
D (35550) Brain: Transaction Queue Empty!
I (35598) Brain: Size of item read : 80
I (35598) Brain: Size of read item ES : 80
D (35598) Brain: Processing Energy State
D (35598) Brain: Updating Node Auditor
I (35598) Brain: Iteration 10 | Time: 0.000000 | last_time_delta: 0.000000 | Generated : 0.000000 Ws, Consumed : 0.000000 Ws, Transmitted : 0.000000 Ws, Received : 0.000000, Current Output : 0.000000, heap_size: 27608, min_free_heap : 16716
D (35628) Brain: Dispatching Energy State as Mesh Frame
I (35628) Brain: Encoded Message, bytes written: 65, encode_status: 1
D (35784) Brain: Serial Transmission Queue Empty!
D (35784) Main: CPU-time_now lu
D (35784) Brain: Adding Energy State to Queue
I (35784) Brain: energy state size: 80, buffer free size: 632
D (36390) Main: CPU-time_now lu
D (36390) Brain: Adding Energy State to Queue
I (36390) Brain: energy state size: 80, buffer free size: 632
D (36516) Brain: Node Control Transmission Queue Empty!
I (36600) Brain: Size of item read : 80
I (36600) Brain: Size of read item ES : 80
D (36600) Brain: Processing Energy State
D (36600) Brain: Updating Node Auditor
I (36600) Brain: Iteration 11 | Time: 0.000000 | last_time_delta: 0.000000 | Generated : 0.000000 Ws, Consumed : 0.000000 Ws, Transmitted : 0.000000 Ws, Received : 0.000000, Current Output : 0.000000, heap_size: 27608, min_free_heap : 16716
D (36624) Brain: Dispatching Energy State as Mesh Frame
I (36630) Brain: Encoded Message, bytes written: 65, encode_status: 1
D (36990) Main: CPU-time_now lu
D (36990) Brain: Adding Energy State to Queue
I (36990) Brain: energy state size: 80, buffer free size: 632
I (37056) [mqtt_tasks, 421]: System information, channel: 5, layer: 1, self mac: 24:6f:28:b0:3f:10, parent bssid: 3e:cd:5d:7c:02:e8, parent rssi: -44, node num: 2, free heap: 27608, min heap size : 16716
I (37068) [mqtt_tasks, 423]: Child mac: a4:cf:12:99:f2:24
D (37476) Brain: Hardware Connfig Transmission Queue Empty!
D (37590) Main: CPU-time_now lu
D (37590) Brain: Adding Energy State to Queue
I (37590) Brain: energy state size: 80, buffer free size: 608
I (37596) Brain: Size of item read : 80
I (37596) Brain: Size of read item ES : 80
D (37602) Brain: Processing Energy State
D (37602) Brain: Updating Node Auditor
I (37608) Brain: Iteration 12 | Time: 0.000000 | last_time_delta: 0.000000 | Generated : 0.000000 Ws, Consumed : 0.000000 Ws, Transmitted : 0.000000 Ws, Received : 0.000000, Current Output : 0.000000, heap_size: 27608, min_free_heap : 16716
D (37626) Brain: Dispatching Energy State as Mesh Frame
I (37632) Brain: Encoded Message, bytes written: 65, encode_status: 1
D (37710) Brain: Serial Transmission Queue Empty!
D (38190) Main: CPU-time_now lu
D (38190) Brain: Adding Energy State to Queue
I (38190) Brain: energy state size: 80, buffer free size: 608
D (38436) Brain: Processing Transaction
I (38598) Brain: Size of item read : 80
I (38598) Brain: Size of read item ES : 80
D (38598) Brain: Processing Energy State
D (38598) Brain: Updating Node Auditor
I (38604) Brain: Iteration 13 | Time: 0.000000 | last_time_delta: 0.000000 | Generated : 0.000000 Ws, Consumed : 0.000000 Ws, Transmitted : 0.000000 Ws, Received : 0.000000, Current Output : 0.000000, heap_size: 27608, min_free_heap : 16716
D (38622) Brain: Dispatching Energy State as Mesh Frame
I (38628) Brain: Encoded Message, bytes written: 65, encode_status: 1
D (38790) Main: CPU-time_now lu
D (38790) Brain: Adding Energy State to Queue
I (38790) Brain: energy state size: 80, buffer free size: 608
D (39390) Main: CPU-time_now lu
D (39390) Brain: Adding Energy State to Queue
I (39390) Brain: energy state size: 80, buffer free size: 520
D (39402) Brain: Transaction Queue Empty!
I (39594) Brain: Size of item read : 80
I (39594) Brain: Size of read item ES : 80
D (39594) Brain: Processing Energy State
D (39594) Brain: Updating Node Auditor
I (39606) Brain: Iteration 14 | Time: 0.000000 | last_time_delta: 0.000000 | Generated : 0.000000 Ws, Consumed : 0.000000 Ws, Transmitted : 0.000000 Ws, Received : 0.000000, Current Output : 0.000000, heap_size: 27608, min_free_heap : 16716
D (39618) Brain: Dispatching Energy State as Mesh Frame
I (39624) Brain: Encoded Message, bytes written: 65, encode_status: 1
D (39630) Brain: Serial Transmission Queue Empty!
D (39990) Main: CPU-time_now lu
D (39990) Brain: Adding Energy State to Queue
I (39990) Brain: energy state size: 80, buffer free size: 520
D (40362) Brain: Node Control Transmission Queue Empty!
D (40590) Main: CPU-time_now lu
D (40590) Brain: Adding Energy State to Queue
I (40590) Brain: energy state size: 80, buffer free size: 432
I (40596) Brain: Size of item read : 80
I (40596) Brain: Size of read item ES : 80
D (40602) Brain: Processing Energy State
D (40602) Brain: Updating Node Auditor
I (40608) Brain: Iteration 15 | Time: 0.000000 | last_time_delta: 0.000000 | Generated : 0.000000 Ws, Consumed : 0.000000 Ws, Transmitted : 0.000000 Ws, Received : 0.000000, Current Output : 0.000000, heap_size: 27608, min_free_heap : 16716
D (40626) Brain: Dispatching Energy State as Mesh Frame
I (40638) Brain: Encoded Message, bytes written: 65, encode_status: 1
D (41190) Main: CPU-time_now lu
D (41190) Brain: Adding Energy State to Queue
I (41190) Brain: energy state size: 80, buffer free size: 392
D (41322) Brain: Hardware Connfig Transmission Queue Empty!
D (41556) Brain: Serial Transmission Queue Empty!
I (41598) Brain: Size of item read : 80
I (41598) Brain: Size of read item ES : 80
D (41598) Brain: Processing Energy State
D (41598) Brain: Updating Node Auditor
I (41604) Brain: Iteration 16 | Time: 0.000000 | last_time_delta: 0.000000 | Generated : 0.000000 Ws, Consumed : 0.000000 Ws, Transmitted : 0.000000 Ws, Received : 0.000000, Current Output : 0.000000, heap_size: 27608, min_free_heap : 16716
D (41622) Brain: Dispatching Energy State as Mesh Frame
I (41628) Brain: Encoded Message, bytes written: 65, encode_status: 1
D (41790) Main: CPU-time_now lu
D (41790) Brain: Adding Energy State to Queue
I (41790) Brain: energy state size: 80, buffer free size: 304
D (42282) Brain: Processing Transaction
D (42390) Main: CPU-time_now lu
D (42390) Brain: Adding Energy State to Queue
I (42390) Brain: energy state size: 80, buffer free size: 216
I (42594) Brain: Size of item read : 80
I (42594) Brain: Size of read item ES : 80
D (42594) Brain: Processing Energy State
D (42594) Brain: Updating Node Auditor
I (42600) Brain: Iteration 17 | Time: 0.000000 | last_time_delta: 0.000000 | Generated : 0.000000 Ws, Consumed : 0.000000 Ws, Transmitted : 0.000000 Ws, Received : 0.000000, Current Output : 0.000000, heap_size: 27608, min_free_heap : 16716
D (42618) Brain: Dispatching Energy State as Mesh Frame
I (42624) Brain: Encoded Message, bytes written: 65, encode_status: 1
D (42990) Main: CPU-time_now lu
D (42990) Brain: Adding Energy State to Queue
I (42990) Brain: energy state size: 80, buffer free size: 256
D (43242) Brain: Transaction Queue Empty!
D (43482) Brain: Serial Transmission Queue Empty!
D (43596) Main: CPU-time_now lu
D (43596) Brain: Adding Energy State to Queue
I (43596) Brain: energy state size: 80, buffer free size: 256
I (43596) Brain: Size of item read : 80
I (43602) Brain: Size of read item ES : 80
D (43608) Brain: Processing Energy State
D (43608) Brain: Updating Node Auditor
I (43614) Brain: Iteration 18 | Time: 0.000000 | last_time_delta: 0.000000 | Generated : 0.000000 Ws, Consumed : 0.000000 Ws, Transmitted : 0.000000 Ws, Received : 0.000000, Current Output : 0.000000, heap_size: 27608, min_free_heap : 16716
D (43632) Brain: Dispatching Energy State as Mesh Frame
I (43638) Brain: Encoded Message, bytes written: 65, encode_status: 1
D (44196) Main: CPU-time_now lu
D (44196) Brain: Adding Energy State to Queue
I (44196) Brain: energy state size: 80, buffer free size: 256
D (44208) Brain: Node Control Transmission Queue Empty!
I (44604) Brain: Size of item read : 80
I (44616) Brain: Size of read item ES : 80
D (44616) Brain: Processing Energy State
D (44616) Brain: Updating Node Auditor
I (44622) Brain: Iteration 19 | Time: 0.000000 | last_time_delta: 0.000000 | Generated : 0.000000 Ws, Consumed : 0.000000 Ws, Transmitted : 0.000000 Ws, Received : 0.000000, Current Output : 0.000000, heap_size: 74744, min_free_heap : 16716
D (44640) Brain: Dispatching Energy State as Mesh Frame
I (44646) Brain: Encoded Message, bytes written: 65, encode_status: 1
D (44796) Main: CPU-time_now lu
D (44796) Brain: Adding Energy State to Queue
I (44796) Brain: energy state size: 80, buffer free size: 256
D (45168) Brain: Hardware Connfig Transmission Queue Empty!
D (45396) Main: CPU-time_now lu
D (45396) Brain: Adding Energy State to Queue
I (45396) Brain: energy state size: 80, buffer free size: 168
D (45402) Brain: Serial Transmission Queue Empty!
I (45612) Brain: Size of item read : 80
I (45612) Brain: Size of read item ES : 80
D (45612) Brain: Processing Energy State
D (45612) Brain: Updating Node Auditor
I (45612) Brain: Iteration 20 | Time: 0.000000 | last_time_delta: 0.000000 | Generated : 0.000000 Ws, Consumed : 0.000000 Ws, Transmitted : 0.000000 Ws, Received : 0.000000, Current Output : 0.000000, heap_size: 78184, min_free_heap : 16716
D (45636) Brain: Dispatching Energy State as Mesh Frame
I (45642) Brain: Encoded Message, bytes written: 65, encode_status: 1
D (45996) Main: CPU-time_now lu
D (45996) Brain: Adding Energy State to Queue
I (45996) Brain: energy state size: 80, buffer free size: 168
D (46134) Brain: Processing Transaction
D (46596) Main: CPU-time_now lu
D (46596) Brain: Adding Energy State to Queue
I (46596) Brain: energy state size: 80, buffer free size: 80
I (46608) Brain: Size of item read : 80
I (46608) Brain: Size of read item ES : 80
D (46608) Brain: Processing Energy State
D (46608) Brain: Updating Node Auditor
I (46614) Brain: Iteration 21 | Time: 0.000000 | last_time_delta: 0.000000 | Generated : 0.000000 Ws, Consumed : 0.000000 Ws, Transmitted : 0.000000 Ws, Received : 0.000000, Current Output : 0.000000, heap_size: 78184, min_free_heap : 16716
D (46632) Brain: Dispatching Energy State as Mesh Frame
I (46644) Brain: Encoded Message, bytes written: 65, encode_status: 1
I (47052) [mqtt_tasks, 421]: System information, channel: 5, layer: 1, self mac: 24:6f:28:b0:3f:10, parent bssid: 3e:cd:5d:7c:02:e8, parent rssi: -44, node num: 2, free heap: 78184, min heap size : 16716
I (47064) [mqtt_tasks, 423]: Child mac: a4:cf:12:99:f2:24
D (47094) Brain: Transaction Queue Empty!
D (47196) Main: CPU-time_now lu
D (47196) Brain: Adding Energy State to Queue
I (47196) Brain: energy state size: 80, buffer free size: 0
D (47322) Brain: Serial Transmission Queue Empty!
D (48054) Brain: Node Control Transmission Queue Empty!
D (48204) Main: CPU-time_now lu
D (48204) Brain: Adding Energy State to Queue
I (48204) Brain: energy state size: 80, buffer free size: 0
I (48564) Brain: Size of item read : 80
I (48564) Brain: Size of read item ES : 80
D (48564) Brain: Processing Energy State
D (48564) Brain: Updating Node Auditor
I (48570) Brain: Iteration 22 | Time: 0.000000 | last_time_delta: 0.000000 | Generated : 0.000000 Ws, Consumed : 0.000000 Ws, Transmitted : 0.000000 Ws, Received : 0.000000, Current Output : 0.000000, heap_size: 78184, min_free_heap : 16716
D (48594) Brain: Dispatching Energy State as Mesh Frame
I (48594) Brain: Encoded Message, bytes written: 65, encode_status: 1
D (49014) Brain: Hardware Connfig Transmission Queue Empty!
D (49248) Brain: Serial Transmission Queue Empty!
D (49974) Brain: Processing Transaction
D (50160) Main: CPU-time_now lu
D (50160) Brain: Adding Energy State to Queue
I (50160) Brain: energy state size: 80, buffer free size: 0
I (50520) Brain: Size of item read : 80
I (50520) Brain: Size of read item ES : 80
D (50520) Brain: Processing Energy State
D (50520) Brain: Updating Node Auditor
I (50532) Brain: Iteration 23 | Time: 0.000000 | last_time_delta: 0.000000 | Generated : 0.000000 Ws, Consumed : 0.000000 Ws, Transmitted : 0.000000 Ws, Received : 0.000000, Current Output : 0.000000, heap_size: 78184, min_free_heap : 16716
D (50544) Brain: Dispatching Energy State as Mesh Frame
I (50550) Brain: Encoded Message, bytes written: 65, encode_status: 1
D (50940) Brain: Transaction Queue Empty!
D (51174) Brain: Serial Transmission Queue Empty!
D (51900) Brain: Node Control Transmission Queue Empty!
D (52116) Main: CPU-time_now lu
D (52116) Brain: Adding Energy State to Queue
I (52116) Brain: energy state size: 80, buffer free size: 0
I (52476) Brain: Size of item read : 80
I (52476) Brain: Size of read item ES : 80
D (52476) Brain: Processing Energy State
D (52476) Brain: Updating Node Auditor
I (52476) Brain: Iteration 24 | Time: 0.000000 | last_time_delta: 0.000000 | Generated : 0.000000 Ws, Consumed : 0.000000 Ws, Transmitted : 0.000000 Ws, Received : 0.000000, Current Output : 0.000000, heap_size: 78184, min_free_heap : 16716
D (52500) Brain: Dispatching Energy State as Mesh Frame
I (52506) Brain: Encoded Message, bytes written: 65, encode_status: 1
D (52866) Brain: Hardware Connfig Transmission Queue Empty!
D (53094) Brain: Serial Transmission Queue Empty!
D (53826) Brain: Processing Transaction
D (54078) Main: CPU-time_now lu
D (54078) Brain: Adding Energy State to Queue
I (54078) Brain: energy state size: 80, buffer free size: 0
I (54438) Brain: Size of item read : 80
I (54438) Brain: Size of read item ES : 80
D (54438) Brain: Processing Energy State
D (54438) Brain: Updating Node Auditor
I (54444) Brain: Iteration 25 | Time: 0.000000 | last_time_delta: 0.000000 | Generated : 0.000000 Ws, Consumed : 0.000000 Ws, Transmitted : 0.000000 Ws, Received : 0.000000, Current Output : 0.000000, heap_size: 78184, min_free_heap : 16716
D (54462) Brain: Dispatching Energy State as Mesh Frame
I (54468) Brain: Encoded Message, bytes written: 65, encode_status: 1
D (54600) MQTT_CLIENT: Reconnecting...
D (54786) Brain: Transaction Queue Empty!
D (55020) Brain: Serial Transmission Queue Empty!
D (55746) Brain: Node Control Transmission Queue Empty!
D (56040) Main: CPU-time_now lu
D (56040) Brain: Adding Energy State to Queue
I (56040) Brain: energy state size: 80, buffer free size: 0
I (56394) Brain: Size of item read : 80
I (56394) Brain: Size of read item ES : 80
D (56394) Brain: Processing Energy State
D (56394) Brain: Updating Node Auditor
I (56406) Brain: Iteration 26 | Time: 0.000000 | last_time_delta: 0.000000 | Generated : 0.000000 Ws, Consumed : 0.000000 Ws, Transmitted : 0.000000 Ws, Received : 0.000000, Current Output : 0.000000, heap_size: 78184, min_free_heap : 16716
D (56418) Brain: Dispatching Energy State as Mesh Frame
I (56424) Brain: Encoded Message, bytes written: 65, encode_status: 1
D (56706) Brain: Hardware Connfig Transmission Queue Empty!
D (56946) Brain: Serial Transmission Queue Empty!
I (57048) [mqtt_tasks, 421]: System information, channel: 5, layer: 1, self mac: 24:6f:28:b0:3f:10, parent bssid: 3e:cd:5d:7c:02:e8, parent rssi: -44, node num: 2, free heap: 78184, min heap size : 16716
I (57060) [mqtt_tasks, 423]: Child mac: a4:cf:12:99:f2:24
D (57672) Brain: Processing Transaction
D (57996) Main: CPU-time_now lu
D (57996) Brain: Adding Energy State to Queue
I (57996) Brain: energy state size: 80, buffer free size: 0
I (58356) Brain: Size of item read : 80
I (58356) Brain: Size of read item ES : 80
D (58356) Brain: Processing Energy State
D (58356) Brain: Updating Node Auditor
I (58356) Brain: Iteration 27 | Time: 0.000000 | last_time_delta: 0.000000 | Generated : 0.000000 Ws, Consumed : 0.000000 Ws, Transmitted : 0.000000 Ws, Received : 0.000000, Current Output : 0.000000, heap_size: 78184, min_free_heap : 16716
D (58386) Brain: Dispatching Energy State as Mesh Frame
I (58386) Brain: Encoded Message, bytes written: 65, encode_status: 1
D (58632) Brain: Transaction Queue Empty!
D (58866) Brain: Serial Transmission Queue Empty!
I (59598) [mesh_mqtt, 247]: Other event id:7
D (59598) esp-tls: host:a1e7lyi19kctcn-ats.iot.ap-southeast-1.amazonaws.com: strlen 51
D (59610) Brain: Node Control Transmission Queue Empty!
D (59952) Main: CPU-time_now lu
D (59952) Brain: Adding Energy State to Queue
I (59952) Brain: energy state size: 80, buffer free size: 0
D (60462) esp-tls: handshake in progress...
I (60468) Brain: Size of item read : 80
I (60468) Brain: Size of read item ES : 80
D (60468) Brain: Processing Energy State
D (60474) Brain: Updating Node Auditor
I (60474) Brain: Iteration 28 | Time: 0.000000 | last_time_delta: 0.000000 | Generated : 0.000000 Ws, Consumed : 0.000000 Ws, Transmitted : 0.000000 Ws, Received : 0.000000, Current Output : 0.000000, heap_size: 50416, min_free_heap : 16716
D (60498) Brain: Dispatching Energy State as Mesh Frame
I (60504) Brain: Encoded Message, bytes written: 65, encode_status: 1
D (60570) Brain: Hardware Connfig Transmission Queue Empty!
D (60786) Brain: Serial Transmission Queue Empty!
D (61536) Brain: Processing Transaction
D (62076) Main: CPU-time_now lu
D (62076) Brain: Adding Energy State to Queue
I (62076) Brain: energy state size: 80, buffer free size: 0
I (62436) Brain: Size of item read : 80
I (62436) Brain: Size of read item ES : 80
D (62436) Brain: Processing Energy State
D (62436) Brain: Updating Node Auditor
I (62442) Brain: Iteration 29 | Time: 0.000000 | last_time_delta: 0.000000 | Generated : 0.000000 Ws, Consumed : 0.000000 Ws, Transmitted : 0.000000 Ws, Received : 0.000000, Current Output : 0.000000, heap_size: 50416, min_free_heap : 16716
D (62466) Brain: Dispatching Energy State as Mesh Frame
I (62466) Brain: Encoded Message, bytes written: 65, encode_status: 1
D (62496) Brain: Transaction Queue Empty!
D (62712) Brain: Serial Transmission Queue Empty!
D (63462) Brain: Node Control Transmission Queue Empty!
D (64032) Main: CPU-time_now lu
D (64032) Brain: Adding Energy State to Queue
I (64032) Brain: energy state size: 80, buffer free size: 0
I (64392) Brain: Size of item read : 80
I (64392) Brain: Size of read item ES : 80
D (64392) Brain: Processing Energy State
D (64392) Brain: Updating Node Auditor
I (64404) Brain: Iteration 30 | Time: 0.000000 | last_time_delta: 0.000000 | Generated : 0.000000 Ws, Consumed : 0.000000 Ws, Transmitted : 0.000000 Ws, Received : 0.000000, Current Output : 0.000000, heap_size: 51996, min_free_heap : 16716
D (64416) Brain: Dispatching Energy State as Mesh Frame
D (64422) Brain: Hardware Connfig Transmission Queue Empty!
I (64428) Brain: Encoded Message, bytes written: 65, encode_status: 1
D (64638) Brain: Serial Transmission Queue Empty!
D (65394) Brain: Processing Transaction
D (65994) Main: CPU-time_now lu
D (65994) Brain: Adding Energy State to Queue
I (65994) Brain: energy state size: 80, buffer free size: 0
I (66354) Brain: Size of item read : 80
I (66354) Brain: Size of read item ES : 80
D (66354) Brain: Processing Energy State
D (66354) Brain: Updating Node Auditor
D (66360) Brain: Transaction Queue Empty!
I (66360) Brain: Iteration 31 | Time: 0.000000 | last_time_delta: 0.000000 | Generated : 0.000000 Ws, Consumed : 0.000000 Ws, Transmitted : 0.000000 Ws, Received : 0.000000, Current Output : 0.000000, heap_size: 51996, min_free_heap : 16716
D (66384) Brain: Dispatching Energy State as Mesh Frame
I (66390) Brain: Encoded Message, bytes written: 65, encode_status: 1
D (66558) Brain: Serial Transmission Queue Empty!
I (67044) [mqtt_tasks, 421]: System information, channel: 5, layer: 1, self mac: 24:6f:28:b0:3f:10, parent bssid: 3e:cd:5d:7c:02:e8, parent rssi: -44, node num: 2, free heap: 51996, min heap size : 16716
I (67056) [mqtt_tasks, 423]: Child mac: a4:cf:12:99:f2:24
D (67320) Brain: Node Control Transmission Queue Empty!
D (67962) Main: CPU-time_now lu
D (67962) Brain: Adding Energy State to Queue
I (67962) Brain: energy state size: 80, buffer free size: 0
D (68280) Brain: Hardware Connfig Transmission Queue Empty!
I (68322) Brain: Size of item read : 80
I (68322) Brain: Size of read item ES : 80
D (68322) Brain: Processing Energy State
D (68322) Brain: Updating Node Auditor
I (68322) Brain: Iteration 32 | Time: 0.000000 | last_time_delta: 0.000000 | Generated : 0.000000 Ws, Consumed : 0.000000 Ws, Transmitted : 0.000000 Ws, Received : 0.000000, Current Output : 0.000000, heap_size: 51996, min_free_heap : 16716
D (68346) Brain: Dispatching Energy State as Mesh Frame
I (68352) Brain: Encoded Message, bytes written: 65, encode_status: 1
D (68484) Brain: Serial Transmission Queue Empty!
D (69240) Brain: Processing Transaction
D (69918) Main: CPU-time_now lu
D (69918) Brain: Adding Energy State to Queue
I (69918) Brain: energy state size: 80, buffer free size: 0
D (70206) Brain: Transaction Queue Empty!
I (70278) Brain: Size of item read : 80
I (70278) Brain: Size of read item ES : 80
D (70278) Brain: Processing Energy State
D (70278) Brain: Updating Node Auditor
I (70284) Brain: Iteration 33 | Time: 0.000000 | last_time_delta: 0.000000 | Generated : 0.000000 Ws, Consumed : 0.000000 Ws, Transmitted : 0.000000 Ws, Received : 0.000000, Current Output : 0.000000, heap_size: 51996, min_free_heap : 16716
D (70308) Brain: Dispatching Energy State as Mesh Frame
I (70308) Brain: Encoded Message, bytes written: 65, encode_status: 1
D (70410) Brain: Serial Transmission Queue Empty!
D (71166) Brain: Node Control Transmission Queue Empty!
D (71880) Main: CPU-time_now lu
D (71880) Brain: Adding Energy State to Queue
I (71880) Brain: energy state size: 80, buffer free size: 0
D (72126) Brain: Hardware Connfig Transmission Queue Empty!
I (72246) Brain: Size of item read : 80
I (72246) Brain: Size of read item ES : 80
D (72246) Brain: Processing Energy State
D (72246) Brain: Updating Node Auditor
I (72258) Brain: Iteration 34 | Time: 0.000000 | last_time_delta: 0.000000 | Generated : 0.000000 Ws, Consumed : 0.000000 Ws, Transmitted : 0.000000 Ws, Received : 0.000000, Current Output : 0.000000, heap_size: 51996, min_free_heap : 16716
D (72270) Brain: Dispatching Energy State as Mesh Frame
I (72276) Brain: Encoded Message, bytes written: 65, encode_status: 1
D (72330) Brain: Serial Transmission Queue Empty!
D (73086) Brain: Processing Transaction
D (73848) Main: CPU-time_now lu
D (73848) Brain: Adding Energy State to Queue
I (73848) Brain: energy state size: 80, buffer free size: 0
D (74046) Brain: Transaction Queue Empty!
I (74214) Brain: Size of item read : 80
I (74214) Brain: Size of read item ES : 80
D (74214) Brain: Processing Energy State
D (74214) Brain: Updating Node Auditor
I (74220) Brain: Iteration 35 | Time: 0.000000 | last_time_delta: 0.000000 | Generated : 0.000000 Ws, Consumed : 0.000000 Ws, Transmitted : 0.000000 Ws, Received : 0.000000, Current Output : 0.000000, heap_size: 51996, min_free_heap : 16716
D (74238) Brain: Dispatching Energy State as Mesh Frame
D (74250) Brain: Serial Transmission Queue Empty!
I (74250) Brain: Encoded Message, bytes written: 65, encode_status: 1
D (75012) Brain: Node Control Transmission Queue Empty!
D (75828) Main: CPU-time_now lu
D (75828) Brain: Adding Energy State to Queue
I (75828) Brain: energy state size: 80, buffer free size: 0
D (75978) Brain: Hardware Connfig Transmission Queue Empty!
D (76182) Brain: Serial Transmission Queue Empty!
I (76182) Brain: Size of item read : 80
I (76182) Brain: Size of read item ES : 80
D (76182) Brain: Processing Energy State
D (76188) Brain: Updating Node Auditor
I (76188) Brain: Iteration 36 | Time: 0.000000 | last_time_delta: 0.000000 | Generated : 0.000000 Ws, Consumed : 0.000000 Ws, Transmitted : 0.000000 Ws, Received : 0.000000, Current Output : 0.000000, heap_size: 51996, min_free_heap : 16716
D (76212) Brain: Dispatching Energy State as Mesh Frame
I (76236) Brain: Encoded Message, bytes written: 65, encode_status: 1
D (76938) Brain: Processing Transaction
I (77040) [mqtt_tasks, 421]: System information, channel: 5, layer: 1, self mac: 24:6f:28:b0:3f:10, parent bssid: 3e:cd:5d:7c:02:e8, parent rssi: -44, node num: 2, free heap: 51996, min heap size : 16716
I (77052) [mqtt_tasks, 423]: Child mac: a4:cf:12:99:f2:24
D (77796) Main: CPU-time_now lu
D (77796) Brain: Adding Energy State to Queue
I (77796) Brain: energy state size: 80, buffer free size: 0
D (77898) Brain: Transaction Queue Empty!
D (78102) Brain: Serial Transmission Queue Empty!
I (78162) Brain: Size of item read : 80
I (78162) Brain: Size of read item ES : 80
D (78162) Brain: Processing Energy State
D (78162) Brain: Updating Node Auditor
I (78174) Brain: Iteration 37 | Time: 0.000000 | last_time_delta: 0.000000 | Generated : 0.000000 Ws, Consumed : 0.000000 Ws, Transmitted : 0.000000 Ws, Received : 0.000000, Current Output : 0.000000, heap_size: 51996, min_free_heap : 16716
D (78186) Brain: Dispatching Energy State as Mesh Frame
I (78192) Brain: Encoded Message, bytes written: 65, encode_status: 1