2023-03-31T20:24:50.578Z,1680294290.579 [Supervisor](DEBUG): Initializing supervisor. 2023-03-31T20:24:50.583Z,1680294290.583 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2023-03-31T20:24:50.583Z,1680294290.583 [SyncHandler](INFO): Protected caller Thread ID is 832 2023-03-31T20:24:50.584Z,1680294290.584 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2023-03-31T20:24:50.585Z,1680294290.585 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2023-03-31T20:24:50.585Z,1680294290.585 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 833 2023-03-31T20:24:50.589Z,1680294290.589 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2023-03-31T20:24:50.606Z,1680294290.606 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2023-03-31T20:24:50.607Z,1680294290.607 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2023-03-31T20:24:50.607Z,1680294290.607 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 834 2023-03-31T20:24:50.612Z,1680294290.612 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2023-03-31T20:24:50.613Z,1680294290.613 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2023-03-31T20:24:50.613Z,1680294290.613 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 835 2023-03-31T20:24:50.615Z,1680294290.615 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2023-03-31T20:24:50.616Z,1680294290.616 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2023-03-31T20:24:50.616Z,1680294290.616 [logger ThreadHandler](INFO): Protected caller Thread ID is 836 2023-03-31T20:24:50.620Z,1680294290.620 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2023-03-31T20:24:50.620Z,1680294290.620 [Supervisor](INFO): Looking for Config files in directory: Config/ 2023-03-31T20:24:50.624Z,1680294290.624 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2023-03-31T20:24:50.945Z,1680294290.945 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2023-03-31T20:24:50.947Z,1680294290.947 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2023-03-31T20:24:51.598Z,1680294291.598 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2023-03-31T20:24:51.599Z,1680294291.599 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2023-03-31T20:24:51.704Z,1680294291.704 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2023-03-31T20:24:51.706Z,1680294291.706 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2023-03-31T20:24:52.172Z,1680294292.172 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2023-03-31T20:24:52.174Z,1680294292.174 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2023-03-31T20:24:52.269Z,1680294292.269 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2023-03-31T20:24:52.270Z,1680294292.270 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2023-03-31T20:24:52.353Z,1680294292.353 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2023-03-31T20:24:52.735Z,1680294292.735 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2023-03-31T20:24:52.737Z,1680294292.737 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2023-03-31T20:24:52.961Z,1680294292.961 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2023-03-31T20:24:52.963Z,1680294292.963 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2023-03-31T20:24:53.097Z,1680294293.097 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2023-03-31T20:24:53.097Z,1680294293.097 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2023-03-31T20:24:53.321Z,1680294293.321 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2023-03-31T20:24:53.322Z,1680294293.322 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2023-03-31T20:24:53.819Z,1680294293.819 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2023-03-31T20:24:53.821Z,1680294293.821 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2023-03-31T20:24:54.264Z,1680294294.264 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2023-03-31T20:24:54.265Z,1680294294.265 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2023-03-31T20:24:54.948Z,1680294294.948 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2023-03-31T20:24:55.169Z,1680294295.169 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2023-03-31T20:24:55.171Z,1680294295.171 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2023-03-31T20:24:55.384Z,1680294295.384 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2023-03-31T20:24:55.385Z,1680294295.385 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2023-03-31T20:24:55.668Z,1680294295.668 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2023-03-31T20:24:55.670Z,1680294295.670 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-brizo/ 2023-03-31T20:24:55.673Z,1680294295.673 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Control.cfg 2023-03-31T20:24:55.781Z,1680294295.781 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Sensor.cfg 2023-03-31T20:24:55.926Z,1680294295.926 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Simulator.cfg 2023-03-31T20:24:56.010Z,1680294296.010 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/secure.cfg 2023-03-31T20:24:56.094Z,1680294296.094 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Servo.cfg 2023-03-31T20:24:56.204Z,1680294296.204 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/vehicle.cfg 2023-03-31T20:24:56.371Z,1680294296.371 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Battery.cfg 2023-03-31T20:24:56.628Z,1680294296.628 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2023-03-31T20:24:56.629Z,1680294296.629 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Science.cfg 2023-03-31T20:24:56.756Z,1680294296.756 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/logger.cfg 2023-03-31T20:24:56.847Z,1680294296.847 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/BIT.cfg 2023-03-31T20:24:56.949Z,1680294296.949 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Navigation.cfg 2023-03-31T20:24:57.048Z,1680294297.048 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg 2023-03-31T20:24:57.072Z,1680294297.072 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2023-03-31T20:24:57.193Z,1680294297.193 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2023-03-31T20:24:57.194Z,1680294297.194 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2023-03-31T20:24:57.209Z,1680294297.209 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2023-03-31T20:24:57.210Z,1680294297.210 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2023-03-31T20:24:57.280Z,1680294297.280 [DepthRateCalculator] Loaded 2023-03-31T20:24:57.280Z,1680294297.280 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2023-03-31T20:24:57.285Z,1680294297.285 [PitchRateCalculator] Loaded 2023-03-31T20:24:57.286Z,1680294297.286 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2023-03-31T20:24:57.296Z,1680294297.296 [SpeedCalculator] Loaded 2023-03-31T20:24:57.296Z,1680294297.296 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2023-03-31T20:24:57.311Z,1680294297.311 [VerticalHomogeneityIndexCalculator] Loaded 2023-03-31T20:24:57.311Z,1680294297.311 [ComponentRegistry](DEBUG): SyncComponent "VerticalHomogeneityIndexCalculator" handled in the control thread. 2023-03-31T20:24:57.316Z,1680294297.316 [YawRateCalculator] Loaded 2023-03-31T20:24:57.316Z,1680294297.316 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2023-03-31T20:24:57.337Z,1680294297.337 [ElevatorOffsetCalculator] Loaded 2023-03-31T20:24:57.337Z,1680294297.337 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2023-03-31T20:24:57.338Z,1680294297.338 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2023-03-31T20:24:57.338Z,1680294297.338 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2023-03-31T20:24:57.405Z,1680294297.405 [VerticalControl](DEBUG): Construct VerticalControl. 2023-03-31T20:24:57.459Z,1680294297.459 [VerticalControl] Loaded 2023-03-31T20:24:57.460Z,1680294297.460 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2023-03-31T20:24:57.462Z,1680294297.462 [HorizontalControl](DEBUG): Construct HorizontalControl. 2023-03-31T20:24:57.502Z,1680294297.502 [HorizontalControl] Loaded 2023-03-31T20:24:57.503Z,1680294297.503 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2023-03-31T20:24:57.505Z,1680294297.505 [SpeedControl](DEBUG): Construct SpeedControl. 2023-03-31T20:24:57.508Z,1680294297.508 [SpeedControl] Loaded 2023-03-31T20:24:57.508Z,1680294297.508 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2023-03-31T20:24:57.511Z,1680294297.511 [LoopControl](DEBUG): Construct LoopControl. 2023-03-31T20:24:57.511Z,1680294297.511 [LoopControl] Loaded 2023-03-31T20:24:57.511Z,1680294297.511 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2023-03-31T20:24:57.512Z,1680294297.512 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2023-03-31T20:24:57.512Z,1680294297.512 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2023-03-31T20:24:57.647Z,1680294297.647 [DeadReckonUsingMultipleVelocitySources] Loaded 2023-03-31T20:24:57.648Z,1680294297.648 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2023-03-31T20:24:57.661Z,1680294297.661 [NavChart] Loaded 2023-03-31T20:24:57.661Z,1680294297.661 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2023-03-31T20:24:57.667Z,1680294297.667 [UniversalFixResidualReporter] Loaded 2023-03-31T20:24:57.667Z,1680294297.667 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2023-03-31T20:24:57.667Z,1680294297.667 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2023-03-31T20:24:57.668Z,1680294297.668 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2023-03-31T20:24:57.849Z,1680294297.849 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2023-03-31T20:24:57.850Z,1680294297.850 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2023-03-31T20:24:58.603Z,1680294298.603 [AHRS_M2] Loaded 2023-03-31T20:24:58.603Z,1680294298.603 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2023-03-31T20:24:58.853Z,1680294298.853 [BackseatComponent] Loaded 2023-03-31T20:24:58.853Z,1680294298.853 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2023-03-31T20:24:58.854Z,1680294298.854 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 408FD4E0 2023-03-31T20:24:58.855Z,1680294298.855 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 918 2023-03-31T20:24:58.857Z,1680294298.857 [LcmUniversalReporter] Loaded 2023-03-31T20:24:58.858Z,1680294298.858 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread. 2023-03-31T20:24:59.967Z,1680294299.967 [BPC1] Loaded 2023-03-31T20:24:59.967Z,1680294299.967 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2023-03-31T20:25:00.205Z,1680294300.205 [DataOverHttps] Loaded 2023-03-31T20:25:00.205Z,1680294300.205 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2023-03-31T20:25:00.260Z,1680294300.260 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 4092D4E0 2023-03-31T20:25:00.260Z,1680294300.260 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 919 2023-03-31T20:25:00.303Z,1680294300.303 [Depth_Keller] Loaded 2023-03-31T20:25:00.304Z,1680294300.304 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2023-03-31T20:25:00.341Z,1680294300.341 [DVL_micro] Loaded 2023-03-31T20:25:00.341Z,1680294300.341 [ComponentRegistry](DEBUG): SyncComponent "DVL_micro" handled in the control thread. 2023-03-31T20:25:00.402Z,1680294300.402 [NAL9602] Loaded 2023-03-31T20:25:00.402Z,1680294300.402 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2023-03-31T20:25:00.432Z,1680294300.432 [Onboard] Loaded 2023-03-31T20:25:00.433Z,1680294300.433 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2023-03-31T20:25:00.433Z,1680294300.433 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 4095D4E0 2023-03-31T20:25:00.434Z,1680294300.434 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 920 2023-03-31T20:25:00.446Z,1680294300.446 [Power24vConverter] Loaded 2023-03-31T20:25:00.446Z,1680294300.446 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2023-03-31T20:25:00.459Z,1680294300.459 [Radio_Surface] Loaded 2023-03-31T20:25:00.459Z,1680294300.459 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2023-03-31T20:25:00.460Z,1680294300.460 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 4098D4E0 2023-03-31T20:25:00.460Z,1680294300.460 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 921 2023-03-31T20:25:00.547Z,1680294300.547 [DATMMP] Loaded 2023-03-31T20:25:00.547Z,1680294300.547 [ComponentRegistry](DEBUG): Component "DATMMP" handled in its own thread. 2023-03-31T20:25:00.548Z,1680294300.548 [DATMMP ThreadHandler](DEBUG): Created PCaller Thread at 409BE4E0 2023-03-31T20:25:00.548Z,1680294300.548 [DATMMP ThreadHandler](INFO): Protected caller Thread ID is 922 2023-03-31T20:25:00.549Z,1680294300.549 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2023-03-31T20:25:00.549Z,1680294300.549 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2023-03-31T20:25:00.705Z,1680294300.705 [BuoyancyServo] Loaded 2023-03-31T20:25:00.706Z,1680294300.706 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2023-03-31T20:25:00.726Z,1680294300.726 [ElevatorServo] Loaded 2023-03-31T20:25:00.726Z,1680294300.726 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2023-03-31T20:25:00.746Z,1680294300.746 [MassServo] Loaded 2023-03-31T20:25:00.746Z,1680294300.746 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2023-03-31T20:25:00.764Z,1680294300.764 [RudderServo] Loaded 2023-03-31T20:25:00.764Z,1680294300.764 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2023-03-31T20:25:00.793Z,1680294300.793 [ThrusterHE] Loaded 2023-03-31T20:25:00.793Z,1680294300.793 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread. 2023-03-31T20:25:00.794Z,1680294300.794 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2023-03-31T20:25:00.794Z,1680294300.794 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2023-03-31T20:25:00.888Z,1680294300.888 [StratificationFrontDetector](IMPORTANT): thresholdVTHI set to: 0.050012 degC 2023-03-31T20:25:00.889Z,1680294300.889 [StratificationFrontDetector](INFO): (re)initializing 2023-03-31T20:25:00.889Z,1680294300.889 [StratificationFrontDetector] Loaded 2023-03-31T20:25:00.889Z,1680294300.889 [ComponentRegistry](DEBUG): SyncComponent "StratificationFrontDetector" handled in the control thread. 2023-03-31T20:25:00.890Z,1680294300.890 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2023-03-31T20:25:00.890Z,1680294300.890 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2023-03-31T20:25:00.932Z,1680294300.932 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2023-03-31T20:25:00.933Z,1680294300.933 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2023-03-31T20:25:01.283Z,1680294301.283 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2023-03-31T20:25:01.284Z,1680294301.284 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2023-03-31T20:25:01.539Z,1680294301.539 [CTD_Seabird] Loaded 2023-03-31T20:25:01.540Z,1680294301.540 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2023-03-31T20:25:01.541Z,1680294301.541 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40B484E0 2023-03-31T20:25:01.541Z,1680294301.541 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 924 2023-03-31T20:25:01.574Z,1680294301.574 [ESPComponent] Loaded 2023-03-31T20:25:01.575Z,1680294301.575 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread. 2023-03-31T20:25:01.594Z,1680294301.594 [PAR_Licor] Loaded 2023-03-31T20:25:01.595Z,1680294301.595 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2023-03-31T20:25:01.625Z,1680294301.625 [WetLabsBB2FL] Loaded 2023-03-31T20:25:01.625Z,1680294301.625 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2023-03-31T20:25:01.626Z,1680294301.626 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40B784E0 2023-03-31T20:25:01.627Z,1680294301.627 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 925 2023-03-31T20:25:01.628Z,1680294301.628 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2023-03-31T20:25:01.629Z,1680294301.629 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2023-03-31T20:25:01.795Z,1680294301.795 [SBIT](DEBUG): Construct Startup Built In Test. 2023-03-31T20:25:01.804Z,1680294301.804 [SBIT] Loaded 2023-03-31T20:25:01.805Z,1680294301.805 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2023-03-31T20:25:01.807Z,1680294301.807 [IBIT](DEBUG): Construct Initiated Built In Test. 2023-03-31T20:25:01.820Z,1680294301.820 [IBIT] Loaded 2023-03-31T20:25:01.820Z,1680294301.820 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2023-03-31T20:25:01.826Z,1680294301.826 [CBIT](DEBUG): Construct Continuous Built In Test. 2023-03-31T20:25:01.930Z,1680294301.930 [CBIT] Loaded 2023-03-31T20:25:01.930Z,1680294301.930 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2023-03-31T20:25:01.931Z,1680294301.931 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2023-03-31T20:25:01.937Z,1680294301.937 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2023-03-31T20:25:01.940Z,1680294301.940 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2023-03-31T20:25:01.951Z,1680294301.951 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2023-03-31T20:25:01.952Z,1680294301.952 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40BE64E0 2023-03-31T20:25:01.952Z,1680294301.952 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 926 2023-03-31T20:25:01.956Z,1680294301.956 [Supervisor](INFO): Main Thread ID is 828 2023-03-31T20:25:01.957Z,1680294301.957 [Supervisor](DEBUG): Running supervisor. 2023-03-31T20:25:01.957Z,1680294301.957 [CommandExec ThreadHandler](INFO): Handler Thread ID is 927 2023-03-31T20:25:01.958Z,1680294301.958 [CommandExec](INFO): Initializing the command executive. 2023-03-31T20:25:01.959Z,1680294301.959 [CommandLine ThreadHandler](INFO): Handler Thread ID is 928 2023-03-31T20:25:01.961Z,1680294301.961 [controlThread ThreadHandler](INFO): Handler Thread ID is 929 2023-03-31T20:25:01.962Z,1680294301.962 [controlThread](DEBUG): Initializing ControlThread 2023-03-31T20:25:01.962Z,1680294301.962 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2023-03-31T20:25:01.963Z,1680294301.963 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2023-03-31T20:25:01.963Z,1680294301.963 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2023-03-31T20:25:01.963Z,1680294301.963 [VerticalHomogeneityIndexCalculator](DEBUG): (re)initializing 2023-03-31T20:25:01.964Z,1680294301.964 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2023-03-31T20:25:01.965Z,1680294301.965 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2023-03-31T20:25:01.965Z,1680294301.965 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2023-03-31T20:25:01.967Z,1680294301.967 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2023-03-31T20:25:01.968Z,1680294301.968 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2023-03-31T20:25:01.968Z,1680294301.968 [LoopControl](DEBUG): Initialize LoopControlComponent. 2023-03-31T20:25:01.969Z,1680294301.969 [NavChart](DEBUG): Initialize NavChart Navigation. 2023-03-31T20:25:01.970Z,1680294301.970 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2023-03-31T20:25:01.976Z,1680294301.976 [SBIT](INFO): Initialize SBIT Component. 2023-03-31T20:25:01.977Z,1680294301.977 [SBIT](IMPORTANT): git: 2023-01-24-37-g2cb96bfa7 2023-03-31T20:25:01.977Z,1680294301.977 [SBIT](INFO): git hash: 2cb96bfa7ba90f0279afde19b052484c1354617e 2023-03-31T20:25:01.977Z,1680294301.977 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2023-03-31T20:25:01.978Z,1680294301.978 [SBIT](INFO): Kernel Reporting Different Version From Configuration. Kernel Expected: #1 PREEMPT Tue Sep 24 11:12:27 PDT 2019 Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021 2023-03-31T20:25:01.979Z,1680294301.979 [SBIT](INFO): Beginning SBIT in 131.000000 seconds. 2023-03-31T20:25:01.980Z,1680294301.980 [IBIT](INFO): Initialize IBIT Component. 2023-03-31T20:25:01.981Z,1680294301.981 [CBIT](DEBUG): Initialize CBIT Component. 2023-03-31T20:25:01.982Z,1680294301.982 [logger ThreadHandler](INFO): Handler Thread ID is 930 2023-03-31T20:25:01.992Z,1680294301.992 [CBIT](DEBUG): Initialized mux pins. 2023-03-31T20:25:01.992Z,1680294301.992 [CBIT](DEBUG): Initializing the watchdog timer. 2023-03-31T20:25:02.000Z,1680294302.000 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 931 2023-03-31T20:25:02.012Z,1680294302.012 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 932 2023-03-31T20:25:02.013Z,1680294302.013 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2023-03-31T20:25:02.016Z,1680294302.016 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2023-03-31T20:25:02.016Z,1680294302.016 [CBIT](DEBUG): Initializing heartbeat. 2023-03-31T20:25:02.024Z,1680294302.024 [Onboard ThreadHandler](INFO): Handler Thread ID is 933 2023-03-31T20:25:02.042Z,1680294302.042 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 934 2023-03-31T20:25:02.064Z,1680294302.064 [DATMMP ThreadHandler](INFO): Handler Thread ID is 935 2023-03-31T20:25:02.065Z,1680294302.065 [DATMMP](INFO): Start 2023-03-31T20:25:02.065Z,1680294302.065 [DATMMP](INFO): Powering up 2023-03-31T20:25:02.065Z,1680294302.065 [DATMMP](DEBUG): Initializing DATMMP. 2023-03-31T20:25:02.069Z,1680294302.069 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 937 2023-03-31T20:25:02.070Z,1680294302.070 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2023-03-31T20:25:02.073Z,1680294302.073 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 939 2023-03-31T20:25:02.076Z,1680294302.076 [WetLabsBB2FL](INFO): Powering up 2023-03-31T20:25:02.078Z,1680294302.078 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 941 2023-03-31T20:25:02.086Z,1680294302.086 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2023-03-31T20:25:02.086Z,1680294302.086 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2023-03-31T20:25:02.086Z,1680294302.086 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2023-03-31T20:25:02.086Z,1680294302.086 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2023-03-31T20:25:02.087Z,1680294302.087 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2023-03-31T20:25:02.087Z,1680294302.087 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2023-03-31T20:25:02.087Z,1680294302.087 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2023-03-31T20:25:02.087Z,1680294302.087 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2023-03-31T20:25:02.088Z,1680294302.088 [CBIT](DEBUG): Deactivating GF circuits. 2023-03-31T20:25:02.088Z,1680294302.088 [CBIT](DEBUG): Deactivating emergency mode. 2023-03-31T20:25:02.124Z,1680294302.124 [CBIT](DEBUG): Backplane powered. 2023-03-31T20:25:02.125Z,1680294302.125 [MissionManager](INFO): Loading Mission from file: Missions/Startup.xml 2023-03-31T20:25:02.152Z,1680294302.152 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2023-03-31T20:25:02.172Z,1680294302.172 [MissionManager](DEBUG): 2023-03-31T20:25:02.172Z,1680294302.172 [MissionManager](INFO): Loading Mission from file: Missions/Default.xml 2023-03-31T20:25:02.253Z,1680294302.253 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2023-03-31T20:25:02.254Z,1680294302.254 [Default:A.Wait](DEBUG): Construct Wait. 2023-03-31T20:25:02.256Z,1680294302.256 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2023-03-31T20:25:02.293Z,1680294302.293 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2023-03-31T20:25:02.316Z,1680294302.316 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2023-03-31T20:25:02.322Z,1680294302.322 [Default:E.Execute](DEBUG): Construct Execute. 2023-03-31T20:25:02.341Z,1680294302.341 [MissionManager](DEBUG): 0 Wait a moment to see if the scheduler starts a new mission before starting to actually run Default. 13 Burn on Dropped weight due to communications timeout. 5 Default mission has been running for Restarting logs and Default mission. restart logs 2023-03-31T20:25:02.346Z,1680294302.346 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DVL_micro,NAL9602,Power24vConverter,ESPComponent,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,VerticalHomogeneityIndexCalculator,YawRateCalculator,ElevatorOffsetCalculator,StratificationFrontDetector,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2023-03-31T20:25:02.368Z,1680294302.368 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2023-03-31T20:25:02.448Z,1680294302.448 [Radio_Surface](INFO): Powering up 2023-03-31T20:25:02.545Z,1680294302.545 [Power24vConverter](INFO): Powering up. 2023-03-31T20:25:02.598Z,1680294302.598 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2023-03-31T20:25:02.604Z,1680294302.604 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2023-03-31T20:25:02.605Z,1680294302.605 [ElevatorServo](DEBUG): Initializing EZServoServo. 2023-03-31T20:25:02.613Z,1680294302.613 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2023-03-31T20:25:02.614Z,1680294302.614 [MassServo](DEBUG): Initializing EZServoServo. 2023-03-31T20:25:02.620Z,1680294302.620 [MassServo](DEBUG): Initializing MassServo. 2023-03-31T20:25:02.621Z,1680294302.621 [RudderServo](DEBUG): Initializing EZServoServo. 2023-03-31T20:25:02.628Z,1680294302.628 [RudderServo](DEBUG): Initializing RudderServo. 2023-03-31T20:25:02.629Z,1680294302.629 [ThrusterHE](DEBUG): Initializing EZServoServo. 2023-03-31T20:25:02.636Z,1680294302.636 [ThrusterHE](DEBUG): Initializing ThrusterHE. 2023-03-31T20:25:03.504Z,1680294303.504 [RudderServo](ERROR): Rudder initialization uart error serial timeout 2023-03-31T20:25:03.504Z,1680294303.504 [RudderServo](FAULT): Rudder failed to initialize 2023-03-31T20:25:03.504Z,1680294303.504 [RudderServo] Communications Fault, FailCount= 1 2023-03-31T20:25:03.504Z,1680294303.504 [RudderServo](ERROR): Communications Fault 2023-03-31T20:25:03.508Z,1680294303.508 [CBIT](ERROR): Communications Fault in component: RudderServo 2023-03-31T20:25:03.705Z,1680294303.705 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2023-03-31T20:25:03.705Z,1680294303.705 [RudderServo](INFO): Powering down 2023-03-31T20:25:04.401Z,1680294304.401 [RudderServo](DEBUG): Initializing EZServoServo. 2023-03-31T20:25:04.521Z,1680294304.521 [RudderServo](DEBUG): Initializing RudderServo. 2023-03-31T20:25:04.525Z,1680294304.525 [CBIT](INFO): Clearing failed state for component RudderServo 2023-03-31T20:25:04.525Z,1680294304.525 [RudderServo] No Fault, FailCount= 1 2023-03-31T20:25:04.688Z,1680294304.688 [WetLabsBB2FL](INFO): Powering down 2023-03-31T20:25:08.145Z,1680294308.145 [ThrusterHE](ERROR): Zero Speed Commanded. 2023-03-31T20:25:13.908Z,1680294313.908 [DATMMP](INFO): DAT read: 2023-03-31T20:25:13.909Z,1680294313.909 [DATMMP](INFO): DAT read: Teledyne Benthos DAT-900 Series 2023-03-31T20:25:15.421Z,1680294315.421 [DATMMP](INFO): DAT read: MF Frequency Band 2023-03-31T20:25:15.422Z,1680294315.422 [DATMMP](INFO): DAT read: Directional Acoustic Transponder version 8.15.0 2023-03-31T20:25:15.423Z,1680294315.423 [DATMMP](INFO): DAT read: Mar 1 2000 20:25:06 2023-03-31T20:25:16.681Z,1680294316.681 [DATMMP](INFO): DAT read: Features enabled [Bearing] 2023-03-31T20:25:16.682Z,1680294316.682 [DATMMP](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP 2023-03-31T20:25:16.682Z,1680294316.682 [DATMMP](INFO): commRate: 800 2023-03-31T20:25:18.748Z,1680294318.748 [DATMMP](INFO): entering command mode 2023-03-31T20:25:18.948Z,1680294318.948 [DATMMP](INFO): DAT read: 2023-03-31T20:25:18.948Z,1680294318.948 [DATMMP](INFO): DAT read: user:1> 2023-03-31T20:25:18.949Z,1680294318.949 [DATMMP](DEBUG): read user prompt 1: user:1> 2023-03-31T20:25:18.949Z,1680294318.949 [DATMMP](INFO): entering MMP mode 2023-03-31T20:25:19.201Z,1680294319.201 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:25:19.202Z,1680294319.202 [DATMMP](INFO): status rx: x1 2023-03-31T20:25:19.203Z,1680294319.203 [DATMMP](INFO): MMP status: 1: started 2023-03-31T20:25:19.203Z,1680294319.203 [DATMMP](INFO): Received message type: status 2023-03-31T20:25:19.203Z,1680294319.203 [DATMMP](INFO): Handled 2023-03-31T20:25:19.453Z,1680294319.453 [DATMMP](INFO): Sent Tx Power Config 8 2023-03-31T20:25:19.454Z,1680294319.454 [DATMMP](INFO): Setting local address: 8 2023-03-31T20:25:19.455Z,1680294319.455 [DATMMP](INFO): Setting time to: 20:25:19 And date to:3/31/2023 2023-03-31T20:25:19.704Z,1680294319.704 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:25:19.705Z,1680294319.705 [DATMMP](INFO): mdmpower rx: x8 x0 x5 x0 2023-03-31T20:25:19.705Z,1680294319.705 [DATMMP](INFO): Received message type: mdmpower 2023-03-31T20:25:19.705Z,1680294319.705 [DATMMP](INFO): Handled 2023-03-31T20:25:19.956Z,1680294319.956 [DATMMP](INFO): GSXN notify for xid: 10 2023-03-31T20:25:19.957Z,1680294319.957 [DATMMP](INFO): sreg_txpower rx: x8 2023-03-31T20:25:19.957Z,1680294319.957 [DATMMP](INFO): Received message type: sreg_txpower 2023-03-31T20:25:19.957Z,1680294319.957 [DATMMP](INFO): Match for : sreg_txpower 2023-03-31T20:25:19.957Z,1680294319.957 [DATMMP](INFO): ACK 2023-03-31T20:25:20.208Z,1680294320.208 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:25:20.209Z,1680294320.209 [DATMMP](INFO): mdmlocal rx: x8 x0 x0 x0 2023-03-31T20:25:20.209Z,1680294320.209 [DATMMP](INFO): Received message type: mdmlocal 2023-03-31T20:25:20.209Z,1680294320.209 [DATMMP](INFO): Handled 2023-03-31T20:25:20.460Z,1680294320.460 [DATMMP](INFO): GSXN notify for xid: 11 2023-03-31T20:25:20.461Z,1680294320.461 [DATMMP](INFO): sreg_locaddr rx: x8 2023-03-31T20:25:20.461Z,1680294320.461 [DATMMP](INFO): Received message type: sreg_locaddr 2023-03-31T20:25:20.461Z,1680294320.461 [DATMMP](INFO): Match for : sreg_locaddr 2023-03-31T20:25:20.461Z,1680294320.461 [DATMMP](INFO): ACK 2023-03-31T20:25:20.712Z,1680294320.712 [DATMMP](INFO): GSXN notify for xid: 12 2023-03-31T20:25:20.713Z,1680294320.713 [DATMMP](INFO): timedate rx: x0 x14 x19 x13 x2 x1F x7B x0 2023-03-31T20:25:20.714Z,1680294320.714 [DATMMP](INFO): Received message type: timedate 2023-03-31T20:25:20.714Z,1680294320.714 [DATMMP](INFO): Match for : timedate 2023-03-31T20:25:20.714Z,1680294320.714 [DATMMP](INFO): ACK 2023-03-31T20:25:20.964Z,1680294320.964 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:25:20.965Z,1680294320.965 [DATMMP](INFO): sys_verb rx: x0 x0 x0 x0 2023-03-31T20:25:20.965Z,1680294320.965 [DATMMP](INFO): Received message type: sys_verb 2023-03-31T20:25:20.965Z,1680294320.965 [DATMMP](INFO): Handled 2023-03-31T20:25:21.216Z,1680294321.216 [DATMMP](INFO): GSXN notify for xid: 13 2023-03-31T20:25:21.217Z,1680294321.217 [DATMMP](INFO): sreg_verbosity rx: x0 2023-03-31T20:25:21.217Z,1680294321.217 [DATMMP](INFO): Received message type: sreg_verbosity 2023-03-31T20:25:21.217Z,1680294321.217 [DATMMP](INFO): Match for : sreg_verbosity 2023-03-31T20:25:21.217Z,1680294321.217 [DATMMP](INFO): ACK 2023-03-31T20:25:21.468Z,1680294321.468 [DATMMP](INFO): GSXN notify for xid: 14 2023-03-31T20:25:21.469Z,1680294321.469 [DATMMP](INFO): version rx: x2 x5 2023-03-31T20:25:21.469Z,1680294321.469 [DATMMP](INFO): DatMMPVersion: 2.5 2023-03-31T20:25:21.469Z,1680294321.469 [DATMMP](INFO): Received message type: version 2023-03-31T20:25:21.470Z,1680294321.470 [DATMMP](INFO): Match for : version 2023-03-31T20:25:21.470Z,1680294321.470 [DATMMP](INFO): ACK 2023-03-31T20:25:21.470Z,1680294321.470 [DATMMP](INFO): in MMP mode: config complete going to runnable 2023-03-31T20:25:30.642Z,1680294330.642 [NAL9602](INFO): Powering up NAL9602 2023-03-31T20:25:35.092Z,1680294335.092 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:25:35.093Z,1680294335.093 [DATMMP](INFO): timesync rx: x0 x1 x1 x0 2023-03-31T20:25:35.094Z,1680294335.094 [DATMMP](INFO): Received message type: timesync 2023-03-31T20:25:35.094Z,1680294335.094 [DATMMP](INFO): Handled 2023-03-31T20:25:41.554Z,1680294341.554 [NAL9602](INFO): NAL9602 initialized 2023-03-31T20:25:44.944Z,1680294344.944 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:25:44.945Z,1680294344.945 [DATMMP](INFO): timesync rx: x1 x0 x1 x0 2023-03-31T20:25:44.946Z,1680294344.946 [DATMMP](INFO): Received message type: timesync 2023-03-31T20:25:44.946Z,1680294344.946 [DATMMP](INFO): Handled 2023-03-31T20:26:41.751Z,1680294401.751 [DVL_micro](ERROR): only read 0 of 1 data item for BIT error 2023-03-31T20:26:41.752Z,1680294401.752 [DVL_micro](ERROR): Failed to parse: :TS,000000000000022.5,0000.0,1489.0,000 2023-03-31T20:27:13.703Z,1680294433.703 [SBIT](IMPORTANT): Beginning Startup BIT 2023-03-31T20:27:13.708Z,1680294433.708 [CBIT](IMPORTANT): Beginning ground fault scan 2023-03-31T20:27:24.658Z,1680294444.658 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): -0.016870 CHAN A1 (24V): -0.002436 CHAN A2 (12V): -0.000617 CHAN A3 (5V): 0.000591 CHAN B0 (3.3V): 0.000537 CHAN B1 (3.15aV): 0.000333 CHAN B2 (3.15bV): 0.000095 CHAN B3 (GND): 0.000288 OPEN: -0.004197 Full Scale: +/- 1 mA 2023-03-31T20:27:26.022Z,1680294446.022 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004481 2023-03-31T20:28:02.045Z,1680294482.045 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2023-03-31T20:28:02.045Z,1680294482.045 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-03-31T20:28:02.074Z,1680294482.074 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-03-31T20:28:02.443Z,1680294482.443 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-03-31T20:28:02.443Z,1680294482.443 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2023-03-31T20:28:07.321Z,1680294487.321 [SBIT](FAULT): Mass: EXPECTED:-0.027810 ACTUAL:-0.027978 2023-03-31T20:28:07.321Z,1680294487.321 [SBIT](FAULT): Control surface position failure. 2023-03-31T20:28:07.692Z,1680294487.692 [SBIT](CRITICAL): SBIT FAILED 2023-03-31T20:28:07.692Z,1680294487.692 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2023-03-31T20:28:07.693Z,1680294487.693 [SBIT](IMPORTANT): BPC1.batteryMissingStickThreshold=5 count; 2023-03-31T20:28:07.693Z,1680294487.693 [SBIT](IMPORTANT): BPC1.loadAtStartup=1 bool; 2023-03-31T20:28:07.693Z,1680294487.693 [SBIT](IMPORTANT): CBIT.runNavErrorCritical=0 bool; 2023-03-31T20:28:07.693Z,1680294487.693 [SBIT](IMPORTANT): CTD_Seabird.minSalinityBound=0 practical_salinity_unit; 2023-03-31T20:28:07.694Z,1680294487.694 [SBIT](IMPORTANT): DAT.sbdAddress=-1 enum; 2023-03-31T20:28:07.694Z,1680294487.694 [SBIT](IMPORTANT): DATMMP.sbdAddress=9 enum; 2023-03-31T20:28:07.694Z,1680294487.694 [SBIT](IMPORTANT): Depth_Keller.offset=3.9 decibar; 2023-03-31T20:28:07.694Z,1680294487.694 [SBIT](IMPORTANT): DropWeight.loadAtStartup=0 bool; 2023-03-31T20:28:07.694Z,1680294487.694 [SBIT](IMPORTANT): ESPComponent.simulateHardware=0 bool; 2023-03-31T20:28:07.694Z,1680294487.694 [SBIT](IMPORTANT): Express none CBIT.ampHoursUsed; 2023-03-31T20:28:07.694Z,1680294487.694 [SBIT](IMPORTANT): Express linearApproximation VerticalHomogeneityIndexCalculator.vertical_temperature_homogeneity_index 0.050000 celsius; 2023-03-31T20:28:07.694Z,1680294487.694 [SBIT](IMPORTANT): Express none WetLabsBB2FL.bin_mean_mass_concentration_of_chlorophyll_in_sea_water; 2023-03-31T20:28:07.695Z,1680294487.695 [SBIT](IMPORTANT): StratificationFrontDetector.loadAtStartup=1 bool; 2023-03-31T20:28:07.695Z,1680294487.695 [SBIT](IMPORTANT): StratificationFrontDetector.threshold_VTHI=0.05 celsius; 2023-03-31T20:28:07.695Z,1680294487.695 [SBIT](IMPORTANT): StratificationFrontDetector.verbosity=1 count; 2023-03-31T20:28:07.695Z,1680294487.695 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=341.374110 cubic_centimeter; 2023-03-31T20:28:07.695Z,1680294487.695 [SBIT](IMPORTANT): VerticalControl.massDefault=-27.810335 millimeter; 2023-03-31T20:28:07.695Z,1680294487.695 [SBIT](IMPORTANT): VerticalControl.massPositionLimitAft=-28 millimeter; 2023-03-31T20:28:07.695Z,1680294487.695 [SBIT](IMPORTANT): VerticalControl.massPositionLimitFwd=32 millimeter; 2023-03-31T20:28:07.696Z,1680294487.696 [SBIT](IMPORTANT): VerticalControl.surfaceThreshold=1.5 meter; 2023-03-31T20:28:07.696Z,1680294487.696 [SBIT](IMPORTANT): VerticalHomogeneityIndexCalculator.depth3=15 meter; 2023-03-31T20:28:07.696Z,1680294487.696 [SBIT](IMPORTANT): VerticalHomogeneityIndexCalculator.depth4=20 meter; 2023-03-31T20:28:07.696Z,1680294487.696 [SBIT](IMPORTANT): VerticalHomogeneityIndexCalculator.loadAtStartup=1 bool; 2023-03-31T20:28:07.697Z,1680294487.697 [CommandExec](FAULT): Scheduling is paused 2023-03-31T20:28:07.698Z,1680294487.698 [CBIT](INFO): Critical error at 20230331T202807 2023-03-31T20:28:07.698Z,1680294487.698 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2023-03-31T20:28:08.090Z,1680294488.090 [MissionManager](IMPORTANT): Started mission Startup 2023-03-31T20:28:08.090Z,1680294488.090 [Startup] Running Loop=1 2023-03-31T20:28:08.090Z,1680294488.090 [Startup](DEBUG): Aggregate::initialize Startup 2023-03-31T20:28:08.090Z,1680294488.090 [Startup:A.GoToSurface] Running Loop=1 2023-03-31T20:28:08.091Z,1680294488.091 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2023-03-31T20:28:08.113Z,1680294488.113 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2023-03-31T20:28:08.115Z,1680294488.115 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2023-03-31T20:28:08.119Z,1680294488.119 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2023-03-31T20:28:08.120Z,1680294488.120 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2023-03-31T20:28:08.120Z,1680294488.120 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2023-03-31T20:28:08.121Z,1680294488.121 [Startup:StartupSatComms] Running Loop=1 2023-03-31T20:28:08.122Z,1680294488.122 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2023-03-31T20:28:08.122Z,1680294488.122 [Startup:StartupSatComms:A] Running Loop=1 2023-03-31T20:28:08.490Z,1680294488.490 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2023-03-31T20:28:15.564Z,1680294495.564 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:28:15.565Z,1680294495.565 [DATMMP](ERROR): Failed to parse DAT message`:006E01040D00080001000000000000 2023-03-31T20:28:15.816Z,1680294495.816 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:28:15.817Z,1680294495.817 [DATMMP](INFO): timesync rx: x0 x0 x0 x0 2023-03-31T20:28:15.817Z,1680294495.817 [DATMMP](INFO): Received message type: timesync 2023-03-31T20:28:15.817Z,1680294495.817 [DATMMP](INFO): Handled 2023-03-31T20:29:08.289Z,1680294548.289 [Startup:StartupSatComms:A](INFO): Timed out from 2023-03-31T20:28:08.1Z 2023-03-31T20:29:08.289Z,1680294548.289 [Startup:StartupSatComms:A] Stopped 2023-03-31T20:29:08.290Z,1680294548.290 [Startup:StartupSatComms:B] Running Loop=1 2023-03-31T20:29:08.706Z,1680294548.706 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2023-03-31T20:29:13.328Z,1680294553.328 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20230331T201721/Courier0004.lzma 2023-03-31T20:29:14.333Z,1680294554.333 [DataOverHttps](INFO): Moved sent file to Logs/20230331T201721/Courier0004.lzma.bak 2023-03-31T20:29:14.333Z,1680294554.333 [DataOverHttps](INFO): SBD MOMSN=17883160 2023-03-31T20:29:34.519Z,1680294574.519 [DataOverHttps](INFO): Sending 185 bytes from file Logs/20230331T202450/Courier0000.lzma 2023-03-31T20:29:35.521Z,1680294575.521 [DataOverHttps](INFO): Moved sent file to Logs/20230331T202450/Courier0000.lzma.bak 2023-03-31T20:29:35.521Z,1680294575.521 [DataOverHttps](INFO): SBD MOMSN=17883162 2023-03-31T20:29:43.241Z,1680294583.241 [DVL_micro](ERROR): Failed to parse: :BD,+00000000.00,+00000000.00,+00000000.00,9999.99,000.00 2023-03-31T20:29:54.563Z,1680294594.563 [DataOverHttps](INFO): Sending 1359 bytes from file Logs/20230331T201721/Express0001.lzma 2023-03-31T20:29:55.561Z,1680294595.561 [DataOverHttps](INFO): Moved sent file to Logs/20230331T201721/Express0001.lzma.bak 2023-03-31T20:29:55.561Z,1680294595.561 [DataOverHttps](INFO): SBD MOMSN=17883166 2023-03-31T20:29:57.654Z,1680294597.654 [BPC1](ERROR): BPC1A: No match for serial number 0BE9 in BPC1A's battery stick inventory (sticks 1-32 in onboard configuration file). 2023-03-31T20:30:08.606Z,1680294608.606 [Startup:StartupSatComms:B](INFO): Timed out from 2023-03-31T20:29:08.3Z 2023-03-31T20:30:08.606Z,1680294608.606 [Startup:StartupSatComms:B] Stopped 2023-03-31T20:30:08.606Z,1680294608.606 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2023-03-31T20:30:08.606Z,1680294608.606 [Startup:StartupSatComms] Stopped 2023-03-31T20:30:08.606Z,1680294608.606 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2023-03-31T20:30:08.607Z,1680294608.607 [Startup](INFO): Completed Startup 2023-03-31T20:30:08.608Z,1680294608.608 [MissionManager](INFO): Startup is completed. 2023-03-31T20:30:08.608Z,1680294608.608 [MissionManager](INFO): Uninitializing Mission Startup 2023-03-31T20:30:08.608Z,1680294608.608 [Startup] Stopped 2023-03-31T20:30:08.608Z,1680294608.608 [Startup](DEBUG): Aggregate::uninitialize Startup 2023-03-31T20:30:08.608Z,1680294608.608 [Startup:A.GoToSurface] Stopped 2023-03-31T20:30:08.608Z,1680294608.608 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2023-03-31T20:30:09.032Z,1680294609.032 [MissionManager](IMPORTANT): Started mission Default 2023-03-31T20:30:09.032Z,1680294609.032 [Default] Running Loop=1 2023-03-31T20:30:09.032Z,1680294609.032 [Default](DEBUG): Aggregate::initialize Default 2023-03-31T20:30:09.033Z,1680294609.033 [Default:B.GoToSurface] Running Loop=1 2023-03-31T20:30:09.033Z,1680294609.033 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2023-03-31T20:30:09.033Z,1680294609.033 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2023-03-31T20:30:09.033Z,1680294609.033 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2023-03-31T20:30:09.033Z,1680294609.033 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2023-03-31T20:30:09.034Z,1680294609.034 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2023-03-31T20:30:09.034Z,1680294609.034 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2023-03-31T20:30:09.034Z,1680294609.034 [Default:A.Wait] Running Loop=1 2023-03-31T20:30:09.034Z,1680294609.034 [Default:A.Wait](DEBUG): Initialize Wait Component. 2023-03-31T20:30:12.324Z,1680294612.324 [BPC1](ERROR): BPC1A: No match for serial number 0BE9 in BPC1A's battery stick inventory (sticks 1-32 in onboard configuration file). 2023-03-31T20:30:17.550Z,1680294617.550 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20230331T201721/Express0005.lzma 2023-03-31T20:30:18.287Z,1680294618.287 [BPC1](ERROR): BPC1B: No match for serial number 0C0C in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2023-03-31T20:30:18.553Z,1680294618.553 [DataOverHttps](INFO): Moved sent file to Logs/20230331T201721/Express0005.lzma.bak 2023-03-31T20:30:18.553Z,1680294618.553 [DataOverHttps](INFO): SBD MOMSN=17883206 2023-03-31T20:30:21.752Z,1680294621.752 [CommandExec](IMPORTANT): got command failComponent 2023-03-31T20:30:21.752Z,1680294621.752 [CommandExec](IMPORTANT): Failed components: 2023-03-31T20:30:21.752Z,1680294621.752 [CommandExec](IMPORTANT): No failed Components. 2023-03-31T20:30:22.338Z,1680294622.338 [Default:A.Wait](INFO): Done Waiting. 2023-03-31T20:30:22.338Z,1680294622.338 [Default:A.Wait] Stopped 2023-03-31T20:30:22.339Z,1680294622.339 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2023-03-31T20:30:22.742Z,1680294622.742 [Default:CheckIn] Running Loop=1 2023-03-31T20:30:22.742Z,1680294622.742 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-03-31T20:30:22.743Z,1680294622.743 [Default:CheckIn:Read_GPS] Running Loop=1 2023-03-31T20:30:23.165Z,1680294623.165 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2023-03-31T20:30:26.770Z,1680294626.770 [BPC1](ERROR): BPC1A: No match for serial number 0BE9 in BPC1A's battery stick inventory (sticks 1-32 in onboard configuration file). 2023-03-31T20:30:31.585Z,1680294631.585 [CommandExec](IMPORTANT): got command get DATMMP.sbdAddress 2023-03-31T20:30:31.585Z,1680294631.585 [CommandExec](IMPORTANT): DATMMP.sbdAddress 9 enum 2023-03-31T20:30:32.826Z,1680294632.826 [BPC1](ERROR): BPC1B: No match for serial number 0C0C in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2023-03-31T20:30:37.637Z,1680294637.637 [CommandExec](IMPORTANT): got command get DATMMP.surfaceThreshold 2023-03-31T20:30:37.637Z,1680294637.637 [CommandExec](IMPORTANT): DATMMP.surfaceThreshold 0.500000 m 2023-03-31T20:30:40.914Z,1680294640.914 [BPC1](ERROR): BPC1A: No match for serial number 0BE9 in BPC1A's battery stick inventory (sticks 1-32 in onboard configuration file). 2023-03-31T20:30:44.949Z,1680294644.949 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2023-03-31T20:30:46.967Z,1680294646.967 [BPC1](ERROR): BPC1B: No match for serial number 0C0C in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2023-03-31T20:30:55.129Z,1680294655.129 [CommandExec](IMPORTANT): got command configSet DATMMP.sendExpress 1 bool persist 2023-03-31T20:30:55.455Z,1680294655.455 [BPC1](ERROR): BPC1A: No match for serial number 0BE9 in BPC1A's battery stick inventory (sticks 1-32 in onboard configuration file). 2023-03-31T20:30:58.363Z,1680294658.363 [CommandExec](IMPORTANT): got command failComponent hardware DATMMP 2023-03-31T20:30:58.363Z,1680294658.363 [DATMMP] Hardware Fault, FailCount= 1 2023-03-31T20:30:58.363Z,1680294658.363 [DATMMP](ERROR): Hardware Fault 2023-03-31T20:30:58.364Z,1680294658.364 [CommandExec](IMPORTANT): DATMMP failureMode is Hardware Fault 2023-03-31T20:30:58.487Z,1680294658.487 [DATMMP](INFO): Stop 2023-03-31T20:30:58.488Z,1680294658.488 [DATMMP](INFO): uninitialize 2023-03-31T20:30:58.488Z,1680294658.488 [DATMMP](INFO): Powering down 2023-03-31T20:30:58.713Z,1680294658.713 [CBIT](ERROR): Hardware Fault in component: DATMMP 2023-03-31T20:30:58.967Z,1680294658.967 [DATMMP](INFO): Stopping 2023-03-31T20:30:59.371Z,1680294659.371 [DATMMP](INFO): Stopped 2023-03-31T20:30:59.516Z,1680294659.516 [CBIT](INFO): Clearing failed state for component DATMMP 2023-03-31T20:30:59.516Z,1680294659.516 [DATMMP] No Fault, FailCount= 1 2023-03-31T20:30:59.775Z,1680294659.775 [DATMMP](INFO): Start 2023-03-31T20:31:00.027Z,1680294660.027 [DATMMP](INFO): Start 2023-03-31T20:31:00.279Z,1680294660.279 [DATMMP](INFO): Start 2023-03-31T20:31:00.531Z,1680294660.531 [DATMMP](INFO): Start 2023-03-31T20:31:00.783Z,1680294660.783 [DATMMP](INFO): Start 2023-03-31T20:31:01.035Z,1680294661.035 [DATMMP](INFO): Start 2023-03-31T20:31:01.106Z,1680294661.106 [BPC1](ERROR): BPC1B: No match for serial number 0C0C in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2023-03-31T20:31:01.287Z,1680294661.287 [DATMMP](INFO): Start 2023-03-31T20:31:01.539Z,1680294661.539 [DATMMP](INFO): Start 2023-03-31T20:31:01.539Z,1680294661.539 [DATMMP](INFO): Powering up 2023-03-31T20:31:01.540Z,1680294661.540 [DATMMP](DEBUG): Initializing DATMMP. 2023-03-31T20:31:01.791Z,1680294661.791 [DATMMP](INFO): in MMP mode: config complete going to runnable 2023-03-31T20:31:03.186Z,1680294663.186 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2023-03-31T20:31:03.186Z,1680294663.186 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-03-31T20:31:03.197Z,1680294663.197 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-03-31T20:31:03.561Z,1680294663.561 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-03-31T20:31:03.561Z,1680294663.561 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2023-03-31T20:31:10.008Z,1680294670.008 [BPC1](ERROR): BPC1A: No match for serial number 0BE9 in BPC1A's battery stick inventory (sticks 1-32 in onboard configuration file). 2023-03-31T20:31:13.846Z,1680294673.846 [CommandExec](IMPORTANT): got command maintain sensor Depth_Keller.depth 0.7 meter 2023-03-31T20:31:13.850Z,1680294673.850 [ComponentRegistry](DEBUG): SyncComponent "Maintain_Depth_Keller.depth" handled in the control thread. 2023-03-31T20:31:14.086Z,1680294674.086 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DVL_micro,NAL9602,Power24vConverter,ESPComponent,PAR_Licor,Depth_Keller,PAR_Licor,Maintain_Depth_Keller.depth,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,VerticalHomogeneityIndexCalculator,YawRateCalculator,ElevatorOffsetCalculator,StratificationFrontDetector,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2023-03-31T20:31:15.651Z,1680294675.651 [BPC1](ERROR): BPC1B: No match for serial number 0C0C in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2023-03-31T20:31:24.138Z,1680294684.138 [BPC1](ERROR): BPC1A: No match for serial number 0BE9 in BPC1A's battery stick inventory (sticks 1-32 in onboard configuration file). 2023-03-31T20:31:29.795Z,1680294689.795 [BPC1](ERROR): BPC1B: No match for serial number 0C0C in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2023-03-31T20:31:38.682Z,1680294698.682 [BPC1](ERROR): BPC1A: No match for serial number 0BE9 in BPC1A's battery stick inventory (sticks 1-32 in onboard configuration file). 2023-03-31T20:31:44.334Z,1680294704.334 [BPC1](ERROR): BPC1B: No match for serial number 0C0C in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2023-03-31T20:31:53.243Z,1680294713.243 [BPC1](ERROR): BPC1A: No match for serial number 0BE9 in BPC1A's battery stick inventory (sticks 1-32 in onboard configuration file). 2023-03-31T20:31:58.474Z,1680294718.474 [BPC1](ERROR): BPC1B: No match for serial number 0C0C in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2023-03-31T20:32:07.366Z,1680294727.366 [BPC1](ERROR): BPC1A: No match for serial number 0BE9 in BPC1A's battery stick inventory (sticks 1-32 in onboard configuration file). 2023-03-31T20:32:09.592Z,1680294729.592 [CommandExec](IMPORTANT): got command failComponent 2023-03-31T20:32:09.592Z,1680294729.592 [CommandExec](IMPORTANT): Failed components: 2023-03-31T20:32:09.592Z,1680294729.592 [CommandExec](IMPORTANT): No failed Components. 2023-03-31T20:32:12.616Z,1680294732.616 [BPC1](ERROR): BPC1B: No match for serial number 0C0C in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2023-03-31T20:32:27.158Z,1680294747.158 [BPC1](ERROR): BPC1B: No match for serial number 0C0C in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file). 2023-03-31T20:32:33.588Z,1680294753.588 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:32:33.589Z,1680294753.589 [DATMMP](ERROR): Failed to parse DAT message`:006E01040D00080000000300000101 2023-03-31T20:32:33.840Z,1680294753.840 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:32:33.840Z,1680294753.840 [DATMMP](INFO): doppler rx: x0 2023-03-31T20:32:33.841Z,1680294753.841 [DATMMP](INFO): Received message type: doppler 2023-03-31T20:32:33.841Z,1680294753.841 [DATMMP](INFO): Handled 2023-03-31T20:32:34.092Z,1680294754.092 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:32:34.093Z,1680294754.093 [DATMMP](INFO): timestamp rx: x1 x14 x20 x25 xF5 2023-03-31T20:32:34.094Z,1680294754.094 [DATMMP](INFO): Rx dataTimestamp_ set to:1680294759.411648 2023-03-31T20:32:34.094Z,1680294754.094 [DATMMP](INFO): Rx ping set to:1680294754.092773 2023-03-31T20:32:34.094Z,1680294754.094 [DATMMP](INFO): Received message type: timestamp 2023-03-31T20:32:34.094Z,1680294754.094 [DATMMP](INFO): Handled 2023-03-31T20:32:34.345Z,1680294754.345 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:32:34.361Z,1680294754.361 [DATMMP](INFO): nav_stat rx: x0 x1 x1 2023-03-31T20:32:34.361Z,1680294754.361 [DATMMP](INFO): Received message type: nav_stat 2023-03-31T20:32:34.362Z,1680294754.362 [DATMMP](INFO): Handled 2023-03-31T20:32:34.596Z,1680294754.596 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:32:34.597Z,1680294754.597 [DATMMP](INFO): directional_debug rx: xA9E x246 x3A x8B x1FF0 x22F1 x3052 x3033 2023-03-31T20:32:34.598Z,1680294754.598 [DATMMP](INFO): Received message type: directional_debug 2023-03-31T20:32:34.598Z,1680294754.598 [DATMMP](INFO): Handled 2023-03-31T20:32:34.848Z,1680294754.848 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:32:34.850Z,1680294754.850 [DATMMP](INFO): directional rx: xA8D x20D x94E xFDBA x378 xFEF2 x0 xD51 x5 xFC7E x27B5966 x-43569E0 2023-03-31T20:32:34.852Z,1680294754.852 [DATMMP](INFO): Received message type: directional 2023-03-31T20:32:34.852Z,1680294754.852 [DATMMP](INFO): Handled 2023-03-31T20:32:35.100Z,1680294755.100 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:32:35.101Z,1680294755.101 [DATMMP](INFO): remote_header rx: xF x4 x5 xF x0 x0 x9 x0 2023-03-31T20:32:35.101Z,1680294755.101 [DATMMP](INFO): DATA Src=9, Dst=0 2023-03-31T20:32:35.101Z,1680294755.101 [DATMMP](INFO): Received message type: remote_header 2023-03-31T20:32:35.101Z,1680294755.101 [DATMMP](INFO): Handled 2023-03-31T20:32:35.352Z,1680294755.352 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:32:35.353Z,1680294755.353 [DATMMP](INFO): acstats rx: x9 x5 x0 x16A x3B x57 xDC xAF xD xFFFF x0 x3E x0 x0 2023-03-31T20:32:35.354Z,1680294755.354 [DATMMP](INFO): Received message type: acstats 2023-03-31T20:32:35.354Z,1680294755.354 [DATMMP](INFO): Handled 2023-03-31T20:32:35.604Z,1680294755.604 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:32:35.605Z,1680294755.605 [DATMMP](ERROR): Failed to parse DAT message`:006E01040D00080001000000000000 2023-03-31T20:32:48.744Z,1680294768.744 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:32:48.745Z,1680294768.745 [DATMMP](ERROR): Failed to parse DAT message`:006E01040D0008000000030000000D 2023-03-31T20:32:48.996Z,1680294768.996 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:32:48.996Z,1680294768.996 [DATMMP](INFO): doppler rx: x0 2023-03-31T20:32:48.997Z,1680294768.997 [DATMMP](INFO): Received message type: doppler 2023-03-31T20:32:48.997Z,1680294768.997 [DATMMP](INFO): Handled 2023-03-31T20:32:49.248Z,1680294769.248 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:32:49.249Z,1680294769.249 [DATMMP](INFO): timestamp rx: x1 x14 x20 x34 x141 2023-03-31T20:32:49.249Z,1680294769.249 [DATMMP](INFO): Rx dataTimestamp_ set to:1680294775.141312 2023-03-31T20:32:49.249Z,1680294769.249 [DATMMP](INFO): Rx ping set to:1680294769.248665 2023-03-31T20:32:49.250Z,1680294769.250 [DATMMP](INFO): Received message type: timestamp 2023-03-31T20:32:49.250Z,1680294769.250 [DATMMP](INFO): Handled 2023-03-31T20:32:49.501Z,1680294769.501 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:32:49.502Z,1680294769.502 [DATMMP](INFO): nav_stat rx: x0 x1 x1 2023-03-31T20:32:49.503Z,1680294769.503 [DATMMP](INFO): Received message type: nav_stat 2023-03-31T20:32:49.503Z,1680294769.503 [DATMMP](INFO): Handled 2023-03-31T20:32:49.752Z,1680294769.752 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:32:49.753Z,1680294769.753 [DATMMP](INFO): directional_debug rx: x1EE xFE35 x3A x24 x1C50 x1F31 x2B32 x2DA3 2023-03-31T20:32:49.754Z,1680294769.754 [DATMMP](INFO): Received message type: directional_debug 2023-03-31T20:32:49.754Z,1680294769.754 [DATMMP](INFO): Handled 2023-03-31T20:32:50.004Z,1680294770.004 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:32:50.005Z,1680294770.005 [DATMMP](INFO): directional rx: x1DC xFE2D x3EE x1CB x963 x1B1 x0 xD51 x5 xFC7E x27B5966 x-43569E0 2023-03-31T20:32:50.007Z,1680294770.007 [DATMMP](INFO): Received message type: directional 2023-03-31T20:32:50.007Z,1680294770.007 [DATMMP](INFO): Handled 2023-03-31T20:32:50.256Z,1680294770.256 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:32:50.257Z,1680294770.257 [DATMMP](INFO): remote_header rx: xF x4 x5 xF x0 x0 x9 x0 2023-03-31T20:32:50.257Z,1680294770.257 [DATMMP](INFO): DATA Src=9, Dst=0 2023-03-31T20:32:50.257Z,1680294770.257 [DATMMP](INFO): Received message type: remote_header 2023-03-31T20:32:50.257Z,1680294770.257 [DATMMP](INFO): Handled 2023-03-31T20:32:50.508Z,1680294770.508 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:32:50.509Z,1680294770.509 [DATMMP](INFO): acstats rx: x9 x5 x0 x166 x3A x4E xC9 xBD xC xFFFF x0 x3E x0 x0 2023-03-31T20:32:50.510Z,1680294770.510 [DATMMP](INFO): Received message type: acstats 2023-03-31T20:32:50.510Z,1680294770.510 [DATMMP](INFO): Handled 2023-03-31T20:32:50.760Z,1680294770.760 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:32:50.761Z,1680294770.761 [DATMMP](ERROR): Failed to parse DAT message`:006E01040D00080001000000000000 2023-03-31T20:33:03.864Z,1680294783.864 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:33:03.865Z,1680294783.865 [DATMMP](ERROR): Failed to parse DAT message`:006E01040D0008000000030000000D 2023-03-31T20:33:04.116Z,1680294784.116 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:33:04.116Z,1680294784.116 [DATMMP](INFO): doppler rx: x0 2023-03-31T20:33:04.117Z,1680294784.117 [DATMMP](INFO): Received message type: doppler 2023-03-31T20:33:04.117Z,1680294784.117 [DATMMP](INFO): Handled 2023-03-31T20:33:04.370Z,1680294784.370 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:33:04.373Z,1680294784.373 [DATMMP](INFO): timestamp rx: x1 x14 x21 x7 x111 2023-03-31T20:33:04.377Z,1680294784.377 [DATMMP](INFO): Rx dataTimestamp_ set to:1680294789.698368 2023-03-31T20:33:04.379Z,1680294784.379 [DATMMP](INFO): Rx ping set to:1680294784.373651 2023-03-31T20:33:04.380Z,1680294784.380 [DATMMP](INFO): Received message type: timestamp 2023-03-31T20:33:04.380Z,1680294784.380 [DATMMP](INFO): Handled 2023-03-31T20:33:04.872Z,1680294784.872 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:33:04.872Z,1680294784.872 [DATMMP](INFO): nav_stat rx: x0 x1 x1 2023-03-31T20:33:04.873Z,1680294784.873 [DATMMP](INFO): Received message type: nav_stat 2023-03-31T20:33:04.873Z,1680294784.873 [DATMMP](INFO): Handled 2023-03-31T20:33:05.124Z,1680294785.124 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:33:05.125Z,1680294785.125 [DATMMP](INFO): directional_debug rx: x89 xFCB8 x3A x43 x7FF0 x7FF1 x7FF2 x7FF3 2023-03-31T20:33:05.126Z,1680294785.126 [DATMMP](INFO): Received message type: directional_debug 2023-03-31T20:33:05.126Z,1680294785.126 [DATMMP](INFO): Handled 2023-03-31T20:33:05.376Z,1680294785.376 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:33:05.377Z,1680294785.377 [DATMMP](INFO): directional rx: x82 xFCB7 x553 x348 x9A2 x2B x0 xD51 x5 xFC7E x27B5966 x-43569E0 2023-03-31T20:33:05.379Z,1680294785.379 [DATMMP](INFO): Received message type: directional 2023-03-31T20:33:05.379Z,1680294785.379 [DATMMP](INFO): Handled 2023-03-31T20:33:05.628Z,1680294785.628 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:33:05.629Z,1680294785.629 [DATMMP](INFO): remote_header rx: xF x4 x5 xF x0 x0 x9 x0 2023-03-31T20:33:05.629Z,1680294785.629 [DATMMP](INFO): DATA Src=9, Dst=0 2023-03-31T20:33:05.629Z,1680294785.629 [DATMMP](INFO): Received message type: remote_header 2023-03-31T20:33:05.629Z,1680294785.629 [DATMMP](INFO): Handled 2023-03-31T20:33:05.880Z,1680294785.880 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:33:05.881Z,1680294785.881 [DATMMP](INFO): acstats rx: x9 x5 x0 x188 x3B x55 xC8 xBB xD xFFFF x0 x42 x0 x0 2023-03-31T20:33:05.882Z,1680294785.882 [DATMMP](INFO): Received message type: acstats 2023-03-31T20:33:05.882Z,1680294785.882 [DATMMP](INFO): Handled 2023-03-31T20:33:06.132Z,1680294786.132 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:33:06.133Z,1680294786.133 [DATMMP](ERROR): Failed to parse DAT message`:006E01040D00080001000000000000 2023-03-31T20:33:18.988Z,1680294798.988 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:33:18.989Z,1680294798.989 [DATMMP](ERROR): Failed to parse DAT message`:006E01040D0008000000030000000D 2023-03-31T20:33:19.240Z,1680294799.240 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:33:19.240Z,1680294799.240 [DATMMP](INFO): doppler rx: x0 2023-03-31T20:33:19.240Z,1680294799.240 [DATMMP](INFO): Received message type: doppler 2023-03-31T20:33:19.241Z,1680294799.241 [DATMMP](INFO): Handled 2023-03-31T20:33:19.492Z,1680294799.492 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:33:19.493Z,1680294799.493 [DATMMP](INFO): timestamp rx: x1 x14 x21 x16 x154 2023-03-31T20:33:19.493Z,1680294799.493 [DATMMP](INFO): Rx dataTimestamp_ set to:1680294805.335872 2023-03-31T20:33:19.493Z,1680294799.493 [DATMMP](INFO): Rx ping set to:1680294799.492647 2023-03-31T20:33:19.494Z,1680294799.494 [DATMMP](INFO): Received message type: timestamp 2023-03-31T20:33:19.494Z,1680294799.494 [DATMMP](INFO): Handled 2023-03-31T20:33:19.996Z,1680294799.996 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:33:19.996Z,1680294799.996 [DATMMP](INFO): nav_stat rx: x0 x1 x1 2023-03-31T20:33:19.997Z,1680294799.997 [DATMMP](INFO): Received message type: nav_stat 2023-03-31T20:33:19.997Z,1680294799.997 [DATMMP](INFO): Handled 2023-03-31T20:33:20.248Z,1680294800.248 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:33:20.249Z,1680294800.249 [DATMMP](INFO): directional_debug rx: x347 xFE4B x3B x30 x1E50 x2431 x2F62 x32B3 2023-03-31T20:33:20.250Z,1680294800.250 [DATMMP](INFO): Received message type: directional_debug 2023-03-31T20:33:20.250Z,1680294800.250 [DATMMP](INFO): Handled 2023-03-31T20:33:20.500Z,1680294800.500 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:33:20.501Z,1680294800.501 [DATMMP](INFO): directional rx: x32C xFE43 x295 x1B5 xAB0 x1A2 x0 xD51 x5 xFC7E x27B5966 x-43569E0 2023-03-31T20:33:20.508Z,1680294800.508 [DATMMP](INFO): Received message type: directional 2023-03-31T20:33:20.508Z,1680294800.508 [DATMMP](INFO): Handled 2023-03-31T20:33:20.752Z,1680294800.752 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:33:20.753Z,1680294800.753 [DATMMP](INFO): remote_header rx: xF x4 x5 xF x0 x0 x9 x0 2023-03-31T20:33:20.753Z,1680294800.753 [DATMMP](INFO): DATA Src=9, Dst=0 2023-03-31T20:33:20.753Z,1680294800.753 [DATMMP](INFO): Received message type: remote_header 2023-03-31T20:33:20.753Z,1680294800.753 [DATMMP](INFO): Handled 2023-03-31T20:33:21.004Z,1680294801.004 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:33:21.005Z,1680294801.005 [DATMMP](INFO): acstats rx: x9 x5 x0 x130 x3A x54 xBA xBF xD xFFFF x0 x40 x0 x0 2023-03-31T20:33:21.006Z,1680294801.006 [DATMMP](INFO): Received message type: acstats 2023-03-31T20:33:21.006Z,1680294801.006 [DATMMP](INFO): Handled 2023-03-31T20:33:21.256Z,1680294801.256 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:33:21.257Z,1680294801.257 [DATMMP](ERROR): Failed to parse DAT message`:006E01040D00080001000000000000 2023-03-31T20:33:34.116Z,1680294814.116 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:33:34.117Z,1680294814.117 [DATMMP](ERROR): Failed to parse DAT message`:006E01040D0008000000030000000D 2023-03-31T20:33:34.368Z,1680294814.368 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:33:34.368Z,1680294814.368 [DATMMP](INFO): doppler rx: x0 2023-03-31T20:33:34.369Z,1680294814.369 [DATMMP](INFO): Received message type: doppler 2023-03-31T20:33:34.369Z,1680294814.369 [DATMMP](INFO): Handled 2023-03-31T20:33:34.620Z,1680294814.620 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:33:34.621Z,1680294814.621 [DATMMP](INFO): timestamp rx: x1 x14 x21 x25 x129 2023-03-31T20:33:34.621Z,1680294814.621 [DATMMP](INFO): Rx dataTimestamp_ set to:1680294819.944128 2023-03-31T20:33:34.621Z,1680294814.621 [DATMMP](INFO): Rx ping set to:1680294814.620708 2023-03-31T20:33:34.622Z,1680294814.622 [DATMMP](INFO): Received message type: timestamp 2023-03-31T20:33:34.622Z,1680294814.622 [DATMMP](INFO): Handled 2023-03-31T20:33:35.124Z,1680294815.124 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:33:35.124Z,1680294815.124 [DATMMP](INFO): nav_stat rx: x0 x1 x1 2023-03-31T20:33:35.125Z,1680294815.125 [DATMMP](INFO): Received message type: nav_stat 2023-03-31T20:33:35.125Z,1680294815.125 [DATMMP](INFO): Handled 2023-03-31T20:33:35.376Z,1680294815.376 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:33:35.377Z,1680294815.377 [DATMMP](INFO): directional_debug rx: x1D6 xFE6E x38 x31 x36C0 x3F71 x37C2 x4133 2023-03-31T20:33:35.378Z,1680294815.378 [DATMMP](INFO): Received message type: directional_debug 2023-03-31T20:33:35.378Z,1680294815.378 [DATMMP](INFO): Handled 2023-03-31T20:33:35.628Z,1680294815.628 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:33:35.629Z,1680294815.629 [DATMMP](INFO): directional rx: x1C9 xFE68 x406 x192 x932 x1E2 x0 xD51 x5 xFC7E x27B5966 x-43569E0 2023-03-31T20:33:35.631Z,1680294815.631 [DATMMP](INFO): Received message type: directional 2023-03-31T20:33:35.631Z,1680294815.631 [DATMMP](INFO): Handled 2023-03-31T20:33:35.880Z,1680294815.880 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:33:35.881Z,1680294815.881 [DATMMP](INFO): remote_header rx: xF x4 x5 xF x0 x0 x9 x0 2023-03-31T20:33:35.881Z,1680294815.881 [DATMMP](INFO): DATA Src=9, Dst=0 2023-03-31T20:33:35.881Z,1680294815.881 [DATMMP](INFO): Received message type: remote_header 2023-03-31T20:33:35.881Z,1680294815.881 [DATMMP](INFO): Handled 2023-03-31T20:33:36.132Z,1680294816.132 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:33:36.133Z,1680294816.133 [DATMMP](INFO): acstats rx: x9 x5 x0 x14D x3A x4C xC6 xBD xD xFFFF x0 x3D x0 x0 2023-03-31T20:33:36.134Z,1680294816.134 [DATMMP](INFO): Received message type: acstats 2023-03-31T20:33:36.134Z,1680294816.134 [DATMMP](INFO): Handled 2023-03-31T20:33:36.384Z,1680294816.384 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:33:36.385Z,1680294816.385 [DATMMP](ERROR): Failed to parse DAT message`:006E01040D00080001000000000000 2023-03-31T20:33:49.236Z,1680294829.236 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:33:49.237Z,1680294829.237 [DATMMP](ERROR): Failed to parse DAT message`:006E01040D0008000000030000000D 2023-03-31T20:33:49.488Z,1680294829.488 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:33:49.488Z,1680294829.488 [DATMMP](INFO): doppler rx: xFFFF 2023-03-31T20:33:49.488Z,1680294829.488 [DATMMP](INFO): Received message type: doppler 2023-03-31T20:33:49.489Z,1680294829.489 [DATMMP](INFO): Handled 2023-03-31T20:33:49.741Z,1680294829.741 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:33:49.745Z,1680294829.745 [DATMMP](INFO): timestamp rx: x1 x14 x21 x34 x175 2023-03-31T20:33:49.746Z,1680294829.746 [DATMMP](INFO): Rx dataTimestamp_ set to:1680294835.673792 2023-03-31T20:33:49.746Z,1680294829.746 [DATMMP](INFO): Rx ping set to:1680294829.744805 2023-03-31T20:33:49.746Z,1680294829.746 [DATMMP](INFO): Received message type: timestamp 2023-03-31T20:33:49.746Z,1680294829.746 [DATMMP](INFO): Handled 2023-03-31T20:33:50.246Z,1680294830.246 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:33:50.247Z,1680294830.247 [DATMMP](INFO): nav_stat rx: x0 x1 x1 2023-03-31T20:33:50.248Z,1680294830.248 [DATMMP](INFO): Received message type: nav_stat 2023-03-31T20:33:50.248Z,1680294830.248 [DATMMP](INFO): Handled 2023-03-31T20:33:50.496Z,1680294830.496 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:33:50.497Z,1680294830.497 [DATMMP](INFO): directional_debug rx: xC52 xFFD8 x3B x2DA x1EF0 x24A1 x3072 x3393 2023-03-31T20:33:50.498Z,1680294830.498 [DATMMP](INFO): Received message type: directional_debug 2023-03-31T20:33:50.498Z,1680294830.498 [DATMMP](INFO): Handled 2023-03-31T20:33:50.748Z,1680294830.748 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:33:50.749Z,1680294830.749 [DATMMP](INFO): directional rx: xC61 xFFF7 x79A x28 x673 xFF69 x0 xD51 x5 xFC7E x27B5966 x-43569E0 2023-03-31T20:33:50.751Z,1680294830.751 [DATMMP](INFO): Received message type: directional 2023-03-31T20:33:50.751Z,1680294830.751 [DATMMP](INFO): Handled 2023-03-31T20:33:50.000Z,1680294831.000 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:33:51.001Z,1680294831.001 [DATMMP](INFO): remote_header rx: xF x4 x5 xF x0 x0 x9 x0 2023-03-31T20:33:51.001Z,1680294831.001 [DATMMP](INFO): DATA Src=9, Dst=0 2023-03-31T20:33:51.001Z,1680294831.001 [DATMMP](INFO): Received message type: remote_header 2023-03-31T20:33:51.001Z,1680294831.001 [DATMMP](INFO): Handled 2023-03-31T20:33:51.252Z,1680294831.252 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:33:51.253Z,1680294831.253 [DATMMP](INFO): acstats rx: x9 x5 xFFFF x114 x3B x52 xCC xBE xD xFFFF x0 x40 x0 x0 2023-03-31T20:33:51.254Z,1680294831.254 [DATMMP](INFO): Received message type: acstats 2023-03-31T20:33:51.254Z,1680294831.254 [DATMMP](INFO): Handled 2023-03-31T20:33:51.504Z,1680294831.504 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:33:51.505Z,1680294831.505 [DATMMP](ERROR): Failed to parse DAT message`:006E01040D00080001000000000000 2023-03-31T20:34:04.132Z,1680294844.132 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3 2023-03-31T20:34:04.132Z,1680294844.132 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-03-31T20:34:04.171Z,1680294844.171 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-03-31T20:34:04.356Z,1680294844.356 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:34:04.357Z,1680294844.357 [DATMMP](ERROR): Failed to parse DAT message`:006E01040D0008000000030000000D 2023-03-31T20:34:04.543Z,1680294844.543 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-03-31T20:34:04.543Z,1680294844.543 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3 2023-03-31T20:34:04.608Z,1680294844.608 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:34:04.608Z,1680294844.608 [DATMMP](INFO): doppler rx: x0 2023-03-31T20:34:04.608Z,1680294844.608 [DATMMP](INFO): Received message type: doppler 2023-03-31T20:34:04.609Z,1680294844.609 [DATMMP](INFO): Handled 2023-03-31T20:34:04.860Z,1680294844.860 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:34:04.861Z,1680294844.861 [DATMMP](INFO): timestamp rx: x1 x14 x22 x7 x14D 2023-03-31T20:34:04.861Z,1680294844.861 [DATMMP](INFO): Rx dataTimestamp_ set to:1680294850.264192 2023-03-31T20:34:04.861Z,1680294844.861 [DATMMP](INFO): Rx ping set to:1680294844.860564 2023-03-31T20:34:04.861Z,1680294844.861 [DATMMP](INFO): Received message type: timestamp 2023-03-31T20:34:04.862Z,1680294844.862 [DATMMP](INFO): Handled 2023-03-31T20:34:05.365Z,1680294845.365 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:34:05.366Z,1680294845.366 [DATMMP](INFO): nav_stat rx: x0 x1 x1 2023-03-31T20:34:05.366Z,1680294845.366 [DATMMP](INFO): Received message type: nav_stat 2023-03-31T20:34:05.366Z,1680294845.366 [DATMMP](INFO): Handled 2023-03-31T20:34:05.616Z,1680294845.616 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:34:05.617Z,1680294845.617 [DATMMP](INFO): directional_debug rx: x210 xFEFA x37 x30 x3CA0 x38A1 x3D42 x3B73 2023-03-31T20:34:05.618Z,1680294845.618 [DATMMP](INFO): Received message type: directional_debug 2023-03-31T20:34:05.618Z,1680294845.618 [DATMMP](INFO): Handled 2023-03-31T20:34:05.868Z,1680294845.868 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:34:05.869Z,1680294845.869 [DATMMP](INFO): directional rx: x1EE xFEFB x3CC x106 x933 x276 x0 xD51 x5 xFC7E x27B5966 x-43569E0 2023-03-31T20:34:05.871Z,1680294845.871 [DATMMP](INFO): Received message type: directional 2023-03-31T20:34:05.871Z,1680294845.871 [DATMMP](INFO): Handled 2023-03-31T20:34:06.120Z,1680294846.120 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:34:06.121Z,1680294846.121 [DATMMP](INFO): remote_header rx: xF x4 x5 xF x0 x0 x9 x0 2023-03-31T20:34:06.121Z,1680294846.121 [DATMMP](INFO): DATA Src=9, Dst=0 2023-03-31T20:34:06.122Z,1680294846.122 [DATMMP](INFO): Received message type: remote_header 2023-03-31T20:34:06.122Z,1680294846.122 [DATMMP](INFO): Handled 2023-03-31T20:34:06.372Z,1680294846.372 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:34:06.373Z,1680294846.373 [DATMMP](INFO): acstats rx: x9 x5 x0 x134 x3A x4E xCD xC3 xD xFFFF x0 x3F x0 x0 2023-03-31T20:34:06.374Z,1680294846.374 [DATMMP](INFO): Received message type: acstats 2023-03-31T20:34:06.374Z,1680294846.374 [DATMMP](INFO): Handled 2023-03-31T20:34:06.624Z,1680294846.624 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:34:06.625Z,1680294846.625 [DATMMP](ERROR): Failed to parse DAT message`:006E01040D00080001000000000000 2023-03-31T20:34:19.480Z,1680294859.480 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:34:19.481Z,1680294859.481 [DATMMP](ERROR): Failed to parse DAT message`:006E01040D0008000000030000000D 2023-03-31T20:34:19.732Z,1680294859.732 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:34:19.732Z,1680294859.732 [DATMMP](INFO): doppler rx: x0 2023-03-31T20:34:19.732Z,1680294859.732 [DATMMP](INFO): Received message type: doppler 2023-03-31T20:34:19.733Z,1680294859.733 [DATMMP](INFO): Handled 2023-03-31T20:34:19.984Z,1680294859.984 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:34:19.985Z,1680294859.985 [DATMMP](INFO): timestamp rx: x1 x14 x22 x17 x130 2023-03-31T20:34:19.985Z,1680294859.985 [DATMMP](INFO): Rx dataTimestamp_ set to:1680294866.015808 2023-03-31T20:34:19.986Z,1680294859.986 [DATMMP](INFO): Rx ping set to:1680294859.984796 2023-03-31T20:34:19.986Z,1680294859.986 [DATMMP](INFO): Received message type: timestamp 2023-03-31T20:34:19.986Z,1680294859.986 [DATMMP](INFO): Handled 2023-03-31T20:34:20.488Z,1680294860.488 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:34:20.489Z,1680294860.489 [DATMMP](INFO): nav_stat rx: x0 x1 x1 2023-03-31T20:34:20.489Z,1680294860.489 [DATMMP](INFO): Received message type: nav_stat 2023-03-31T20:34:20.489Z,1680294860.489 [DATMMP](INFO): Handled 2023-03-31T20:34:20.740Z,1680294860.740 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:34:20.741Z,1680294860.741 [DATMMP](INFO): directional_debug rx: x1A8 xFE18 x39 x26 x3650 x3871 x3762 x3C83 2023-03-31T20:34:20.742Z,1680294860.742 [DATMMP](INFO): Received message type: directional_debug 2023-03-31T20:34:20.742Z,1680294860.742 [DATMMP](INFO): Handled 2023-03-31T20:34:20.992Z,1680294860.992 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:34:20.993Z,1680294860.993 [DATMMP](INFO): directional rx: x193 xFE0F x434 x1E8 x935 x186 x0 xD51 x5 xFC7E x27B5966 x-43569E0 2023-03-31T20:34:20.995Z,1680294860.995 [DATMMP](INFO): Received message type: directional 2023-03-31T20:34:20.995Z,1680294860.995 [DATMMP](INFO): Handled 2023-03-31T20:34:21.244Z,1680294861.244 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:34:21.245Z,1680294861.245 [DATMMP](INFO): remote_header rx: xF x4 x5 xF x0 x0 x9 x0 2023-03-31T20:34:21.245Z,1680294861.245 [DATMMP](INFO): DATA Src=9, Dst=0 2023-03-31T20:34:21.245Z,1680294861.245 [DATMMP](INFO): Received message type: remote_header 2023-03-31T20:34:21.245Z,1680294861.245 [DATMMP](INFO): Handled 2023-03-31T20:34:21.496Z,1680294861.496 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:34:21.497Z,1680294861.497 [DATMMP](INFO): acstats rx: x9 x5 x0 x106 x3A x4D xBE xB8 xD xFFFF x0 x40 x0 x0 2023-03-31T20:34:21.497Z,1680294861.497 [DATMMP](INFO): Received message type: acstats 2023-03-31T20:34:21.497Z,1680294861.497 [DATMMP](INFO): Handled 2023-03-31T20:34:21.748Z,1680294861.748 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:34:21.749Z,1680294861.749 [DATMMP](ERROR): Failed to parse DAT message`:006E01040D00080001000000000000 2023-03-31T20:34:23.515Z,1680294863.515 [DVL_micro](ERROR): only read 0 of 1 data item for BIT error 2023-03-31T20:34:23.515Z,1680294863.515 [DVL_micro](ERROR): Failed to parse: :TS,00000000000000,35.0000.0,1489.0,000 2023-03-31T20:34:34.602Z,1680294874.602 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:34:34.604Z,1680294874.604 [DATMMP](ERROR): Failed to parse DAT message`:006E01040D0008000000030000000D 2023-03-31T20:34:34.852Z,1680294874.852 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:34:34.852Z,1680294874.852 [DATMMP](INFO): doppler rx: xFFFF 2023-03-31T20:34:34.853Z,1680294874.853 [DATMMP](INFO): Received message type: doppler 2023-03-31T20:34:34.853Z,1680294874.853 [DATMMP](INFO): Handled 2023-03-31T20:34:35.104Z,1680294875.104 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:34:35.105Z,1680294875.105 [DATMMP](INFO): timestamp rx: x1 x14 x22 x26 x112 2023-03-31T20:34:35.105Z,1680294875.105 [DATMMP](INFO): Rx dataTimestamp_ set to:1680294880.708608 2023-03-31T20:34:35.105Z,1680294875.105 [DATMMP](INFO): Rx ping set to:1680294875.104598 2023-03-31T20:34:35.106Z,1680294875.106 [DATMMP](INFO): Received message type: timestamp 2023-03-31T20:34:35.106Z,1680294875.106 [DATMMP](INFO): Handled 2023-03-31T20:34:35.608Z,1680294875.608 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:34:35.608Z,1680294875.608 [DATMMP](INFO): nav_stat rx: x0 x1 x1 2023-03-31T20:34:35.608Z,1680294875.608 [DATMMP](INFO): Received message type: nav_stat 2023-03-31T20:34:35.609Z,1680294875.609 [DATMMP](INFO): Handled 2023-03-31T20:34:35.860Z,1680294875.860 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:34:35.861Z,1680294875.861 [DATMMP](INFO): directional_debug rx: x19F xFD74 x3A x32 x3040 x3E41 x35B2 x3E33 2023-03-31T20:34:35.862Z,1680294875.862 [DATMMP](INFO): Received message type: directional_debug 2023-03-31T20:34:35.862Z,1680294875.862 [DATMMP](INFO): Handled 2023-03-31T20:34:36.112Z,1680294876.112 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:34:36.113Z,1680294876.113 [DATMMP](INFO): directional rx: x185 xFD6A x43D x28C x977 xEC x0 xD51 x5 xFC7E x27B5966 x-43569E0 2023-03-31T20:34:36.115Z,1680294876.115 [DATMMP](INFO): Received message type: directional 2023-03-31T20:34:36.115Z,1680294876.115 [DATMMP](INFO): Handled 2023-03-31T20:34:36.364Z,1680294876.364 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:34:36.365Z,1680294876.365 [DATMMP](INFO): remote_header rx: xF x4 x5 xF x0 x0 x9 x0 2023-03-31T20:34:36.365Z,1680294876.365 [DATMMP](INFO): DATA Src=9, Dst=0 2023-03-31T20:34:36.365Z,1680294876.365 [DATMMP](INFO): Received message type: remote_header 2023-03-31T20:34:36.365Z,1680294876.365 [DATMMP](INFO): Handled 2023-03-31T20:34:36.616Z,1680294876.616 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:34:36.618Z,1680294876.618 [DATMMP](INFO): acstats rx: x9 x5 xFFFF x10B x3B x54 xB2 xB6 xD xFFFF x0 x3D x0 x0 2023-03-31T20:34:36.618Z,1680294876.618 [DATMMP](INFO): Received message type: acstats 2023-03-31T20:34:36.618Z,1680294876.618 [DATMMP](INFO): Handled 2023-03-31T20:34:36.868Z,1680294876.868 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:34:36.869Z,1680294876.869 [DATMMP](ERROR): Failed to parse DAT message`:006E01040D00080001000000000000 2023-03-31T20:34:49.728Z,1680294889.728 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:34:49.729Z,1680294889.729 [DATMMP](ERROR): Failed to parse DAT message`:006E01040D0008000000030000000D 2023-03-31T20:34:49.980Z,1680294889.980 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:34:49.980Z,1680294889.980 [DATMMP](INFO): doppler rx: x0 2023-03-31T20:34:49.981Z,1680294889.981 [DATMMP](INFO): Received message type: doppler 2023-03-31T20:34:49.981Z,1680294889.981 [DATMMP](INFO): Handled 2023-03-31T20:34:50.232Z,1680294890.232 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:34:50.233Z,1680294890.233 [DATMMP](INFO): timestamp rx: x1 x14 x22 x35 x14F 2023-03-31T20:34:50.233Z,1680294890.233 [DATMMP](INFO): Rx dataTimestamp_ set to:1680294896.284672 2023-03-31T20:34:50.234Z,1680294890.234 [DATMMP](INFO): Rx ping set to:1680294890.232774 2023-03-31T20:34:50.234Z,1680294890.234 [DATMMP](INFO): Received message type: timestamp 2023-03-31T20:34:50.234Z,1680294890.234 [DATMMP](INFO): Handled 2023-03-31T20:34:50.736Z,1680294890.736 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:34:50.736Z,1680294890.736 [DATMMP](INFO): nav_stat rx: x0 x1 x1 2023-03-31T20:34:50.737Z,1680294890.737 [DATMMP](INFO): Received message type: nav_stat 2023-03-31T20:34:50.737Z,1680294890.737 [DATMMP](INFO): Handled 2023-03-31T20:34:50.988Z,1680294890.988 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:34:50.989Z,1680294890.989 [DATMMP](INFO): directional_debug rx: x21A xFCB3 x3B x15 x1E10 x24E1 x3192 x3123 2023-03-31T20:34:50.990Z,1680294890.990 [DATMMP](INFO): Received message type: directional_debug 2023-03-31T20:34:50.990Z,1680294890.990 [DATMMP](INFO): Handled 2023-03-31T20:34:51.240Z,1680294891.240 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:34:51.241Z,1680294891.241 [DATMMP](INFO): directional rx: x214 xFCB1 x3C2 x34D x9C7 x39 x0 xD51 x5 xFC7E x27B5966 x-43569E0 2023-03-31T20:34:51.243Z,1680294891.243 [DATMMP](INFO): Received message type: directional 2023-03-31T20:34:51.243Z,1680294891.243 [DATMMP](INFO): Handled 2023-03-31T20:34:51.492Z,1680294891.492 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:34:51.493Z,1680294891.493 [DATMMP](INFO): remote_header rx: xF x4 x5 xF x0 x0 x9 x0 2023-03-31T20:34:51.493Z,1680294891.493 [DATMMP](INFO): DATA Src=9, Dst=0 2023-03-31T20:34:51.493Z,1680294891.493 [DATMMP](INFO): Received message type: remote_header 2023-03-31T20:34:51.493Z,1680294891.493 [DATMMP](INFO): Handled 2023-03-31T20:34:51.744Z,1680294891.744 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:34:51.745Z,1680294891.745 [DATMMP](INFO): acstats rx: x9 x5 x0 x121 x3B x57 xA5 xB4 xD xFFFF x0 x40 x0 x0 2023-03-31T20:34:51.745Z,1680294891.745 [DATMMP](INFO): Received message type: acstats 2023-03-31T20:34:51.746Z,1680294891.746 [DATMMP](INFO): Handled 2023-03-31T20:34:51.996Z,1680294891.996 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:34:51.997Z,1680294891.997 [DATMMP](ERROR): Failed to parse DAT message`:006E01040D00080001000000000000 2023-03-31T20:35:04.856Z,1680294904.856 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:35:04.857Z,1680294904.857 [DATMMP](ERROR): Failed to parse DAT message`:006E01040D0008000000030000000D 2023-03-31T20:35:05.108Z,1680294905.108 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:35:05.109Z,1680294905.109 [DATMMP](INFO): doppler rx: x0 2023-03-31T20:35:05.109Z,1680294905.109 [DATMMP](INFO): Received message type: doppler 2023-03-31T20:35:05.109Z,1680294905.109 [DATMMP](INFO): Handled 2023-03-31T20:35:05.360Z,1680294905.360 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:35:05.361Z,1680294905.361 [DATMMP](INFO): timestamp rx: x1 x14 x23 x8 x136 2023-03-31T20:35:05.361Z,1680294905.361 [DATMMP](INFO): Rx dataTimestamp_ set to:1680294911.028672 2023-03-31T20:35:05.362Z,1680294905.362 [DATMMP](INFO): Rx ping set to:1680294905.360756 2023-03-31T20:35:05.362Z,1680294905.362 [DATMMP](INFO): Received message type: timestamp 2023-03-31T20:35:05.362Z,1680294905.362 [DATMMP](INFO): Handled 2023-03-31T20:35:05.864Z,1680294905.864 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:35:05.864Z,1680294905.864 [DATMMP](INFO): nav_stat rx: x0 x1 x1 2023-03-31T20:35:05.865Z,1680294905.865 [DATMMP](INFO): Received message type: nav_stat 2023-03-31T20:35:05.865Z,1680294905.865 [DATMMP](INFO): Handled 2023-03-31T20:35:06.116Z,1680294906.116 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:35:06.117Z,1680294906.117 [DATMMP](INFO): directional_debug rx: x3B1 xFD48 x38 x1A x3CB0 x3921 x3D92 x3D33 2023-03-31T20:35:06.118Z,1680294906.118 [DATMMP](INFO): Received message type: directional_debug 2023-03-31T20:35:06.118Z,1680294906.118 [DATMMP](INFO): Handled 2023-03-31T20:35:06.368Z,1680294906.368 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:35:06.369Z,1680294906.369 [DATMMP](INFO): directional rx: x38A xFD3E x22B x2B8 xA43 xAA x0 xD51 x5 xFC7E x27B5966 x-43569E0 2023-03-31T20:35:06.371Z,1680294906.371 [DATMMP](INFO): Received message type: directional 2023-03-31T20:35:06.371Z,1680294906.371 [DATMMP](INFO): Handled 2023-03-31T20:35:06.620Z,1680294906.620 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:35:06.621Z,1680294906.621 [DATMMP](INFO): remote_header rx: xF x4 x5 xF x0 x0 x9 x0 2023-03-31T20:35:06.621Z,1680294906.621 [DATMMP](INFO): DATA Src=9, Dst=0 2023-03-31T20:35:06.621Z,1680294906.621 [DATMMP](INFO): Received message type: remote_header 2023-03-31T20:35:06.621Z,1680294906.621 [DATMMP](INFO): Handled 2023-03-31T20:35:06.872Z,1680294906.872 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:35:06.873Z,1680294906.873 [DATMMP](INFO): acstats rx: x9 x5 x0 x13F x3B x50 xA3 xAB xD xFFFF x0 x40 x0 x0 2023-03-31T20:35:06.874Z,1680294906.874 [DATMMP](INFO): Received message type: acstats 2023-03-31T20:35:06.874Z,1680294906.874 [DATMMP](INFO): Handled 2023-03-31T20:35:07.124Z,1680294907.124 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:35:07.125Z,1680294907.125 [DATMMP](ERROR): Failed to parse DAT message`:006E01040D00080001000000000000 2023-03-31T20:35:19.976Z,1680294919.976 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:35:19.977Z,1680294919.977 [DATMMP](ERROR): Failed to parse DAT message`:006E01040D0008000000030000000D 2023-03-31T20:35:20.228Z,1680294920.228 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:35:20.228Z,1680294920.228 [DATMMP](INFO): doppler rx: x0 2023-03-31T20:35:20.228Z,1680294920.228 [DATMMP](INFO): Received message type: doppler 2023-03-31T20:35:20.229Z,1680294920.229 [DATMMP](INFO): Handled 2023-03-31T20:35:20.480Z,1680294920.480 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:35:20.481Z,1680294920.481 [DATMMP](INFO): timestamp rx: x1 x14 x23 x17 x17A 2023-03-31T20:35:20.481Z,1680294920.481 [DATMMP](INFO): Rx dataTimestamp_ set to:1680294926.724992 2023-03-31T20:35:20.481Z,1680294920.481 [DATMMP](INFO): Rx ping set to:1680294920.480652 2023-03-31T20:35:20.482Z,1680294920.482 [DATMMP](INFO): Received message type: timestamp 2023-03-31T20:35:20.482Z,1680294920.482 [DATMMP](INFO): Handled 2023-03-31T20:35:20.984Z,1680294920.984 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:35:20.984Z,1680294920.984 [DATMMP](INFO): nav_stat rx: x0 x1 x1 2023-03-31T20:35:20.985Z,1680294920.985 [DATMMP](INFO): Received message type: nav_stat 2023-03-31T20:35:20.985Z,1680294920.985 [DATMMP](INFO): Handled 2023-03-31T20:35:21.236Z,1680294921.236 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:35:21.237Z,1680294921.237 [DATMMP](INFO): directional_debug rx: xC79 xFD03 x3B xF x1D50 x2381 x3152 x30C3 2023-03-31T20:35:21.238Z,1680294921.238 [DATMMP](INFO): Received message type: directional_debug 2023-03-31T20:35:21.238Z,1680294921.238 [DATMMP](INFO): Handled 2023-03-31T20:35:21.488Z,1680294921.488 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:35:21.489Z,1680294921.489 [DATMMP](INFO): directional rx: xC86 xFD0D x773 x2FD x949 xFFE8 x0 xD51 x5 xFC7E x27B5966 x-43569E0 2023-03-31T20:35:21.491Z,1680294921.491 [DATMMP](INFO): Received message type: directional 2023-03-31T20:35:21.491Z,1680294921.491 [DATMMP](INFO): Handled 2023-03-31T20:35:21.740Z,1680294921.740 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:35:21.741Z,1680294921.741 [DATMMP](INFO): remote_header rx: xF x4 x5 xF x0 x0 x9 x0 2023-03-31T20:35:21.741Z,1680294921.741 [DATMMP](INFO): DATA Src=9, Dst=0 2023-03-31T20:35:21.741Z,1680294921.741 [DATMMP](INFO): Received message type: remote_header 2023-03-31T20:35:21.741Z,1680294921.741 [DATMMP](INFO): Handled 2023-03-31T20:35:21.992Z,1680294921.992 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:35:21.993Z,1680294921.993 [DATMMP](INFO): acstats rx: x9 x5 x0 x11D x3B x57 x9B xAD xD xFFFF x0 x3E x0 x0 2023-03-31T20:35:21.993Z,1680294921.993 [DATMMP](INFO): Received message type: acstats 2023-03-31T20:35:21.994Z,1680294921.994 [DATMMP](INFO): Handled 2023-03-31T20:35:22.244Z,1680294922.244 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:35:22.245Z,1680294922.245 [DATMMP](ERROR): Failed to parse DAT message`:006E01040D00080001000000000000 2023-03-31T20:35:22.942Z,1680294922.942 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-03-31T20:30:22.7Z 2023-03-31T20:35:22.942Z,1680294922.942 [Default:CheckIn:Read_GPS] Stopped 2023-03-31T20:35:22.943Z,1680294922.943 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-03-31T20:35:23.351Z,1680294923.351 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications 2023-03-31T20:35:23.504Z,1680294923.504 [DATMMP](INFO): *** SENDING_FILL_BUFFER *** 2023-03-31T20:35:26.714Z,1680294926.714 [DATMMP](INFO): #Outgoing data=1 2023-03-31T20:35:26.724Z,1680294926.724 [DATMMP](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_NAV_DATA 2023-03-31T20:35:26.726Z,1680294926.726 [DATMMP](INFO): *** SENDING_NAV_DATA *** 2023-03-31T20:35:26.976Z,1680294926.976 [DATMMP](INFO): GSXN notify for xid: 15 2023-03-31T20:35:26.977Z,1680294926.977 [DATMMP](INFO): depth rx: x1 x1 x4 x0 2023-03-31T20:35:26.977Z,1680294926.977 [DATMMP](INFO): Received message type: depth 2023-03-31T20:35:26.977Z,1680294926.977 [DATMMP](INFO): Match for : depth 2023-03-31T20:35:26.977Z,1680294926.977 [DATMMP](INFO): ACK 2023-03-31T20:35:26.977Z,1680294926.977 [DATMMP](INFO): *** SENDING_NAV_DATA *** 2023-03-31T20:35:26.977Z,1680294926.977 [DATMMP](DEBUG): In sendingNavData, set commsState_ = SENDING_TRANSMIT 2023-03-31T20:35:27.228Z,1680294927.228 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:35:27.229Z,1680294927.229 [DATMMP](ERROR): Failed to parse DAT message`:006E01040D00080000000100000005 2023-03-31T20:35:27.229Z,1680294927.229 [DATMMP](INFO): *** SENDING_TRANSMIT *** 2023-03-31T20:35:27.230Z,1680294927.230 [DATMMP](INFO): Tx to 9 len 47 xid 16 2023-03-31T20:35:27.230Z,1680294927.230 [DATMMP](INFO): In sendingTransmit, set commsState_ = SENDING_TRANSMIT_VERIFY 2023-03-31T20:35:27.231Z,1680294927.231 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:35:27.480Z,1680294927.480 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:35:27.480Z,1680294927.480 [DATMMP](INFO): iface_err rx: x0 x0 x5 2023-03-31T20:35:27.481Z,1680294927.481 [DATMMP](ERROR): 5:Error talking to DAT parse 2023-03-31T20:35:27.481Z,1680294927.481 [DATMMP](INFO): Received message type: iface_err 2023-03-31T20:35:27.481Z,1680294927.481 [DATMMP](INFO): Handled 2023-03-31T20:35:27.481Z,1680294927.481 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:35:27.732Z,1680294927.732 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:35:27.732Z,1680294927.732 [DATMMP](INFO): status rx: x0 2023-03-31T20:35:27.733Z,1680294927.733 [DATMMP](INFO): MMP status: 0: exited 2023-03-31T20:35:27.733Z,1680294927.733 [DATMMP](INFO): Received message type: status 2023-03-31T20:35:27.733Z,1680294927.733 [DATMMP](INFO): Handled 2023-03-31T20:35:27.733Z,1680294927.733 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:35:28.235Z,1680294928.235 [DATMMP](INFO): Stop 2023-03-31T20:35:28.235Z,1680294928.235 [DATMMP](INFO): uninitialize 2023-03-31T20:35:28.235Z,1680294928.235 [DATMMP](INFO): Powering down 2023-03-31T20:35:28.487Z,1680294928.487 [DATMMP](INFO): Stopping 2023-03-31T20:35:28.739Z,1680294928.739 [DATMMP](INFO): Stopped 2023-03-31T20:35:28.991Z,1680294928.991 [DATMMP](INFO): Start 2023-03-31T20:35:29.243Z,1680294929.243 [DATMMP](INFO): Start 2023-03-31T20:35:29.497Z,1680294929.497 [DATMMP](INFO): Start 2023-03-31T20:35:29.747Z,1680294929.747 [DATMMP](INFO): Start 2023-03-31T20:35:29.999Z,1680294929.999 [DATMMP](INFO): Start 2023-03-31T20:35:30.251Z,1680294930.251 [DATMMP](INFO): Start 2023-03-31T20:35:30.503Z,1680294930.503 [DATMMP](INFO): Start 2023-03-31T20:35:30.755Z,1680294930.755 [DATMMP](INFO): Start 2023-03-31T20:35:31.007Z,1680294931.007 [DATMMP](INFO): Start 2023-03-31T20:35:31.259Z,1680294931.259 [DATMMP](INFO): Start 2023-03-31T20:35:31.259Z,1680294931.259 [DATMMP](INFO): Powering up 2023-03-31T20:35:31.260Z,1680294931.260 [DATMMP](DEBUG): Initializing DATMMP. 2023-03-31T20:35:33.480Z,1680294933.480 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230331T202450/Courier0004.lzma 2023-03-31T20:35:34.481Z,1680294934.481 [DataOverHttps](INFO): Moved sent file to Logs/20230331T202450/Courier0004.lzma.bak 2023-03-31T20:35:34.481Z,1680294934.481 [DataOverHttps](INFO): SBD MOMSN=17883305 2023-03-31T20:35:42.721Z,1680294942.721 [NAL9602](FAULT): GPS failed to acquire within timeout. 2023-03-31T20:35:42.721Z,1680294942.721 [NAL9602] Data Fault, FailCount= 1 2023-03-31T20:35:42.721Z,1680294942.721 [NAL9602](ERROR): Data Fault 2023-03-31T20:35:42.799Z,1680294942.799 [CBIT](ERROR): Data Fault in component: NAL9602 2023-03-31T20:35:43.119Z,1680294943.119 [DATMMP](INFO): DAT read: 2023-03-31T20:35:43.120Z,1680294943.120 [DATMMP](INFO): DAT read: Teledyne Benthos DAT-900 Series 2023-03-31T20:35:43.122Z,1680294943.122 [NAL9602](INFO): Powering down 2023-03-31T20:35:43.983Z,1680294943.983 [CBIT](INFO): Clearing failed state for component NAL9602 2023-03-31T20:35:43.983Z,1680294943.983 [NAL9602] No Fault, FailCount= 1 2023-03-31T20:35:44.628Z,1680294944.628 [DATMMP](INFO): DAT read: MF Frequency Band 2023-03-31T20:35:44.629Z,1680294944.629 [DATMMP](INFO): DAT read: Directional Acoustic Transponder version 8.15.0 2023-03-31T20:35:44.630Z,1680294944.630 [DATMMP](INFO): DAT read: Mar 1 2000 20:35:43 2023-03-31T20:35:45.636Z,1680294945.636 [DATMMP](INFO): DAT read: Features enabled [Bearing] 2023-03-31T20:35:45.637Z,1680294945.637 [DATMMP](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP 2023-03-31T20:35:45.637Z,1680294945.637 [DATMMP](INFO): commRate: 800 2023-03-31T20:35:47.703Z,1680294947.703 [DATMMP](INFO): entering command mode 2023-03-31T20:35:47.903Z,1680294947.903 [DATMMP](INFO): DAT read: 2023-03-31T20:35:47.904Z,1680294947.904 [DATMMP](INFO): DAT read: user:1> 2023-03-31T20:35:47.904Z,1680294947.904 [DATMMP](DEBUG): read user prompt 1: user:1> 2023-03-31T20:35:47.904Z,1680294947.904 [DATMMP](INFO): entering MMP mode 2023-03-31T20:35:48.155Z,1680294948.155 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:35:48.156Z,1680294948.156 [DATMMP](INFO): status rx: x1 2023-03-31T20:35:48.157Z,1680294948.157 [DATMMP](INFO): MMP status: 1: started 2023-03-31T20:35:48.157Z,1680294948.157 [DATMMP](INFO): Received message type: status 2023-03-31T20:35:48.157Z,1680294948.157 [DATMMP](INFO): Handled 2023-03-31T20:35:48.407Z,1680294948.407 [DATMMP](INFO): in MMP mode: config complete going to runnable 2023-03-31T20:35:48.408Z,1680294948.408 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:35:48.408Z,1680294948.408 [DATMMP](FAULT): Buffer send receipt timeout failure. 2023-03-31T20:35:48.408Z,1680294948.408 [DATMMP](DEBUG): In sendingTransmitVerify, timeout set commsState_ = SENDING_FILL_BUFFER 2023-03-31T20:35:48.659Z,1680294948.659 [DATMMP](INFO): *** SENDING_FILL_BUFFER *** 2023-03-31T20:35:54.582Z,1680294954.582 [DATMMP](INFO): #Outgoing data=1 2023-03-31T20:35:54.582Z,1680294954.582 [DATMMP](ERROR): Waiting for previous to be ack'd 2023-03-31T20:35:54.582Z,1680294954.582 [DATMMP](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_NAV_DATA 2023-03-31T20:35:54.584Z,1680294954.584 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:35:54.585Z,1680294954.585 [DATMMP](INFO): doppler rx: x0 2023-03-31T20:35:54.586Z,1680294954.586 [DATMMP](INFO): Received message type: doppler 2023-03-31T20:35:54.586Z,1680294954.586 [DATMMP](INFO): Handled 2023-03-31T20:35:54.586Z,1680294954.586 [DATMMP](INFO): *** SENDING_NAV_DATA *** 2023-03-31T20:35:54.586Z,1680294954.586 [DATMMP](DEBUG): In sendingNavData, set commsState_ = SENDING_TRANSMIT 2023-03-31T20:35:54.836Z,1680294954.836 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:35:54.836Z,1680294954.836 [DATMMP](INFO): timestamp rx: x1 x14 x23 x32 x2192 2023-03-31T20:35:54.837Z,1680294954.837 [DATMMP](INFO): Rx dataTimestamp_ set to:1680294969.970752 2023-03-31T20:35:54.837Z,1680294954.837 [DATMMP](INFO): Rx ping set to:1680294954.836567 2023-03-31T20:35:54.837Z,1680294954.837 [DATMMP](INFO): Received message type: timestamp 2023-03-31T20:35:54.838Z,1680294954.838 [DATMMP](INFO): Handled 2023-03-31T20:35:54.838Z,1680294954.838 [DATMMP](INFO): *** SENDING_TRANSMIT *** 2023-03-31T20:35:54.838Z,1680294954.838 [DATMMP](INFO): Tx to 9 len 47 xid 17 2023-03-31T20:35:54.839Z,1680294954.839 [DATMMP](INFO): In sendingTransmit, set commsState_ = SENDING_TRANSMIT_VERIFY 2023-03-31T20:35:54.840Z,1680294954.840 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:35:55.088Z,1680294955.088 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:35:55.089Z,1680294955.089 [DATMMP](INFO): nav_stat rx: x0 x1 x1 2023-03-31T20:35:55.089Z,1680294955.089 [DATMMP](INFO): Received message type: nav_stat 2023-03-31T20:35:55.089Z,1680294955.089 [DATMMP](INFO): Handled 2023-03-31T20:35:55.089Z,1680294955.089 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:35:55.340Z,1680294955.340 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:35:55.341Z,1680294955.341 [DATMMP](INFO): directional_debug rx: xF9 xFE73 x39 x24 x3C70 x4791 x3D72 x4753 2023-03-31T20:35:55.342Z,1680294955.342 [DATMMP](INFO): Received message type: directional_debug 2023-03-31T20:35:55.342Z,1680294955.342 [DATMMP](INFO): Handled 2023-03-31T20:35:55.342Z,1680294955.342 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:35:55.592Z,1680294955.592 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:35:55.593Z,1680294955.593 [DATMMP](INFO): directional rx: xEB xFE71 x4E3 x18D x879 x184 x0 xD53 xFFFC xFC76 x27B5966 x-43569E0 2023-03-31T20:35:55.595Z,1680294955.595 [DATMMP](INFO): Received message type: directional 2023-03-31T20:35:55.595Z,1680294955.595 [DATMMP](INFO): Handled 2023-03-31T20:35:55.595Z,1680294955.595 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:35:55.844Z,1680294955.844 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:35:55.845Z,1680294955.845 [DATMMP](INFO): remote_header rx: xF x4 x5 xF x0 x0 x9 x0 2023-03-31T20:35:55.845Z,1680294955.845 [DATMMP](INFO): DATA Src=9, Dst=0 2023-03-31T20:35:55.845Z,1680294955.845 [DATMMP](INFO): Received message type: remote_header 2023-03-31T20:35:55.845Z,1680294955.845 [DATMMP](INFO): Handled 2023-03-31T20:35:55.845Z,1680294955.845 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:35:56.096Z,1680294956.096 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:35:56.097Z,1680294956.097 [DATMMP](INFO): acstats rx: x9 x5 x0 x18B x3B x4F x90 xA6 xD xFFFF x0 x3E x0 x0 2023-03-31T20:35:56.098Z,1680294956.098 [DATMMP](INFO): Received message type: acstats 2023-03-31T20:35:56.098Z,1680294956.098 [DATMMP](INFO): Handled 2023-03-31T20:35:56.098Z,1680294956.098 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:35:56.348Z,1680294956.348 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:35:56.348Z,1680294956.348 [DATMMP](INFO): timesync rx: x0 x1 x1 x0 2023-03-31T20:35:56.349Z,1680294956.349 [DATMMP](INFO): Received message type: timesync 2023-03-31T20:35:56.349Z,1680294956.349 [DATMMP](INFO): Handled 2023-03-31T20:35:56.349Z,1680294956.349 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:35:56.600Z,1680294956.600 [DATMMP](INFO): GSXN notify for xid: 17 2023-03-31T20:35:56.601Z,1680294956.601 [DATMMP](INFO): cmd_result rx: x1 x7 x0 x1 2023-03-31T20:35:56.601Z,1680294956.601 [DATMMP](DEBUG): Command complete send 2023-03-31T20:35:56.601Z,1680294956.601 [DATMMP](ERROR): 1:COMPLETE 2023-03-31T20:35:56.601Z,1680294956.601 [DATMMP](INFO): Received message type: cmd_result 2023-03-31T20:35:56.601Z,1680294956.601 [DATMMP](INFO): Handled 2023-03-31T20:35:56.602Z,1680294956.602 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:35:56.852Z,1680294956.852 [DATMMP](INFO): GSXN notify for xid: 0 2023-03-31T20:35:56.853Z,1680294956.853 [DATMMP](INFO): timestamp rx: x0 x14 x23 x37 x1D8E 2023-03-31T20:35:56.853Z,1680294956.853 [DATMMP](INFO): Received message type: timestamp 2023-03-31T20:35:56.853Z,1680294956.853 [DATMMP](INFO): Handled 2023-03-31T20:35:56.853Z,1680294956.853 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:35:56.938Z,1680294956.938 [DataOverHttps](INFO): Sending 1301 bytes from file Logs/20230331T202450/Express0001.lzma 2023-03-31T20:35:57.106Z,1680294957.106 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:35:57.355Z,1680294957.355 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:35:57.608Z,1680294957.608 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:35:57.860Z,1680294957.860 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:35:57.937Z,1680294957.937 [DataOverHttps](INFO): Moved sent file to Logs/20230331T202450/Express0001.lzma.bak 2023-03-31T20:35:57.937Z,1680294957.937 [DataOverHttps](INFO): SBD MOMSN=17883307 2023-03-31T20:35:58.111Z,1680294958.111 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:35:58.364Z,1680294958.364 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:35:58.616Z,1680294958.616 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:35:58.868Z,1680294958.868 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:35:59.120Z,1680294959.120 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:35:59.372Z,1680294959.372 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:35:59.624Z,1680294959.624 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:35:59.876Z,1680294959.876 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:00.128Z,1680294960.128 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:00.380Z,1680294960.380 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:00.632Z,1680294960.632 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:00.884Z,1680294960.884 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:01.136Z,1680294961.136 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:01.388Z,1680294961.388 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:01.640Z,1680294961.640 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:01.891Z,1680294961.891 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:02.143Z,1680294962.143 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:02.396Z,1680294962.396 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:02.648Z,1680294962.648 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:02.899Z,1680294962.899 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:03.151Z,1680294963.151 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:03.404Z,1680294963.404 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:03.655Z,1680294963.655 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:03.908Z,1680294963.908 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:04.159Z,1680294964.159 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:04.411Z,1680294964.411 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:04.664Z,1680294964.664 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:04.916Z,1680294964.916 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:05.168Z,1680294965.168 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:05.419Z,1680294965.420 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:05.671Z,1680294965.671 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:05.924Z,1680294965.924 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:06.176Z,1680294966.176 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:06.428Z,1680294966.428 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:06.679Z,1680294966.679 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:06.931Z,1680294966.931 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:07.184Z,1680294967.184 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:07.436Z,1680294967.436 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:07.688Z,1680294967.688 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:07.939Z,1680294967.939 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:08.192Z,1680294968.192 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:08.444Z,1680294968.444 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:08.696Z,1680294968.696 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:08.948Z,1680294968.948 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:09.199Z,1680294969.199 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:09.451Z,1680294969.451 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:09.704Z,1680294969.704 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:09.956Z,1680294969.956 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:10.207Z,1680294970.207 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:10.459Z,1680294970.459 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:10.712Z,1680294970.712 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:10.964Z,1680294970.964 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:11.216Z,1680294971.216 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:11.467Z,1680294971.467 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:11.720Z,1680294971.720 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:11.972Z,1680294971.972 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:12.224Z,1680294972.224 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:12.476Z,1680294972.476 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:12.728Z,1680294972.728 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:12.979Z,1680294972.979 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:13.232Z,1680294973.232 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:13.421Z,1680294973.421 [NAL9602](INFO): Powering up NAL9602 2023-03-31T20:36:13.484Z,1680294973.484 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:13.736Z,1680294973.736 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:13.988Z,1680294973.988 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:14.239Z,1680294974.239 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:14.492Z,1680294974.492 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:14.744Z,1680294974.744 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:14.996Z,1680294974.996 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:15.247Z,1680294975.247 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:15.752Z,1680294975.752 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:16.004Z,1680294976.004 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:16.255Z,1680294976.255 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:16.507Z,1680294976.507 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:17.012Z,1680294977.012 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:17.263Z,1680294977.263 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:17.515Z,1680294977.515 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:17.767Z,1680294977.767 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:18.019Z,1680294978.019 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:18.271Z,1680294978.271 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:18.524Z,1680294978.524 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:18.775Z,1680294978.775 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:19.027Z,1680294979.027 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:19.280Z,1680294979.280 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:19.533Z,1680294979.533 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:19.787Z,1680294979.787 [DataOverHttps](INFO): Sending 436 bytes from file Logs/20230331T202450/Express0005.lzma 2023-03-31T20:36:19.790Z,1680294979.790 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:20.043Z,1680294980.043 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:20.296Z,1680294980.296 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:20.548Z,1680294980.548 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:20.789Z,1680294980.789 [DataOverHttps](INFO): Moved sent file to Logs/20230331T202450/Express0005.lzma.bak 2023-03-31T20:36:20.789Z,1680294980.789 [DataOverHttps](INFO): SBD MOMSN=17883345 2023-03-31T20:36:20.800Z,1680294980.800 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:21.052Z,1680294981.052 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:21.303Z,1680294981.303 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:21.556Z,1680294981.556 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:21.808Z,1680294981.808 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:22.060Z,1680294982.060 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:22.316Z,1680294982.316 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:22.567Z,1680294982.567 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:22.820Z,1680294982.820 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:23.073Z,1680294983.073 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:23.324Z,1680294983.324 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:23.576Z,1680294983.576 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:23.828Z,1680294983.828 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:24.080Z,1680294984.080 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:24.332Z,1680294984.332 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:24.345Z,1680294984.345 [NAL9602](INFO): NAL9602 initialized 2023-03-31T20:36:24.584Z,1680294984.584 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:24.836Z,1680294984.836 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:25.088Z,1680294985.088 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:25.340Z,1680294985.340 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:25.589Z,1680294985.589 [Default:CheckIn:Read_Iridium] Stopped 2023-03-31T20:36:25.589Z,1680294985.589 [Default:CheckIn:C.Wait] Running Loop=1 2023-03-31T20:36:25.590Z,1680294985.590 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-03-31T20:36:25.592Z,1680294985.592 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:25.844Z,1680294985.844 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:26.096Z,1680294986.096 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:26.348Z,1680294986.348 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:26.600Z,1680294986.600 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:27.104Z,1680294987.104 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:27.356Z,1680294987.356 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:27.608Z,1680294987.608 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:27.860Z,1680294987.860 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:28.112Z,1680294988.112 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:28.364Z,1680294988.364 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:28.616Z,1680294988.616 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:28.868Z,1680294988.868 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:29.120Z,1680294989.120 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:29.372Z,1680294989.372 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:29.623Z,1680294989.623 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:29.876Z,1680294989.876 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:30.128Z,1680294990.128 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:30.380Z,1680294990.380 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:30.632Z,1680294990.632 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:30.884Z,1680294990.884 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:31.135Z,1680294991.135 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:31.388Z,1680294991.388 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:31.640Z,1680294991.640 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:31.892Z,1680294991.892 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:32.144Z,1680294992.144 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:32.395Z,1680294992.395 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:32.648Z,1680294992.648 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:32.899Z,1680294992.899 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:33.152Z,1680294993.152 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:33.404Z,1680294993.404 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:33.907Z,1680294993.907 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:34.160Z,1680294994.160 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:34.412Z,1680294994.412 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:34.663Z,1680294994.663 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:34.916Z,1680294994.916 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:35.168Z,1680294995.168 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:35.419Z,1680294995.419 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:35.672Z,1680294995.672 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:35.923Z,1680294995.923 [DATMMP](INFO): *** SENDING_ACK_WAITING *** 2023-03-31T20:36:35.924Z,1680294995.924 [DATMMP](DEBUG): In sendingAckWaiting, timeout so set commsState_ = SENDING_FILL_BUFFER 2023-03-31T20:36:36.177Z,1680294996.177 [DATMMP](INFO): *** SENDING_FILL_BUFFER *** 2023-03-31T20:36:36.177Z,1680294996.177 [DATMMP](ERROR): Waiting for previous to be ack'd 2023-03-31T20:36:36.177Z,1680294996.177 [DATMMP](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_NAV_DATA 2023-03-31T20:36:36.428Z,1680294996.428 [DATMMP](INFO): *** SENDING_NAV_DATA *** 2023-03-31T20:36:36.428Z,1680294996.428 [DATMMP](DEBUG): In sendingNavData, set commsState_ = SENDING_TRANSMIT 2023-03-31T20:36:36.680Z,1680294996.680 [DATMMP](INFO): *** SENDING_TRANSMIT *** 2023-03-31T20:36:36.680Z,1680294996.680 [DATMMP](INFO): Tx to 9 len 47 xid 18 2023-03-31T20:36:36.681Z,1680294996.681 [DATMMP](INFO): In sendingTransmit, set commsState_ = SENDING_TRANSMIT_VERIFY 2023-03-31T20:36:36.681Z,1680294996.681 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:36:36.932Z,1680294996.932 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:36:37.183Z,1680294997.183 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:36:37.436Z,1680294997.436 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:36:37.940Z,1680294997.940 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:36:38.191Z,1680294998.191 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:36:38.444Z,1680294998.444 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:36:38.696Z,1680294998.696 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:36:38.948Z,1680294998.948 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:36:39.200Z,1680294999.200 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:36:39.452Z,1680294999.452 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:36:39.704Z,1680294999.704 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:36:39.958Z,1680294999.958 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:36:40.208Z,1680295000.208 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:36:40.460Z,1680295000.460 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:36:40.712Z,1680295000.712 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:36:40.964Z,1680295000.964 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:36:41.216Z,1680295001.216 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:36:41.468Z,1680295001.468 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:36:41.719Z,1680295001.719 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:36:41.971Z,1680295001.971 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:36:42.224Z,1680295002.224 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:36:42.476Z,1680295002.476 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:36:42.728Z,1680295002.728 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:36:42.980Z,1680295002.980 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:36:43.231Z,1680295003.231 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:36:43.484Z,1680295003.484 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:36:43.736Z,1680295003.736 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:36:43.988Z,1680295003.988 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:36:44.240Z,1680295004.240 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:36:44.491Z,1680295004.491 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:36:44.744Z,1680295004.744 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:36:44.996Z,1680295004.996 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:36:45.248Z,1680295005.248 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:36:45.499Z,1680295005.499 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:36:45.752Z,1680295005.752 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:36:46.003Z,1680295006.003 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:36:46.256Z,1680295006.256 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:36:46.508Z,1680295006.508 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:36:46.759Z,1680295006.759 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:36:46.760Z,1680295006.760 [DATMMP](FAULT): Buffer send receipt timeout failure. 2023-03-31T20:36:46.760Z,1680295006.760 [DATMMP](DEBUG): In sendingTransmitVerify, timeout set commsState_ = SENDING_FILL_BUFFER 2023-03-31T20:36:47.012Z,1680295007.012 [DATMMP](INFO): *** SENDING_FILL_BUFFER *** 2023-03-31T20:36:47.012Z,1680295007.012 [DATMMP](ERROR): Waiting for previous to be ack'd 2023-03-31T20:36:47.012Z,1680295007.012 [DATMMP](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_NAV_DATA 2023-03-31T20:36:47.263Z,1680295007.263 [DATMMP](INFO): *** SENDING_NAV_DATA *** 2023-03-31T20:36:47.264Z,1680295007.264 [DATMMP](DEBUG): In sendingNavData, set commsState_ = SENDING_TRANSMIT 2023-03-31T20:36:47.515Z,1680295007.515 [DATMMP](INFO): *** SENDING_TRANSMIT *** 2023-03-31T20:36:47.516Z,1680295007.516 [DATMMP](INFO): In sendingTransmit, dataTxMessage not ack'd 2023-03-31T20:36:47.516Z,1680295007.516 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:36:47.516Z,1680295007.516 [DATMMP](FAULT): Buffer send receipt timeout failure. 2023-03-31T20:36:47.516Z,1680295007.516 [DATMMP](DEBUG): In sendingTransmitVerify, timeout set commsState_ = SENDING_FILL_BUFFER 2023-03-31T20:36:47.767Z,1680295007.767 [DATMMP](INFO): *** SENDING_FILL_BUFFER *** 2023-03-31T20:36:47.768Z,1680295007.768 [DATMMP](ERROR): Waiting for previous to be ack'd 2023-03-31T20:36:47.768Z,1680295007.768 [DATMMP](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_NAV_DATA 2023-03-31T20:36:48.019Z,1680295008.019 [DATMMP](INFO): *** SENDING_NAV_DATA *** 2023-03-31T20:36:48.020Z,1680295008.020 [DATMMP](DEBUG): In sendingNavData, set commsState_ = SENDING_TRANSMIT 2023-03-31T20:36:48.272Z,1680295008.272 [DATMMP](INFO): *** SENDING_TRANSMIT *** 2023-03-31T20:36:48.272Z,1680295008.272 [DATMMP](INFO): In sendingTransmit, dataTxMessage not ack'd 2023-03-31T20:36:48.272Z,1680295008.272 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:36:48.272Z,1680295008.272 [DATMMP](FAULT): Buffer send receipt timeout failure. 2023-03-31T20:36:48.272Z,1680295008.272 [DATMMP](DEBUG): In sendingTransmitVerify, timeout set commsState_ = SENDING_FILL_BUFFER 2023-03-31T20:36:48.525Z,1680295008.525 [DATMMP](INFO): *** SENDING_FILL_BUFFER *** 2023-03-31T20:36:48.527Z,1680295008.527 [DATMMP](ERROR): Waiting for previous to be ack'd 2023-03-31T20:36:48.527Z,1680295008.527 [DATMMP](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_NAV_DATA 2023-03-31T20:36:48.776Z,1680295008.776 [DATMMP](INFO): *** SENDING_NAV_DATA *** 2023-03-31T20:36:48.776Z,1680295008.776 [DATMMP](DEBUG): In sendingNavData, set commsState_ = SENDING_TRANSMIT 2023-03-31T20:36:49.036Z,1680295009.036 [DATMMP](INFO): *** SENDING_TRANSMIT *** 2023-03-31T20:36:49.036Z,1680295009.036 [DATMMP](INFO): In sendingTransmit, dataTxMessage not ack'd 2023-03-31T20:36:49.036Z,1680295009.036 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:36:49.036Z,1680295009.036 [DATMMP](FAULT): Buffer send receipt timeout failure. 2023-03-31T20:36:49.036Z,1680295009.036 [DATMMP](DEBUG): In sendingTransmitVerify, timeout set commsState_ = SENDING_FILL_BUFFER 2023-03-31T20:36:49.287Z,1680295009.287 [DATMMP](INFO): *** SENDING_FILL_BUFFER *** 2023-03-31T20:36:49.288Z,1680295009.288 [DATMMP](ERROR): Waiting for previous to be ack'd 2023-03-31T20:36:49.288Z,1680295009.288 [DATMMP](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_NAV_DATA 2023-03-31T20:36:49.540Z,1680295009.540 [DATMMP](INFO): *** SENDING_NAV_DATA *** 2023-03-31T20:36:49.540Z,1680295009.540 [DATMMP](DEBUG): In sendingNavData, set commsState_ = SENDING_TRANSMIT 2023-03-31T20:36:49.791Z,1680295009.791 [DATMMP](INFO): *** SENDING_TRANSMIT *** 2023-03-31T20:36:49.792Z,1680295009.792 [DATMMP](INFO): In sendingTransmit, dataTxMessage not ack'd 2023-03-31T20:36:49.792Z,1680295009.792 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:36:49.792Z,1680295009.792 [DATMMP](FAULT): Buffer send receipt timeout failure. 2023-03-31T20:36:49.792Z,1680295009.792 [DATMMP](DEBUG): In sendingTransmitVerify, timeout set commsState_ = SENDING_FILL_BUFFER 2023-03-31T20:36:50.043Z,1680295010.043 [DATMMP](INFO): *** SENDING_FILL_BUFFER *** 2023-03-31T20:36:50.044Z,1680295010.044 [DATMMP](ERROR): Waiting for previous to be ack'd 2023-03-31T20:36:50.044Z,1680295010.044 [DATMMP](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_NAV_DATA 2023-03-31T20:36:50.295Z,1680295010.295 [DATMMP](INFO): *** SENDING_NAV_DATA *** 2023-03-31T20:36:50.296Z,1680295010.296 [DATMMP](DEBUG): In sendingNavData, set commsState_ = SENDING_TRANSMIT 2023-03-31T20:36:50.547Z,1680295010.547 [DATMMP](INFO): *** SENDING_TRANSMIT *** 2023-03-31T20:36:50.547Z,1680295010.547 [DATMMP](INFO): In sendingTransmit, dataTxMessage not ack'd 2023-03-31T20:36:50.548Z,1680295010.548 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:36:50.548Z,1680295010.548 [DATMMP](FAULT): Buffer send receipt timeout failure. 2023-03-31T20:36:50.548Z,1680295010.548 [DATMMP](DEBUG): In sendingTransmitVerify, timeout set commsState_ = SENDING_FILL_BUFFER 2023-03-31T20:36:50.800Z,1680295010.800 [DATMMP](INFO): *** SENDING_FILL_BUFFER *** 2023-03-31T20:36:50.800Z,1680295010.800 [DATMMP](ERROR): Waiting for previous to be ack'd 2023-03-31T20:36:50.800Z,1680295010.800 [DATMMP](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_NAV_DATA 2023-03-31T20:36:51.051Z,1680295011.051 [DATMMP](INFO): *** SENDING_NAV_DATA *** 2023-03-31T20:36:51.052Z,1680295011.052 [DATMMP](DEBUG): In sendingNavData, set commsState_ = SENDING_TRANSMIT 2023-03-31T20:36:51.303Z,1680295011.303 [DATMMP](INFO): *** SENDING_TRANSMIT *** 2023-03-31T20:36:51.304Z,1680295011.304 [DATMMP](INFO): In sendingTransmit, dataTxMessage not ack'd 2023-03-31T20:36:51.304Z,1680295011.304 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:36:51.304Z,1680295011.304 [DATMMP](FAULT): Buffer send receipt timeout failure. 2023-03-31T20:36:51.304Z,1680295011.304 [DATMMP](DEBUG): In sendingTransmitVerify, timeout set commsState_ = SENDING_FILL_BUFFER 2023-03-31T20:36:51.556Z,1680295011.556 [DATMMP](INFO): *** SENDING_FILL_BUFFER *** 2023-03-31T20:36:51.556Z,1680295011.556 [DATMMP](ERROR): Waiting for previous to be ack'd 2023-03-31T20:36:51.556Z,1680295011.556 [DATMMP](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_NAV_DATA 2023-03-31T20:36:51.807Z,1680295011.807 [DATMMP](INFO): *** SENDING_NAV_DATA *** 2023-03-31T20:36:51.808Z,1680295011.808 [DATMMP](DEBUG): In sendingNavData, set commsState_ = SENDING_TRANSMIT 2023-03-31T20:36:52.059Z,1680295012.059 [DATMMP](INFO): *** SENDING_TRANSMIT *** 2023-03-31T20:36:52.060Z,1680295012.060 [DATMMP](INFO): In sendingTransmit, dataTxMessage not ack'd 2023-03-31T20:36:52.060Z,1680295012.060 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:36:52.060Z,1680295012.060 [DATMMP](FAULT): Buffer send receipt timeout failure. 2023-03-31T20:36:52.060Z,1680295012.060 [DATMMP](DEBUG): In sendingTransmitVerify, timeout set commsState_ = SENDING_FILL_BUFFER 2023-03-31T20:36:52.312Z,1680295012.312 [DATMMP](INFO): *** SENDING_FILL_BUFFER *** 2023-03-31T20:36:52.312Z,1680295012.312 [DATMMP](ERROR): Waiting for previous to be ack'd 2023-03-31T20:36:52.312Z,1680295012.312 [DATMMP](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_NAV_DATA 2023-03-31T20:36:52.563Z,1680295012.563 [DATMMP](INFO): *** SENDING_NAV_DATA *** 2023-03-31T20:36:52.564Z,1680295012.564 [DATMMP](DEBUG): In sendingNavData, set commsState_ = SENDING_TRANSMIT 2023-03-31T20:36:52.815Z,1680295012.815 [DATMMP](INFO): *** SENDING_TRANSMIT *** 2023-03-31T20:36:52.816Z,1680295012.816 [DATMMP](INFO): In sendingTransmit, dataTxMessage not ack'd 2023-03-31T20:36:52.816Z,1680295012.816 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:36:52.816Z,1680295012.816 [DATMMP](FAULT): Buffer send receipt timeout failure. 2023-03-31T20:36:52.816Z,1680295012.816 [DATMMP](DEBUG): In sendingTransmitVerify, timeout set commsState_ = SENDING_FILL_BUFFER 2023-03-31T20:36:53.067Z,1680295013.067 [DATMMP](INFO): *** SENDING_FILL_BUFFER *** 2023-03-31T20:36:53.083Z,1680295013.083 [DATMMP](ERROR): Waiting for previous to be ack'd 2023-03-31T20:36:53.083Z,1680295013.083 [DATMMP](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_NAV_DATA 2023-03-31T20:36:53.320Z,1680295013.320 [DATMMP](INFO): *** SENDING_NAV_DATA *** 2023-03-31T20:36:53.320Z,1680295013.320 [DATMMP](DEBUG): In sendingNavData, set commsState_ = SENDING_TRANSMIT 2023-03-31T20:36:53.573Z,1680295013.573 [DATMMP](INFO): *** SENDING_TRANSMIT *** 2023-03-31T20:36:53.573Z,1680295013.573 [DATMMP](INFO): In sendingTransmit, dataTxMessage not ack'd 2023-03-31T20:36:53.574Z,1680295013.574 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:36:53.574Z,1680295013.574 [DATMMP](FAULT): Buffer send receipt timeout failure. 2023-03-31T20:36:53.575Z,1680295013.575 [DATMMP](DEBUG): In sendingTransmitVerify, timeout set commsState_ = SENDING_FILL_BUFFER 2023-03-31T20:36:53.824Z,1680295013.824 [DATMMP](INFO): *** SENDING_FILL_BUFFER *** 2023-03-31T20:36:53.824Z,1680295013.824 [DATMMP](ERROR): Waiting for previous to be ack'd 2023-03-31T20:36:53.824Z,1680295013.824 [DATMMP](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_NAV_DATA 2023-03-31T20:36:54.075Z,1680295014.075 [DATMMP](INFO): *** SENDING_NAV_DATA *** 2023-03-31T20:36:54.076Z,1680295014.076 [DATMMP](DEBUG): In sendingNavData, set commsState_ = SENDING_TRANSMIT 2023-03-31T20:36:54.328Z,1680295014.328 [DATMMP](INFO): *** SENDING_TRANSMIT *** 2023-03-31T20:36:54.328Z,1680295014.328 [DATMMP](INFO): In sendingTransmit, dataTxMessage not ack'd 2023-03-31T20:36:54.328Z,1680295014.328 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:36:54.328Z,1680295014.328 [DATMMP](FAULT): Buffer send receipt timeout failure. 2023-03-31T20:36:54.328Z,1680295014.328 [DATMMP](DEBUG): In sendingTransmitVerify, timeout set commsState_ = SENDING_FILL_BUFFER 2023-03-31T20:36:54.580Z,1680295014.580 [DATMMP](INFO): *** SENDING_FILL_BUFFER *** 2023-03-31T20:36:54.580Z,1680295014.580 [DATMMP](ERROR): Waiting for previous to be ack'd 2023-03-31T20:36:54.580Z,1680295014.580 [DATMMP](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_NAV_DATA 2023-03-31T20:36:54.831Z,1680295014.831 [DATMMP](INFO): *** SENDING_NAV_DATA *** 2023-03-31T20:36:54.832Z,1680295014.832 [DATMMP](DEBUG): In sendingNavData, set commsState_ = SENDING_TRANSMIT 2023-03-31T20:36:55.084Z,1680295015.084 [DATMMP](INFO): *** SENDING_TRANSMIT *** 2023-03-31T20:36:55.084Z,1680295015.084 [DATMMP](INFO): In sendingTransmit, dataTxMessage not ack'd 2023-03-31T20:36:55.084Z,1680295015.084 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:36:55.084Z,1680295015.084 [DATMMP](FAULT): Buffer send receipt timeout failure. 2023-03-31T20:36:55.084Z,1680295015.084 [DATMMP](DEBUG): In sendingTransmitVerify, timeout set commsState_ = SENDING_FILL_BUFFER 2023-03-31T20:36:55.336Z,1680295015.336 [DATMMP](INFO): *** SENDING_FILL_BUFFER *** 2023-03-31T20:36:55.336Z,1680295015.336 [DATMMP](ERROR): Waiting for previous to be ack'd 2023-03-31T20:36:55.336Z,1680295015.336 [DATMMP](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_NAV_DATA 2023-03-31T20:36:55.588Z,1680295015.588 [DATMMP](INFO): *** SENDING_NAV_DATA *** 2023-03-31T20:36:55.588Z,1680295015.588 [DATMMP](DEBUG): In sendingNavData, set commsState_ = SENDING_TRANSMIT 2023-03-31T20:36:55.840Z,1680295015.840 [DATMMP](INFO): *** SENDING_TRANSMIT *** 2023-03-31T20:36:55.840Z,1680295015.840 [DATMMP](INFO): In sendingTransmit, dataTxMessage not ack'd 2023-03-31T20:36:55.840Z,1680295015.840 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:36:55.840Z,1680295015.840 [DATMMP](FAULT): Buffer send receipt timeout failure. 2023-03-31T20:36:55.840Z,1680295015.840 [DATMMP](DEBUG): In sendingTransmitVerify, timeout set commsState_ = SENDING_FILL_BUFFER 2023-03-31T20:36:56.092Z,1680295016.092 [DATMMP](INFO): *** SENDING_FILL_BUFFER *** 2023-03-31T20:36:56.092Z,1680295016.092 [DATMMP](ERROR): Waiting for previous to be ack'd 2023-03-31T20:36:56.092Z,1680295016.092 [DATMMP](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_NAV_DATA 2023-03-31T20:36:56.344Z,1680295016.344 [DATMMP](INFO): *** SENDING_NAV_DATA *** 2023-03-31T20:36:56.344Z,1680295016.344 [DATMMP](DEBUG): In sendingNavData, set commsState_ = SENDING_TRANSMIT 2023-03-31T20:36:56.596Z,1680295016.596 [DATMMP](INFO): *** SENDING_TRANSMIT *** 2023-03-31T20:36:56.596Z,1680295016.596 [DATMMP](INFO): In sendingTransmit, dataTxMessage not ack'd 2023-03-31T20:36:56.596Z,1680295016.596 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:36:56.596Z,1680295016.596 [DATMMP](FAULT): Buffer send receipt timeout failure. 2023-03-31T20:36:56.596Z,1680295016.596 [DATMMP](DEBUG): In sendingTransmitVerify, timeout set commsState_ = SENDING_FILL_BUFFER 2023-03-31T20:36:56.848Z,1680295016.848 [DATMMP](INFO): *** SENDING_FILL_BUFFER *** 2023-03-31T20:36:56.848Z,1680295016.848 [DATMMP](ERROR): Waiting for previous to be ack'd 2023-03-31T20:36:56.848Z,1680295016.848 [DATMMP](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_NAV_DATA 2023-03-31T20:36:57.352Z,1680295017.352 [DATMMP](INFO): *** SENDING_NAV_DATA *** 2023-03-31T20:36:57.352Z,1680295017.352 [DATMMP](DEBUG): In sendingNavData, set commsState_ = SENDING_TRANSMIT 2023-03-31T20:36:57.603Z,1680295017.603 [DATMMP](INFO): *** SENDING_TRANSMIT *** 2023-03-31T20:36:57.604Z,1680295017.604 [DATMMP](INFO): In sendingTransmit, dataTxMessage not ack'd 2023-03-31T20:36:57.604Z,1680295017.604 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:36:57.604Z,1680295017.604 [DATMMP](FAULT): Buffer send receipt timeout failure. 2023-03-31T20:36:57.604Z,1680295017.604 [DATMMP](DEBUG): In sendingTransmitVerify, timeout set commsState_ = SENDING_FILL_BUFFER 2023-03-31T20:36:57.855Z,1680295017.855 [DATMMP](INFO): *** SENDING_FILL_BUFFER *** 2023-03-31T20:36:57.856Z,1680295017.856 [DATMMP](ERROR): Waiting for previous to be ack'd 2023-03-31T20:36:57.856Z,1680295017.856 [DATMMP](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_NAV_DATA 2023-03-31T20:36:58.108Z,1680295018.108 [DATMMP](INFO): *** SENDING_NAV_DATA *** 2023-03-31T20:36:58.108Z,1680295018.108 [DATMMP](DEBUG): In sendingNavData, set commsState_ = SENDING_TRANSMIT 2023-03-31T20:36:58.360Z,1680295018.360 [DATMMP](INFO): *** SENDING_TRANSMIT *** 2023-03-31T20:36:58.360Z,1680295018.360 [DATMMP](INFO): In sendingTransmit, dataTxMessage not ack'd 2023-03-31T20:36:58.360Z,1680295018.360 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:36:58.360Z,1680295018.360 [DATMMP](FAULT): Buffer send receipt timeout failure. 2023-03-31T20:36:58.360Z,1680295018.360 [DATMMP](DEBUG): In sendingTransmitVerify, timeout set commsState_ = SENDING_FILL_BUFFER 2023-03-31T20:36:58.611Z,1680295018.611 [DATMMP](INFO): *** SENDING_FILL_BUFFER *** 2023-03-31T20:36:58.612Z,1680295018.612 [DATMMP](ERROR): Waiting for previous to be ack'd 2023-03-31T20:36:58.612Z,1680295018.612 [DATMMP](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_NAV_DATA 2023-03-31T20:36:58.863Z,1680295018.863 [DATMMP](INFO): *** SENDING_NAV_DATA *** 2023-03-31T20:36:58.864Z,1680295018.864 [DATMMP](DEBUG): In sendingNavData, set commsState_ = SENDING_TRANSMIT 2023-03-31T20:36:59.116Z,1680295019.116 [DATMMP](INFO): *** SENDING_TRANSMIT *** 2023-03-31T20:36:59.116Z,1680295019.116 [DATMMP](INFO): In sendingTransmit, dataTxMessage not ack'd 2023-03-31T20:36:59.116Z,1680295019.116 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:36:59.116Z,1680295019.116 [DATMMP](FAULT): Buffer send receipt timeout failure. 2023-03-31T20:36:59.116Z,1680295019.116 [DATMMP](DEBUG): In sendingTransmitVerify, timeout set commsState_ = SENDING_FILL_BUFFER 2023-03-31T20:36:59.368Z,1680295019.368 [DATMMP](INFO): *** SENDING_FILL_BUFFER *** 2023-03-31T20:36:59.368Z,1680295019.368 [DATMMP](ERROR): Waiting for previous to be ack'd 2023-03-31T20:36:59.368Z,1680295019.368 [DATMMP](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_NAV_DATA 2023-03-31T20:36:59.620Z,1680295019.620 [DATMMP](INFO): *** SENDING_NAV_DATA *** 2023-03-31T20:36:59.620Z,1680295019.620 [DATMMP](DEBUG): In sendingNavData, set commsState_ = SENDING_TRANSMIT 2023-03-31T20:36:59.872Z,1680295019.872 [DATMMP](INFO): *** SENDING_TRANSMIT *** 2023-03-31T20:36:59.872Z,1680295019.872 [DATMMP](INFO): In sendingTransmit, dataTxMessage not ack'd 2023-03-31T20:36:59.872Z,1680295019.872 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:36:59.872Z,1680295019.872 [DATMMP](FAULT): Buffer send receipt timeout failure. 2023-03-31T20:36:59.872Z,1680295019.872 [DATMMP](DEBUG): In sendingTransmitVerify, timeout set commsState_ = SENDING_FILL_BUFFER 2023-03-31T20:37:00.123Z,1680295020.123 [DATMMP](INFO): *** SENDING_FILL_BUFFER *** 2023-03-31T20:37:00.124Z,1680295020.124 [DATMMP](ERROR): Waiting for previous to be ack'd 2023-03-31T20:37:00.124Z,1680295020.124 [DATMMP](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_NAV_DATA 2023-03-31T20:37:00.376Z,1680295020.376 [DATMMP](INFO): *** SENDING_NAV_DATA *** 2023-03-31T20:37:00.376Z,1680295020.376 [DATMMP](DEBUG): In sendingNavData, set commsState_ = SENDING_TRANSMIT 2023-03-31T20:37:00.628Z,1680295020.628 [DATMMP](INFO): *** SENDING_TRANSMIT *** 2023-03-31T20:37:00.628Z,1680295020.628 [DATMMP](INFO): In sendingTransmit, dataTxMessage not ack'd 2023-03-31T20:37:00.628Z,1680295020.628 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:37:00.628Z,1680295020.628 [DATMMP](FAULT): Buffer send receipt timeout failure. 2023-03-31T20:37:00.628Z,1680295020.628 [DATMMP](DEBUG): In sendingTransmitVerify, timeout set commsState_ = SENDING_FILL_BUFFER 2023-03-31T20:37:00.879Z,1680295020.879 [DATMMP](INFO): *** SENDING_FILL_BUFFER *** 2023-03-31T20:37:00.880Z,1680295020.880 [DATMMP](ERROR): Waiting for previous to be ack'd 2023-03-31T20:37:00.880Z,1680295020.880 [DATMMP](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_NAV_DATA 2023-03-31T20:37:01.132Z,1680295021.132 [DATMMP](INFO): *** SENDING_NAV_DATA *** 2023-03-31T20:37:01.132Z,1680295021.132 [DATMMP](DEBUG): In sendingNavData, set commsState_ = SENDING_TRANSMIT 2023-03-31T20:37:01.383Z,1680295021.383 [DATMMP](INFO): *** SENDING_TRANSMIT *** 2023-03-31T20:37:01.384Z,1680295021.384 [DATMMP](INFO): In sendingTransmit, dataTxMessage not ack'd 2023-03-31T20:37:01.384Z,1680295021.384 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:37:01.384Z,1680295021.384 [DATMMP](FAULT): Buffer send receipt timeout failure. 2023-03-31T20:37:01.384Z,1680295021.384 [DATMMP](DEBUG): In sendingTransmitVerify, timeout set commsState_ = SENDING_FILL_BUFFER 2023-03-31T20:37:01.637Z,1680295021.637 [DATMMP](INFO): *** SENDING_FILL_BUFFER *** 2023-03-31T20:37:01.637Z,1680295021.637 [DATMMP](ERROR): Waiting for previous to be ack'd 2023-03-31T20:37:01.637Z,1680295021.637 [DATMMP](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_NAV_DATA 2023-03-31T20:37:01.888Z,1680295021.888 [DATMMP](INFO): *** SENDING_NAV_DATA *** 2023-03-31T20:37:01.888Z,1680295021.888 [DATMMP](DEBUG): In sendingNavData, set commsState_ = SENDING_TRANSMIT 2023-03-31T20:37:02.140Z,1680295022.140 [DATMMP](INFO): *** SENDING_TRANSMIT *** 2023-03-31T20:37:02.140Z,1680295022.140 [DATMMP](INFO): In sendingTransmit, dataTxMessage not ack'd 2023-03-31T20:37:02.140Z,1680295022.140 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:37:02.140Z,1680295022.140 [DATMMP](FAULT): Buffer send receipt timeout failure. 2023-03-31T20:37:02.140Z,1680295022.140 [DATMMP](DEBUG): In sendingTransmitVerify, timeout set commsState_ = SENDING_FILL_BUFFER 2023-03-31T20:37:02.392Z,1680295022.392 [DATMMP](INFO): *** SENDING_FILL_BUFFER *** 2023-03-31T20:37:02.392Z,1680295022.392 [DATMMP](ERROR): Waiting for previous to be ack'd 2023-03-31T20:37:02.392Z,1680295022.392 [DATMMP](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_NAV_DATA 2023-03-31T20:37:02.643Z,1680295022.643 [DATMMP](INFO): *** SENDING_NAV_DATA *** 2023-03-31T20:37:02.644Z,1680295022.644 [DATMMP](DEBUG): In sendingNavData, set commsState_ = SENDING_TRANSMIT 2023-03-31T20:37:02.896Z,1680295022.896 [DATMMP](INFO): *** SENDING_TRANSMIT *** 2023-03-31T20:37:02.896Z,1680295022.896 [DATMMP](INFO): In sendingTransmit, dataTxMessage not ack'd 2023-03-31T20:37:02.896Z,1680295022.896 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:37:02.896Z,1680295022.896 [DATMMP](FAULT): Buffer send receipt timeout failure. 2023-03-31T20:37:02.896Z,1680295022.896 [DATMMP](DEBUG): In sendingTransmitVerify, timeout set commsState_ = SENDING_FILL_BUFFER 2023-03-31T20:37:03.148Z,1680295023.148 [DATMMP](INFO): *** SENDING_FILL_BUFFER *** 2023-03-31T20:37:03.148Z,1680295023.148 [DATMMP](ERROR): Waiting for previous to be ack'd 2023-03-31T20:37:03.148Z,1680295023.148 [DATMMP](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_NAV_DATA 2023-03-31T20:37:03.400Z,1680295023.400 [DATMMP](INFO): *** SENDING_NAV_DATA *** 2023-03-31T20:37:03.400Z,1680295023.400 [DATMMP](DEBUG): In sendingNavData, set commsState_ = SENDING_TRANSMIT 2023-03-31T20:37:03.652Z,1680295023.652 [DATMMP](INFO): *** SENDING_TRANSMIT *** 2023-03-31T20:37:03.652Z,1680295023.652 [DATMMP](INFO): In sendingTransmit, dataTxMessage not ack'd 2023-03-31T20:37:03.652Z,1680295023.652 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:37:03.652Z,1680295023.652 [DATMMP](FAULT): Buffer send receipt timeout failure. 2023-03-31T20:37:03.652Z,1680295023.652 [DATMMP](DEBUG): In sendingTransmitVerify, timeout set commsState_ = SENDING_FILL_BUFFER 2023-03-31T20:37:03.903Z,1680295023.903 [DATMMP](INFO): *** SENDING_FILL_BUFFER *** 2023-03-31T20:37:03.904Z,1680295023.904 [DATMMP](ERROR): Waiting for previous to be ack'd 2023-03-31T20:37:03.904Z,1680295023.904 [DATMMP](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_NAV_DATA 2023-03-31T20:37:04.156Z,1680295024.156 [DATMMP](INFO): *** SENDING_NAV_DATA *** 2023-03-31T20:37:04.156Z,1680295024.156 [DATMMP](DEBUG): In sendingNavData, set commsState_ = SENDING_TRANSMIT 2023-03-31T20:37:04.408Z,1680295024.408 [DATMMP](INFO): *** SENDING_TRANSMIT *** 2023-03-31T20:37:04.408Z,1680295024.408 [DATMMP](INFO): In sendingTransmit, dataTxMessage not ack'd 2023-03-31T20:37:04.408Z,1680295024.408 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:37:04.408Z,1680295024.408 [DATMMP](FAULT): Buffer send receipt timeout failure. 2023-03-31T20:37:04.408Z,1680295024.408 [DATMMP](DEBUG): In sendingTransmitVerify, timeout set commsState_ = SENDING_FILL_BUFFER 2023-03-31T20:37:04.660Z,1680295024.660 [DATMMP](INFO): *** SENDING_FILL_BUFFER *** 2023-03-31T20:37:04.660Z,1680295024.660 [DATMMP](ERROR): Waiting for previous to be ack'd 2023-03-31T20:37:04.660Z,1680295024.660 [DATMMP](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_NAV_DATA 2023-03-31T20:37:04.912Z,1680295024.912 [DATMMP](INFO): *** SENDING_NAV_DATA *** 2023-03-31T20:37:04.912Z,1680295024.912 [DATMMP](DEBUG): In sendingNavData, set commsState_ = SENDING_TRANSMIT 2023-03-31T20:37:05.164Z,1680295025.164 [DATMMP](INFO): *** SENDING_TRANSMIT *** 2023-03-31T20:37:05.164Z,1680295025.164 [DATMMP](INFO): In sendingTransmit, dataTxMessage not ack'd 2023-03-31T20:37:05.164Z,1680295025.164 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:37:05.164Z,1680295025.164 [DATMMP](FAULT): Buffer send receipt timeout failure. 2023-03-31T20:37:05.164Z,1680295025.164 [DATMMP](DEBUG): In sendingTransmitVerify, timeout set commsState_ = SENDING_FILL_BUFFER 2023-03-31T20:37:05.166Z,1680295025.166 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4 2023-03-31T20:37:05.166Z,1680295025.166 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-03-31T20:37:05.210Z,1680295025.210 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-03-31T20:37:05.416Z,1680295025.416 [DATMMP](INFO): *** SENDING_FILL_BUFFER *** 2023-03-31T20:37:05.416Z,1680295025.416 [DATMMP](ERROR): Waiting for previous to be ack'd 2023-03-31T20:37:05.416Z,1680295025.416 [DATMMP](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_NAV_DATA 2023-03-31T20:37:05.633Z,1680295025.633 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-03-31T20:37:05.633Z,1680295025.633 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4 2023-03-31T20:37:05.668Z,1680295025.668 [DATMMP](INFO): *** SENDING_NAV_DATA *** 2023-03-31T20:37:05.668Z,1680295025.668 [DATMMP](DEBUG): In sendingNavData, set commsState_ = SENDING_TRANSMIT 2023-03-31T20:37:05.920Z,1680295025.920 [DATMMP](INFO): *** SENDING_TRANSMIT *** 2023-03-31T20:37:05.920Z,1680295025.920 [DATMMP](INFO): In sendingTransmit, dataTxMessage not ack'd 2023-03-31T20:37:05.920Z,1680295025.920 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:37:05.920Z,1680295025.920 [DATMMP](FAULT): Buffer send receipt timeout failure. 2023-03-31T20:37:05.920Z,1680295025.920 [DATMMP](DEBUG): In sendingTransmitVerify, timeout set commsState_ = SENDING_FILL_BUFFER 2023-03-31T20:37:06.171Z,1680295026.171 [DATMMP](INFO): *** SENDING_FILL_BUFFER *** 2023-03-31T20:37:06.172Z,1680295026.172 [DATMMP](ERROR): Waiting for previous to be ack'd 2023-03-31T20:37:06.172Z,1680295026.172 [DATMMP](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_NAV_DATA 2023-03-31T20:37:06.676Z,1680295026.676 [DATMMP](INFO): *** SENDING_NAV_DATA *** 2023-03-31T20:37:06.676Z,1680295026.676 [DATMMP](DEBUG): In sendingNavData, set commsState_ = SENDING_TRANSMIT 2023-03-31T20:37:06.928Z,1680295026.928 [DATMMP](INFO): *** SENDING_TRANSMIT *** 2023-03-31T20:37:06.928Z,1680295026.928 [DATMMP](INFO): In sendingTransmit, dataTxMessage not ack'd 2023-03-31T20:37:06.928Z,1680295026.928 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:37:06.928Z,1680295026.928 [DATMMP](FAULT): Buffer send receipt timeout failure. 2023-03-31T20:37:06.928Z,1680295026.928 [DATMMP](DEBUG): In sendingTransmitVerify, timeout set commsState_ = SENDING_FILL_BUFFER 2023-03-31T20:37:07.431Z,1680295027.431 [DATMMP](INFO): *** SENDING_FILL_BUFFER *** 2023-03-31T20:37:07.432Z,1680295027.432 [DATMMP](ERROR): Waiting for previous to be ack'd 2023-03-31T20:37:07.432Z,1680295027.432 [DATMMP](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_NAV_DATA 2023-03-31T20:37:07.683Z,1680295027.683 [DATMMP](INFO): *** SENDING_NAV_DATA *** 2023-03-31T20:37:07.684Z,1680295027.684 [DATMMP](DEBUG): In sendingNavData, set commsState_ = SENDING_TRANSMIT 2023-03-31T20:37:07.935Z,1680295027.935 [DATMMP](INFO): *** SENDING_TRANSMIT *** 2023-03-31T20:37:07.936Z,1680295027.936 [DATMMP](INFO): In sendingTransmit, dataTxMessage not ack'd 2023-03-31T20:37:07.936Z,1680295027.936 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:37:07.936Z,1680295027.936 [DATMMP](FAULT): Buffer send receipt timeout failure. 2023-03-31T20:37:07.936Z,1680295027.936 [DATMMP](DEBUG): In sendingTransmitVerify, timeout set commsState_ = SENDING_FILL_BUFFER 2023-03-31T20:37:08.188Z,1680295028.188 [DATMMP](INFO): *** SENDING_FILL_BUFFER *** 2023-03-31T20:37:08.188Z,1680295028.188 [DATMMP](ERROR): Waiting for previous to be ack'd 2023-03-31T20:37:08.188Z,1680295028.188 [DATMMP](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_NAV_DATA 2023-03-31T20:37:08.440Z,1680295028.440 [DATMMP](INFO): *** SENDING_NAV_DATA *** 2023-03-31T20:37:08.440Z,1680295028.440 [DATMMP](DEBUG): In sendingNavData, set commsState_ = SENDING_TRANSMIT 2023-03-31T20:37:08.691Z,1680295028.691 [DATMMP](INFO): *** SENDING_TRANSMIT *** 2023-03-31T20:37:08.692Z,1680295028.692 [DATMMP](INFO): In sendingTransmit, dataTxMessage not ack'd 2023-03-31T20:37:08.692Z,1680295028.692 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:37:08.692Z,1680295028.692 [DATMMP](FAULT): Buffer send receipt timeout failure. 2023-03-31T20:37:08.692Z,1680295028.692 [DATMMP](DEBUG): In sendingTransmitVerify, timeout set commsState_ = SENDING_FILL_BUFFER 2023-03-31T20:37:08.944Z,1680295028.944 [DATMMP](INFO): *** SENDING_FILL_BUFFER *** 2023-03-31T20:37:08.944Z,1680295028.944 [DATMMP](ERROR): Waiting for previous to be ack'd 2023-03-31T20:37:08.944Z,1680295028.944 [DATMMP](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_NAV_DATA 2023-03-31T20:37:09.197Z,1680295029.197 [DATMMP](INFO): *** SENDING_NAV_DATA *** 2023-03-31T20:37:09.197Z,1680295029.197 [DATMMP](DEBUG): In sendingNavData, set commsState_ = SENDING_TRANSMIT 2023-03-31T20:37:09.447Z,1680295029.447 [DATMMP](INFO): *** SENDING_TRANSMIT *** 2023-03-31T20:37:09.448Z,1680295029.448 [DATMMP](INFO): In sendingTransmit, dataTxMessage not ack'd 2023-03-31T20:37:09.448Z,1680295029.448 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:37:09.448Z,1680295029.448 [DATMMP](FAULT): Buffer send receipt timeout failure. 2023-03-31T20:37:09.448Z,1680295029.448 [DATMMP](DEBUG): In sendingTransmitVerify, timeout set commsState_ = SENDING_FILL_BUFFER 2023-03-31T20:37:09.700Z,1680295029.700 [DATMMP](INFO): *** SENDING_FILL_BUFFER *** 2023-03-31T20:37:09.700Z,1680295029.700 [DATMMP](ERROR): Waiting for previous to be ack'd 2023-03-31T20:37:09.700Z,1680295029.700 [DATMMP](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_NAV_DATA 2023-03-31T20:37:09.951Z,1680295029.951 [DATMMP](INFO): *** SENDING_NAV_DATA *** 2023-03-31T20:37:09.952Z,1680295029.952 [DATMMP](DEBUG): In sendingNavData, set commsState_ = SENDING_TRANSMIT 2023-03-31T20:37:10.204Z,1680295030.204 [DATMMP](INFO): *** SENDING_TRANSMIT *** 2023-03-31T20:37:10.204Z,1680295030.204 [DATMMP](INFO): In sendingTransmit, dataTxMessage not ack'd 2023-03-31T20:37:10.204Z,1680295030.204 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:37:10.204Z,1680295030.204 [DATMMP](FAULT): Buffer send receipt timeout failure. 2023-03-31T20:37:10.204Z,1680295030.204 [DATMMP](DEBUG): In sendingTransmitVerify, timeout set commsState_ = SENDING_FILL_BUFFER 2023-03-31T20:37:10.456Z,1680295030.456 [DATMMP](INFO): *** SENDING_FILL_BUFFER *** 2023-03-31T20:37:10.456Z,1680295030.456 [DATMMP](ERROR): Waiting for previous to be ack'd 2023-03-31T20:37:10.456Z,1680295030.456 [DATMMP](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_NAV_DATA 2023-03-31T20:37:10.708Z,1680295030.708 [DATMMP](INFO): *** SENDING_NAV_DATA *** 2023-03-31T20:37:10.708Z,1680295030.708 [DATMMP](DEBUG): In sendingNavData, set commsState_ = SENDING_TRANSMIT 2023-03-31T20:37:10.960Z,1680295030.960 [DATMMP](INFO): *** SENDING_TRANSMIT *** 2023-03-31T20:37:10.960Z,1680295030.960 [DATMMP](INFO): In sendingTransmit, dataTxMessage not ack'd 2023-03-31T20:37:10.960Z,1680295030.960 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:37:10.960Z,1680295030.960 [DATMMP](FAULT): Buffer send receipt timeout failure. 2023-03-31T20:37:10.960Z,1680295030.960 [DATMMP](DEBUG): In sendingTransmitVerify, timeout set commsState_ = SENDING_FILL_BUFFER 2023-03-31T20:37:11.211Z,1680295031.211 [DATMMP](INFO): *** SENDING_FILL_BUFFER *** 2023-03-31T20:37:11.212Z,1680295031.212 [DATMMP](ERROR): Waiting for previous to be ack'd 2023-03-31T20:37:11.212Z,1680295031.212 [DATMMP](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_NAV_DATA 2023-03-31T20:37:11.464Z,1680295031.464 [DATMMP](INFO): *** SENDING_NAV_DATA *** 2023-03-31T20:37:11.464Z,1680295031.464 [DATMMP](DEBUG): In sendingNavData, set commsState_ = SENDING_TRANSMIT 2023-03-31T20:37:11.716Z,1680295031.716 [DATMMP](INFO): *** SENDING_TRANSMIT *** 2023-03-31T20:37:11.716Z,1680295031.716 [DATMMP](INFO): In sendingTransmit, dataTxMessage not ack'd 2023-03-31T20:37:11.716Z,1680295031.716 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:37:11.716Z,1680295031.716 [DATMMP](FAULT): Buffer send receipt timeout failure. 2023-03-31T20:37:11.716Z,1680295031.716 [DATMMP](DEBUG): In sendingTransmitVerify, timeout set commsState_ = SENDING_FILL_BUFFER 2023-03-31T20:37:11.968Z,1680295031.968 [DATMMP](INFO): *** SENDING_FILL_BUFFER *** 2023-03-31T20:37:11.968Z,1680295031.968 [DATMMP](ERROR): Waiting for previous to be ack'd 2023-03-31T20:37:11.968Z,1680295031.968 [DATMMP](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_NAV_DATA 2023-03-31T20:37:12.219Z,1680295032.219 [DATMMP](INFO): *** SENDING_NAV_DATA *** 2023-03-31T20:37:12.220Z,1680295032.220 [DATMMP](DEBUG): In sendingNavData, set commsState_ = SENDING_TRANSMIT 2023-03-31T20:37:12.472Z,1680295032.472 [DATMMP](INFO): *** SENDING_TRANSMIT *** 2023-03-31T20:37:12.472Z,1680295032.472 [DATMMP](INFO): In sendingTransmit, dataTxMessage not ack'd 2023-03-31T20:37:12.472Z,1680295032.472 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:37:12.472Z,1680295032.472 [DATMMP](FAULT): Buffer send receipt timeout failure. 2023-03-31T20:37:12.472Z,1680295032.472 [DATMMP](DEBUG): In sendingTransmitVerify, timeout set commsState_ = SENDING_FILL_BUFFER 2023-03-31T20:37:12.724Z,1680295032.724 [DATMMP](INFO): *** SENDING_FILL_BUFFER *** 2023-03-31T20:37:12.724Z,1680295032.724 [DATMMP](ERROR): Waiting for previous to be ack'd 2023-03-31T20:37:12.724Z,1680295032.724 [DATMMP](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_NAV_DATA 2023-03-31T20:37:12.976Z,1680295032.976 [DATMMP](INFO): *** SENDING_NAV_DATA *** 2023-03-31T20:37:12.976Z,1680295032.976 [DATMMP](DEBUG): In sendingNavData, set commsState_ = SENDING_TRANSMIT 2023-03-31T20:37:13.228Z,1680295033.228 [DATMMP](INFO): *** SENDING_TRANSMIT *** 2023-03-31T20:37:13.228Z,1680295033.228 [DATMMP](INFO): In sendingTransmit, dataTxMessage not ack'd 2023-03-31T20:37:13.228Z,1680295033.228 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:37:13.228Z,1680295033.228 [DATMMP](FAULT): Buffer send receipt timeout failure. 2023-03-31T20:37:13.228Z,1680295033.228 [DATMMP](DEBUG): In sendingTransmitVerify, timeout set commsState_ = SENDING_FILL_BUFFER 2023-03-31T20:37:13.479Z,1680295033.479 [DATMMP](INFO): *** SENDING_FILL_BUFFER *** 2023-03-31T20:37:13.480Z,1680295033.480 [DATMMP](ERROR): Waiting for previous to be ack'd 2023-03-31T20:37:13.480Z,1680295033.480 [DATMMP](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_NAV_DATA 2023-03-31T20:37:13.732Z,1680295033.732 [DATMMP](INFO): *** SENDING_NAV_DATA *** 2023-03-31T20:37:13.732Z,1680295033.732 [DATMMP](DEBUG): In sendingNavData, set commsState_ = SENDING_TRANSMIT 2023-03-31T20:37:13.984Z,1680295033.984 [DATMMP](INFO): *** SENDING_TRANSMIT *** 2023-03-31T20:37:13.984Z,1680295033.984 [DATMMP](INFO): In sendingTransmit, dataTxMessage not ack'd 2023-03-31T20:37:13.984Z,1680295033.984 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:37:13.984Z,1680295033.984 [DATMMP](FAULT): Buffer send receipt timeout failure. 2023-03-31T20:37:13.984Z,1680295033.984 [DATMMP](DEBUG): In sendingTransmitVerify, timeout set commsState_ = SENDING_FILL_BUFFER 2023-03-31T20:37:14.236Z,1680295034.236 [DATMMP](INFO): *** SENDING_FILL_BUFFER *** 2023-03-31T20:37:14.236Z,1680295034.236 [DATMMP](ERROR): Waiting for previous to be ack'd 2023-03-31T20:37:14.236Z,1680295034.236 [DATMMP](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_NAV_DATA 2023-03-31T20:37:14.487Z,1680295034.487 [DATMMP](INFO): *** SENDING_NAV_DATA *** 2023-03-31T20:37:14.488Z,1680295034.488 [DATMMP](DEBUG): In sendingNavData, set commsState_ = SENDING_TRANSMIT 2023-03-31T20:37:14.740Z,1680295034.740 [DATMMP](INFO): *** SENDING_TRANSMIT *** 2023-03-31T20:37:14.740Z,1680295034.740 [DATMMP](INFO): In sendingTransmit, dataTxMessage not ack'd 2023-03-31T20:37:14.740Z,1680295034.740 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:37:14.740Z,1680295034.740 [DATMMP](FAULT): Buffer send receipt timeout failure. 2023-03-31T20:37:14.740Z,1680295034.740 [DATMMP](DEBUG): In sendingTransmitVerify, timeout set commsState_ = SENDING_FILL_BUFFER 2023-03-31T20:37:14.992Z,1680295034.992 [DATMMP](INFO): *** SENDING_FILL_BUFFER *** 2023-03-31T20:37:14.992Z,1680295034.992 [DATMMP](ERROR): Waiting for previous to be ack'd 2023-03-31T20:37:14.992Z,1680295034.992 [DATMMP](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_NAV_DATA 2023-03-31T20:37:15.244Z,1680295035.244 [DATMMP](INFO): *** SENDING_NAV_DATA *** 2023-03-31T20:37:15.244Z,1680295035.244 [DATMMP](DEBUG): In sendingNavData, set commsState_ = SENDING_TRANSMIT 2023-03-31T20:37:15.496Z,1680295035.496 [DATMMP](INFO): *** SENDING_TRANSMIT *** 2023-03-31T20:37:15.496Z,1680295035.496 [DATMMP](INFO): In sendingTransmit, dataTxMessage not ack'd 2023-03-31T20:37:15.496Z,1680295035.496 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:37:15.496Z,1680295035.496 [DATMMP](FAULT): Buffer send receipt timeout failure. 2023-03-31T20:37:15.496Z,1680295035.496 [DATMMP](DEBUG): In sendingTransmitVerify, timeout set commsState_ = SENDING_FILL_BUFFER 2023-03-31T20:37:15.748Z,1680295035.748 [DATMMP](INFO): *** SENDING_FILL_BUFFER *** 2023-03-31T20:37:15.748Z,1680295035.748 [DATMMP](ERROR): Waiting for previous to be ack'd 2023-03-31T20:37:15.748Z,1680295035.748 [DATMMP](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_NAV_DATA 2023-03-31T20:37:16.002Z,1680295036.002 [DATMMP](INFO): *** SENDING_NAV_DATA *** 2023-03-31T20:37:16.002Z,1680295036.002 [DATMMP](DEBUG): In sendingNavData, set commsState_ = SENDING_TRANSMIT 2023-03-31T20:37:16.252Z,1680295036.252 [DATMMP](INFO): *** SENDING_TRANSMIT *** 2023-03-31T20:37:16.252Z,1680295036.252 [DATMMP](INFO): In sendingTransmit, dataTxMessage not ack'd 2023-03-31T20:37:16.252Z,1680295036.252 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:37:16.252Z,1680295036.252 [DATMMP](FAULT): Buffer send receipt timeout failure. 2023-03-31T20:37:16.252Z,1680295036.252 [DATMMP](DEBUG): In sendingTransmitVerify, timeout set commsState_ = SENDING_FILL_BUFFER 2023-03-31T20:37:16.504Z,1680295036.504 [DATMMP](INFO): *** SENDING_FILL_BUFFER *** 2023-03-31T20:37:16.504Z,1680295036.504 [DATMMP](ERROR): Waiting for previous to be ack'd 2023-03-31T20:37:16.504Z,1680295036.504 [DATMMP](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_NAV_DATA 2023-03-31T20:37:16.756Z,1680295036.756 [DATMMP](INFO): *** SENDING_NAV_DATA *** 2023-03-31T20:37:16.756Z,1680295036.756 [DATMMP](DEBUG): In sendingNavData, set commsState_ = SENDING_TRANSMIT 2023-03-31T20:37:17.008Z,1680295037.008 [DATMMP](INFO): *** SENDING_TRANSMIT *** 2023-03-31T20:37:17.008Z,1680295037.008 [DATMMP](INFO): In sendingTransmit, dataTxMessage not ack'd 2023-03-31T20:37:17.008Z,1680295037.008 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:37:17.008Z,1680295037.008 [DATMMP](FAULT): Buffer send receipt timeout failure. 2023-03-31T20:37:17.008Z,1680295037.008 [DATMMP](DEBUG): In sendingTransmitVerify, timeout set commsState_ = SENDING_FILL_BUFFER 2023-03-31T20:37:17.260Z,1680295037.260 [DATMMP](INFO): *** SENDING_FILL_BUFFER *** 2023-03-31T20:37:17.260Z,1680295037.260 [DATMMP](ERROR): Waiting for previous to be ack'd 2023-03-31T20:37:17.260Z,1680295037.260 [DATMMP](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_NAV_DATA 2023-03-31T20:37:17.512Z,1680295037.512 [DATMMP](INFO): *** SENDING_NAV_DATA *** 2023-03-31T20:37:17.512Z,1680295037.512 [DATMMP](DEBUG): In sendingNavData, set commsState_ = SENDING_TRANSMIT 2023-03-31T20:37:17.763Z,1680295037.763 [DATMMP](INFO): *** SENDING_TRANSMIT *** 2023-03-31T20:37:17.764Z,1680295037.764 [DATMMP](INFO): In sendingTransmit, dataTxMessage not ack'd 2023-03-31T20:37:17.764Z,1680295037.764 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:37:17.764Z,1680295037.764 [DATMMP](FAULT): Buffer send receipt timeout failure. 2023-03-31T20:37:17.764Z,1680295037.764 [DATMMP](DEBUG): In sendingTransmitVerify, timeout set commsState_ = SENDING_FILL_BUFFER 2023-03-31T20:37:18.016Z,1680295038.016 [DATMMP](INFO): *** SENDING_FILL_BUFFER *** 2023-03-31T20:37:18.016Z,1680295038.016 [DATMMP](ERROR): Waiting for previous to be ack'd 2023-03-31T20:37:18.016Z,1680295038.016 [DATMMP](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_NAV_DATA 2023-03-31T20:37:18.268Z,1680295038.268 [DATMMP](INFO): *** SENDING_NAV_DATA *** 2023-03-31T20:37:18.268Z,1680295038.268 [DATMMP](DEBUG): In sendingNavData, set commsState_ = SENDING_TRANSMIT 2023-03-31T20:37:18.519Z,1680295038.519 [DATMMP](INFO): *** SENDING_TRANSMIT *** 2023-03-31T20:37:18.520Z,1680295038.520 [DATMMP](INFO): In sendingTransmit, dataTxMessage not ack'd 2023-03-31T20:37:18.520Z,1680295038.520 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:37:18.520Z,1680295038.520 [DATMMP](FAULT): Buffer send receipt timeout failure. 2023-03-31T20:37:18.520Z,1680295038.520 [DATMMP](DEBUG): In sendingTransmitVerify, timeout set commsState_ = SENDING_FILL_BUFFER 2023-03-31T20:37:18.772Z,1680295038.772 [DATMMP](INFO): *** SENDING_FILL_BUFFER *** 2023-03-31T20:37:18.772Z,1680295038.772 [DATMMP](ERROR): Waiting for previous to be ack'd 2023-03-31T20:37:18.772Z,1680295038.772 [DATMMP](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_NAV_DATA 2023-03-31T20:37:19.023Z,1680295039.023 [DATMMP](INFO): *** SENDING_NAV_DATA *** 2023-03-31T20:37:19.024Z,1680295039.024 [DATMMP](DEBUG): In sendingNavData, set commsState_ = SENDING_TRANSMIT 2023-03-31T20:37:19.276Z,1680295039.276 [DATMMP](INFO): *** SENDING_TRANSMIT *** 2023-03-31T20:37:19.276Z,1680295039.276 [DATMMP](INFO): In sendingTransmit, dataTxMessage not ack'd 2023-03-31T20:37:19.276Z,1680295039.276 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:37:19.276Z,1680295039.276 [DATMMP](FAULT): Buffer send receipt timeout failure. 2023-03-31T20:37:19.276Z,1680295039.276 [DATMMP](DEBUG): In sendingTransmitVerify, timeout set commsState_ = SENDING_FILL_BUFFER 2023-03-31T20:37:19.528Z,1680295039.528 [DATMMP](INFO): *** SENDING_FILL_BUFFER *** 2023-03-31T20:37:19.528Z,1680295039.528 [DATMMP](ERROR): Waiting for previous to be ack'd 2023-03-31T20:37:19.528Z,1680295039.528 [DATMMP](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_NAV_DATA 2023-03-31T20:37:19.780Z,1680295039.780 [DATMMP](INFO): *** SENDING_NAV_DATA *** 2023-03-31T20:37:19.780Z,1680295039.780 [DATMMP](DEBUG): In sendingNavData, set commsState_ = SENDING_TRANSMIT 2023-03-31T20:37:20.031Z,1680295040.031 [DATMMP](INFO): *** SENDING_TRANSMIT *** 2023-03-31T20:37:20.032Z,1680295040.032 [DATMMP](INFO): In sendingTransmit, dataTxMessage not ack'd 2023-03-31T20:37:20.032Z,1680295040.032 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:37:20.032Z,1680295040.032 [DATMMP](FAULT): Buffer send receipt timeout failure. 2023-03-31T20:37:20.032Z,1680295040.032 [DATMMP](DEBUG): In sendingTransmitVerify, timeout set commsState_ = SENDING_FILL_BUFFER 2023-03-31T20:37:20.284Z,1680295040.284 [DATMMP](INFO): *** SENDING_FILL_BUFFER *** 2023-03-31T20:37:20.284Z,1680295040.284 [DATMMP](ERROR): Waiting for previous to be ack'd 2023-03-31T20:37:20.284Z,1680295040.284 [DATMMP](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_NAV_DATA 2023-03-31T20:37:20.788Z,1680295040.788 [DATMMP](INFO): *** SENDING_NAV_DATA *** 2023-03-31T20:37:20.788Z,1680295040.788 [DATMMP](DEBUG): In sendingNavData, set commsState_ = SENDING_TRANSMIT 2023-03-31T20:37:21.040Z,1680295041.040 [DATMMP](INFO): *** SENDING_TRANSMIT *** 2023-03-31T20:37:21.040Z,1680295041.040 [DATMMP](INFO): In sendingTransmit, dataTxMessage not ack'd 2023-03-31T20:37:21.040Z,1680295041.040 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:37:21.040Z,1680295041.040 [DATMMP](FAULT): Buffer send receipt timeout failure. 2023-03-31T20:37:21.040Z,1680295041.040 [DATMMP](DEBUG): In sendingTransmitVerify, timeout set commsState_ = SENDING_FILL_BUFFER 2023-03-31T20:37:21.292Z,1680295041.292 [DATMMP](INFO): *** SENDING_FILL_BUFFER *** 2023-03-31T20:37:21.292Z,1680295041.292 [DATMMP](ERROR): Waiting for previous to be ack'd 2023-03-31T20:37:21.292Z,1680295041.292 [DATMMP](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_NAV_DATA 2023-03-31T20:37:21.544Z,1680295041.544 [DATMMP](INFO): *** SENDING_NAV_DATA *** 2023-03-31T20:37:21.544Z,1680295041.544 [DATMMP](DEBUG): In sendingNavData, set commsState_ = SENDING_TRANSMIT 2023-03-31T20:37:21.796Z,1680295041.796 [DATMMP](INFO): *** SENDING_TRANSMIT *** 2023-03-31T20:37:21.796Z,1680295041.796 [DATMMP](INFO): In sendingTransmit, dataTxMessage not ack'd 2023-03-31T20:37:21.796Z,1680295041.796 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:37:21.796Z,1680295041.796 [DATMMP](FAULT): Buffer send receipt timeout failure. 2023-03-31T20:37:21.796Z,1680295041.796 [DATMMP](DEBUG): In sendingTransmitVerify, timeout set commsState_ = SENDING_FILL_BUFFER 2023-03-31T20:37:22.047Z,1680295042.047 [DATMMP](INFO): *** SENDING_FILL_BUFFER *** 2023-03-31T20:37:22.048Z,1680295042.048 [DATMMP](ERROR): Waiting for previous to be ack'd 2023-03-31T20:37:22.048Z,1680295042.048 [DATMMP](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_NAV_DATA 2023-03-31T20:37:22.300Z,1680295042.300 [DATMMP](INFO): *** SENDING_NAV_DATA *** 2023-03-31T20:37:22.300Z,1680295042.300 [DATMMP](DEBUG): In sendingNavData, set commsState_ = SENDING_TRANSMIT 2023-03-31T20:37:22.552Z,1680295042.552 [DATMMP](INFO): *** SENDING_TRANSMIT *** 2023-03-31T20:37:22.552Z,1680295042.552 [DATMMP](INFO): In sendingTransmit, dataTxMessage not ack'd 2023-03-31T20:37:22.552Z,1680295042.552 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:37:22.552Z,1680295042.552 [DATMMP](FAULT): Buffer send receipt timeout failure. 2023-03-31T20:37:22.552Z,1680295042.552 [DATMMP](DEBUG): In sendingTransmitVerify, timeout set commsState_ = SENDING_FILL_BUFFER 2023-03-31T20:37:22.804Z,1680295042.804 [DATMMP](INFO): *** SENDING_FILL_BUFFER *** 2023-03-31T20:37:22.804Z,1680295042.804 [DATMMP](ERROR): Waiting for previous to be ack'd 2023-03-31T20:37:22.804Z,1680295042.804 [DATMMP](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_NAV_DATA 2023-03-31T20:37:23.056Z,1680295043.056 [DATMMP](INFO): *** SENDING_NAV_DATA *** 2023-03-31T20:37:23.056Z,1680295043.056 [DATMMP](DEBUG): In sendingNavData, set commsState_ = SENDING_TRANSMIT 2023-03-31T20:37:23.307Z,1680295043.307 [DATMMP](INFO): *** SENDING_TRANSMIT *** 2023-03-31T20:37:23.308Z,1680295043.308 [DATMMP](INFO): In sendingTransmit, dataTxMessage not ack'd 2023-03-31T20:37:23.308Z,1680295043.308 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:37:23.308Z,1680295043.308 [DATMMP](FAULT): Buffer send receipt timeout failure. 2023-03-31T20:37:23.308Z,1680295043.308 [DATMMP](DEBUG): In sendingTransmitVerify, timeout set commsState_ = SENDING_FILL_BUFFER 2023-03-31T20:37:23.560Z,1680295043.560 [DATMMP](INFO): *** SENDING_FILL_BUFFER *** 2023-03-31T20:37:23.560Z,1680295043.560 [DATMMP](ERROR): Waiting for previous to be ack'd 2023-03-31T20:37:23.560Z,1680295043.560 [DATMMP](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_NAV_DATA 2023-03-31T20:37:23.812Z,1680295043.812 [DATMMP](INFO): *** SENDING_NAV_DATA *** 2023-03-31T20:37:23.812Z,1680295043.812 [DATMMP](DEBUG): In sendingNavData, set commsState_ = SENDING_TRANSMIT 2023-03-31T20:37:24.064Z,1680295044.064 [DATMMP](INFO): *** SENDING_TRANSMIT *** 2023-03-31T20:37:24.064Z,1680295044.064 [DATMMP](INFO): In sendingTransmit, dataTxMessage not ack'd 2023-03-31T20:37:24.064Z,1680295044.064 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:37:24.064Z,1680295044.064 [DATMMP](FAULT): Buffer send receipt timeout failure. 2023-03-31T20:37:24.064Z,1680295044.064 [DATMMP](DEBUG): In sendingTransmitVerify, timeout set commsState_ = SENDING_FILL_BUFFER 2023-03-31T20:37:24.315Z,1680295044.315 [DATMMP](INFO): *** SENDING_FILL_BUFFER *** 2023-03-31T20:37:24.316Z,1680295044.316 [DATMMP](ERROR): Waiting for previous to be ack'd 2023-03-31T20:37:24.316Z,1680295044.316 [DATMMP](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_NAV_DATA 2023-03-31T20:37:24.568Z,1680295044.568 [DATMMP](INFO): *** SENDING_NAV_DATA *** 2023-03-31T20:37:24.568Z,1680295044.568 [DATMMP](DEBUG): In sendingNavData, set commsState_ = SENDING_TRANSMIT 2023-03-31T20:37:24.820Z,1680295044.820 [DATMMP](INFO): *** SENDING_TRANSMIT *** 2023-03-31T20:37:24.820Z,1680295044.820 [DATMMP](INFO): In sendingTransmit, dataTxMessage not ack'd 2023-03-31T20:37:24.820Z,1680295044.820 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:37:24.820Z,1680295044.820 [DATMMP](FAULT): Buffer send receipt timeout failure. 2023-03-31T20:37:24.820Z,1680295044.820 [DATMMP](DEBUG): In sendingTransmitVerify, timeout set commsState_ = SENDING_FILL_BUFFER 2023-03-31T20:37:25.072Z,1680295045.072 [DATMMP](INFO): *** SENDING_FILL_BUFFER *** 2023-03-31T20:37:25.072Z,1680295045.072 [DATMMP](ERROR): Waiting for previous to be ack'd 2023-03-31T20:37:25.072Z,1680295045.072 [DATMMP](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_NAV_DATA 2023-03-31T20:37:25.324Z,1680295045.324 [DATMMP](INFO): *** SENDING_NAV_DATA *** 2023-03-31T20:37:25.324Z,1680295045.324 [DATMMP](DEBUG): In sendingNavData, set commsState_ = SENDING_TRANSMIT 2023-03-31T20:37:25.575Z,1680295045.575 [DATMMP](INFO): *** SENDING_TRANSMIT *** 2023-03-31T20:37:25.576Z,1680295045.576 [DATMMP](INFO): In sendingTransmit, dataTxMessage not ack'd 2023-03-31T20:37:25.576Z,1680295045.576 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:37:25.576Z,1680295045.576 [DATMMP](FAULT): Buffer send receipt timeout failure. 2023-03-31T20:37:25.576Z,1680295045.576 [DATMMP](DEBUG): In sendingTransmitVerify, timeout set commsState_ = SENDING_FILL_BUFFER 2023-03-31T20:37:25.828Z,1680295045.828 [DATMMP](INFO): *** SENDING_FILL_BUFFER *** 2023-03-31T20:37:25.828Z,1680295045.828 [DATMMP](ERROR): Waiting for previous to be ack'd 2023-03-31T20:37:25.828Z,1680295045.828 [DATMMP](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_NAV_DATA 2023-03-31T20:37:26.080Z,1680295046.080 [DATMMP](INFO): *** SENDING_NAV_DATA *** 2023-03-31T20:37:26.080Z,1680295046.080 [DATMMP](DEBUG): In sendingNavData, set commsState_ = SENDING_TRANSMIT 2023-03-31T20:37:26.332Z,1680295046.332 [DATMMP](INFO): *** SENDING_TRANSMIT *** 2023-03-31T20:37:26.332Z,1680295046.332 [DATMMP](INFO): In sendingTransmit, dataTxMessage not ack'd 2023-03-31T20:37:26.332Z,1680295046.332 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:37:26.332Z,1680295046.332 [DATMMP](FAULT): Buffer send receipt timeout failure. 2023-03-31T20:37:26.332Z,1680295046.332 [DATMMP](DEBUG): In sendingTransmitVerify, timeout set commsState_ = SENDING_FILL_BUFFER 2023-03-31T20:37:26.584Z,1680295046.584 [DATMMP](INFO): *** SENDING_FILL_BUFFER *** 2023-03-31T20:37:26.584Z,1680295046.584 [DATMMP](ERROR): Waiting for previous to be ack'd 2023-03-31T20:37:26.584Z,1680295046.584 [DATMMP](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_NAV_DATA 2023-03-31T20:37:26.836Z,1680295046.836 [DATMMP](INFO): *** SENDING_NAV_DATA *** 2023-03-31T20:37:26.836Z,1680295046.836 [DATMMP](DEBUG): In sendingNavData, set commsState_ = SENDING_TRANSMIT 2023-03-31T20:37:27.088Z,1680295047.088 [DATMMP](INFO): *** SENDING_TRANSMIT *** 2023-03-31T20:37:27.088Z,1680295047.088 [DATMMP](INFO): In sendingTransmit, dataTxMessage not ack'd 2023-03-31T20:37:27.088Z,1680295047.088 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:37:27.088Z,1680295047.088 [DATMMP](FAULT): Buffer send receipt timeout failure. 2023-03-31T20:37:27.088Z,1680295047.088 [DATMMP](DEBUG): In sendingTransmitVerify, timeout set commsState_ = SENDING_FILL_BUFFER 2023-03-31T20:37:27.340Z,1680295047.340 [DATMMP](INFO): *** SENDING_FILL_BUFFER *** 2023-03-31T20:37:27.340Z,1680295047.340 [DATMMP](ERROR): Waiting for previous to be ack'd 2023-03-31T20:37:27.340Z,1680295047.340 [DATMMP](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_NAV_DATA 2023-03-31T20:37:27.591Z,1680295047.591 [DATMMP](INFO): *** SENDING_NAV_DATA *** 2023-03-31T20:37:27.592Z,1680295047.592 [DATMMP](DEBUG): In sendingNavData, set commsState_ = SENDING_TRANSMIT 2023-03-31T20:37:27.844Z,1680295047.844 [DATMMP](INFO): *** SENDING_TRANSMIT *** 2023-03-31T20:37:27.844Z,1680295047.844 [DATMMP](INFO): In sendingTransmit, dataTxMessage not ack'd 2023-03-31T20:37:27.844Z,1680295047.844 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:37:27.844Z,1680295047.844 [DATMMP](FAULT): Buffer send receipt timeout failure. 2023-03-31T20:37:27.844Z,1680295047.844 [DATMMP](DEBUG): In sendingTransmitVerify, timeout set commsState_ = SENDING_FILL_BUFFER 2023-03-31T20:37:28.095Z,1680295048.095 [DATMMP](INFO): *** SENDING_FILL_BUFFER *** 2023-03-31T20:37:28.096Z,1680295048.096 [DATMMP](ERROR): Waiting for previous to be ack'd 2023-03-31T20:37:28.096Z,1680295048.096 [DATMMP](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_NAV_DATA 2023-03-31T20:37:28.348Z,1680295048.348 [DATMMP](INFO): *** SENDING_NAV_DATA *** 2023-03-31T20:37:28.348Z,1680295048.348 [DATMMP](DEBUG): In sendingNavData, set commsState_ = SENDING_TRANSMIT 2023-03-31T20:37:28.600Z,1680295048.600 [DATMMP](INFO): *** SENDING_TRANSMIT *** 2023-03-31T20:37:28.600Z,1680295048.600 [DATMMP](INFO): In sendingTransmit, dataTxMessage not ack'd 2023-03-31T20:37:28.600Z,1680295048.600 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:37:28.600Z,1680295048.600 [DATMMP](FAULT): Buffer send receipt timeout failure. 2023-03-31T20:37:28.600Z,1680295048.600 [DATMMP](DEBUG): In sendingTransmitVerify, timeout set commsState_ = SENDING_FILL_BUFFER 2023-03-31T20:37:28.852Z,1680295048.852 [DATMMP](INFO): *** SENDING_FILL_BUFFER *** 2023-03-31T20:37:28.852Z,1680295048.852 [DATMMP](ERROR): Waiting for previous to be ack'd 2023-03-31T20:37:28.852Z,1680295048.852 [DATMMP](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_NAV_DATA 2023-03-31T20:37:29.103Z,1680295049.103 [DATMMP](INFO): *** SENDING_NAV_DATA *** 2023-03-31T20:37:29.104Z,1680295049.104 [DATMMP](DEBUG): In sendingNavData, set commsState_ = SENDING_TRANSMIT 2023-03-31T20:37:29.355Z,1680295049.355 [DATMMP](INFO): *** SENDING_TRANSMIT *** 2023-03-31T20:37:29.356Z,1680295049.356 [DATMMP](INFO): In sendingTransmit, dataTxMessage not ack'd 2023-03-31T20:37:29.356Z,1680295049.356 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:37:29.356Z,1680295049.356 [DATMMP](FAULT): Buffer send receipt timeout failure. 2023-03-31T20:37:29.356Z,1680295049.356 [DATMMP](DEBUG): In sendingTransmitVerify, timeout set commsState_ = SENDING_FILL_BUFFER 2023-03-31T20:37:29.608Z,1680295049.608 [DATMMP](INFO): *** SENDING_FILL_BUFFER *** 2023-03-31T20:37:29.608Z,1680295049.608 [DATMMP](ERROR): Waiting for previous to be ack'd 2023-03-31T20:37:29.608Z,1680295049.608 [DATMMP](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_NAV_DATA 2023-03-31T20:37:29.860Z,1680295049.860 [DATMMP](INFO): *** SENDING_NAV_DATA *** 2023-03-31T20:37:29.860Z,1680295049.860 [DATMMP](DEBUG): In sendingNavData, set commsState_ = SENDING_TRANSMIT 2023-03-31T20:37:30.112Z,1680295050.112 [DATMMP](INFO): *** SENDING_TRANSMIT *** 2023-03-31T20:37:30.112Z,1680295050.112 [DATMMP](INFO): In sendingTransmit, dataTxMessage not ack'd 2023-03-31T20:37:30.112Z,1680295050.112 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:37:30.112Z,1680295050.112 [DATMMP](FAULT): Buffer send receipt timeout failure. 2023-03-31T20:37:30.112Z,1680295050.112 [DATMMP](DEBUG): In sendingTransmitVerify, timeout set commsState_ = SENDING_FILL_BUFFER 2023-03-31T20:37:30.364Z,1680295050.364 [DATMMP](INFO): *** SENDING_FILL_BUFFER *** 2023-03-31T20:37:30.364Z,1680295050.364 [DATMMP](ERROR): Waiting for previous to be ack'd 2023-03-31T20:37:30.364Z,1680295050.364 [DATMMP](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_NAV_DATA 2023-03-31T20:37:30.872Z,1680295050.872 [DATMMP](INFO): *** SENDING_NAV_DATA *** 2023-03-31T20:37:30.872Z,1680295050.872 [DATMMP](DEBUG): In sendingNavData, set commsState_ = SENDING_TRANSMIT 2023-03-31T20:37:31.123Z,1680295051.123 [DATMMP](INFO): *** SENDING_TRANSMIT *** 2023-03-31T20:37:31.124Z,1680295051.124 [DATMMP](INFO): In sendingTransmit, dataTxMessage not ack'd 2023-03-31T20:37:31.124Z,1680295051.124 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:37:31.124Z,1680295051.124 [DATMMP](FAULT): Buffer send receipt timeout failure. 2023-03-31T20:37:31.124Z,1680295051.124 [DATMMP](DEBUG): In sendingTransmitVerify, timeout set commsState_ = SENDING_FILL_BUFFER 2023-03-31T20:37:31.376Z,1680295051.376 [DATMMP](INFO): *** SENDING_FILL_BUFFER *** 2023-03-31T20:37:31.376Z,1680295051.376 [DATMMP](ERROR): Waiting for previous to be ack'd 2023-03-31T20:37:31.376Z,1680295051.376 [DATMMP](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_NAV_DATA 2023-03-31T20:37:31.627Z,1680295051.627 [DATMMP](INFO): *** SENDING_NAV_DATA *** 2023-03-31T20:37:31.628Z,1680295051.628 [DATMMP](DEBUG): In sendingNavData, set commsState_ = SENDING_TRANSMIT 2023-03-31T20:37:31.880Z,1680295051.880 [DATMMP](INFO): *** SENDING_TRANSMIT *** 2023-03-31T20:37:31.880Z,1680295051.880 [DATMMP](INFO): In sendingTransmit, dataTxMessage not ack'd 2023-03-31T20:37:31.880Z,1680295051.880 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:37:31.880Z,1680295051.880 [DATMMP](FAULT): Buffer send receipt timeout failure. 2023-03-31T20:37:31.880Z,1680295051.880 [DATMMP](DEBUG): In sendingTransmitVerify, timeout set commsState_ = SENDING_FILL_BUFFER 2023-03-31T20:37:32.132Z,1680295052.132 [DATMMP](INFO): *** SENDING_FILL_BUFFER *** 2023-03-31T20:37:32.132Z,1680295052.132 [DATMMP](ERROR): Waiting for previous to be ack'd 2023-03-31T20:37:32.132Z,1680295052.132 [DATMMP](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_NAV_DATA 2023-03-31T20:37:32.384Z,1680295052.384 [DATMMP](INFO): *** SENDING_NAV_DATA *** 2023-03-31T20:37:32.384Z,1680295052.384 [DATMMP](DEBUG): In sendingNavData, set commsState_ = SENDING_TRANSMIT 2023-03-31T20:37:32.609Z,1680295052.609 [CommandExec](IMPORTANT): got command maintain clear 2023-03-31T20:37:32.635Z,1680295052.635 [DATMMP](INFO): *** SENDING_TRANSMIT *** 2023-03-31T20:37:32.636Z,1680295052.636 [DATMMP](INFO): In sendingTransmit, dataTxMessage not ack'd 2023-03-31T20:37:32.636Z,1680295052.636 [DATMMP](INFO): *** SENDING_TRANSMIT_VERIFY *** 2023-03-31T20:37:32.636Z,1680295052.636 [DATMMP](FAULT): Buffer send receipt timeout failure. 2023-03-31T20:37:32.636Z,1680295052.636 [DATMMP](DEBUG): In sendingTransmitVerify, timeout set commsState_ = SENDING_FILL_BUFFER 2023-03-31T20:37:32.697Z,1680295052.697 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DVL_micro,NAL9602,Power24vConverter,ESPComponent,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,VerticalHomogeneityIndexCalculator,YawRateCalculator,ElevatorOffsetCalculator,StratificationFrontDetector,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2023-03-31T20:37:32.887Z,1680295052.887 [DATMMP](INFO): *** SENDING_FILL_BUFFER *** 2023-03-31T20:37:32.888Z,1680295052.888 [DATMMP](ERROR): Waiting for previous to be ack'd 2023-03-31T20:37:32.888Z,1680295052.888 [DATMMP](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_NAV_DATA