Added time-based wifi data logging

Author: BobSaidHi

.gitignore

@@ -9,3 +9,4 @@ demos/LoadDemo_v0.2.1.zip
 demos/LoadDemo_v0.3.0.zip
 demos/LoadDemo_v0.3.0_v1.0.0.zip
 demos/LoadDemo_v0.3.1_v1.0.1.zip
+/.PVS-Studio

lib/LoadComms/LoadComms.cpp

@@ -145,6 +145,10 @@ etl::string<LoadComms::LOG_STRING_SIZE> LoadComms::getLogString() const {
         return logString;
     }
 
+LoadComms::LogData LoadComms::getLogData() const {
+    return LogData{txEvents, bytesSent, bytesNotSent, rxEvents, bytesReceived};
+}
+
 void LoadComms::onDataSent_(const wifi_tx_info_t *tx_info, esp_now_send_status_t status) {
   // (void)tx_info;
   // Serial.print("Send status: ");

lib/LoadComms/LoadComms.hpp

@@ -98,6 +98,16 @@ class LoadComms {
      */
     etl::string<LOG_STRING_SIZE> getLogString() const;
 
+    struct LogData {
+        uint_fast32_t txEvents;
+        uint_fast32_t bytesSent;
+        uint_fast32_t bytesNotSent;
+        uint_fast32_t rxEvents;
+        uint_fast32_t bytesReceived;
+    };
+
+    LogData getLogData() const;
+
 private:
   NacellePacket incomingPacket_;  ///< Received packet from nacelle.
   LoadboxPacket outgoingPacket_;   ///< Outgoing packet to send.

src/main.cpp

@@ -638,8 +638,38 @@ constexpr uint32_t LOG_ITEM_INTERVAL_MS = RUN::TASK_INTERVALS::TI_LOG_DATA_ms;
         // delay(LOG_ITEM_INTERVAL_MS);
 
         ESP_LOGI(TAG, "%s", INA260::getLogString().c_str());
-        
-        ESP_LOGI(TAG, "%s", loadComms.getLogString().c_str());  
+
+        static unsigned int prevTime_us = 0;
+        static LoadComms::LogData lastLogData = {0};
+        unsigned int currentTime_us = micros();
+        ESP_LOGI(TAG, "%s", loadComms.getLogString().c_str());
+        LoadComms::LogData currentLogData = loadComms.getLogData();
+        unsigned long deltaTime_us = currentTime_us - prevTime_us;
+        uint_fast32_t deltaTxEvents =
+            currentLogData.txEvents - lastLogData.txEvents;
+        uint_fast32_t deltaBytesSent =
+            currentLogData.bytesSent - lastLogData.bytesSent;
+        uint_fast32_t deltaBytesFailed =
+            currentLogData.bytesNotSent - lastLogData.bytesNotSent;
+        uint_fast32_t deltaRxEvents =
+            currentLogData.rxEvents - lastLogData.rxEvents;
+        uint_fast32_t deltaBytesReceived =
+            currentLogData.bytesReceived - lastLogData.bytesReceived;
+
+        constexpr unsigned long m_TO_BASE = 1000;
+        constexpr unsigned long u_TO_m = 1000;
+        constexpr unsigned long u_TO_BASE = m_TO_BASE * u_TO_m;
+        ESP_LOGI(TAG, "TxE/s: %u, TxBS/s: %u, TxBF/s: %u, RxE/s: %u, RxB/s: %u",
+                 deltaTxEvents * u_TO_BASE / deltaTime_us,
+                 deltaBytesSent * u_TO_BASE / deltaTime_us,
+                 deltaBytesFailed * u_TO_BASE / deltaTime_us,
+                 deltaRxEvents * u_TO_BASE / deltaTime_us,
+                 deltaBytesReceived * u_TO_BASE / deltaTime_us);
+        prevTime_us = currentTime_us;
+        lastLogData = currentLogData;
+
+        unsigned int elapsedTime_us = currentTime_us - prevTime_us;
+        prevTime_us = currentTime_us;
 
         delay(LOG_ITEM_INTERVAL_MS);