2024-01-05T22:34:08.554Z,1704494048.554 [Supervisor](DEBUG): Initializing supervisor.
2024-01-05T22:34:08.558Z,1704494048.558 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2024-01-05T22:34:08.559Z,1704494048.559 [SyncHandler](INFO): Protected caller Thread ID is 839
2024-01-05T22:34:08.559Z,1704494048.559 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2024-01-05T22:34:08.560Z,1704494048.560 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2024-01-05T22:34:08.561Z,1704494048.561 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 840
2024-01-05T22:34:08.565Z,1704494048.565 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2024-01-05T22:34:08.582Z,1704494048.582 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2024-01-05T22:34:08.583Z,1704494048.583 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2024-01-05T22:34:08.583Z,1704494048.583 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 841
2024-01-05T22:34:08.588Z,1704494048.588 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2024-01-05T22:34:08.589Z,1704494048.589 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2024-01-05T22:34:08.589Z,1704494048.589 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 842
2024-01-05T22:34:08.591Z,1704494048.591 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2024-01-05T22:34:08.592Z,1704494048.592 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2024-01-05T22:34:08.592Z,1704494048.592 [logger ThreadHandler](INFO): Protected caller Thread ID is 843
2024-01-05T22:34:08.596Z,1704494048.596 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2024-01-05T22:34:08.596Z,1704494048.596 [Supervisor](INFO): Looking for Config files in directory: Config/
2024-01-05T22:34:08.601Z,1704494048.601 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2024-01-05T22:34:08.697Z,1704494048.697 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2024-01-05T22:34:08.699Z,1704494048.699 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2024-01-05T22:34:09.427Z,1704494049.427 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2024-01-05T22:34:09.429Z,1704494049.429 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2024-01-05T22:34:09.658Z,1704494049.658 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2024-01-05T22:34:09.660Z,1704494049.660 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2024-01-05T22:34:09.740Z,1704494049.740 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2024-01-05T22:34:09.873Z,1704494049.873 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2024-01-05T22:34:09.874Z,1704494049.874 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2024-01-05T22:34:09.955Z,1704494049.955 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2024-01-05T22:34:10.063Z,1704494050.063 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2024-01-05T22:34:10.065Z,1704494050.065 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2024-01-05T22:34:10.490Z,1704494050.490 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2024-01-05T22:34:10.491Z,1704494050.491 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2024-01-05T22:34:10.986Z,1704494050.986 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2024-01-05T22:34:10.988Z,1704494050.988 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2024-01-05T22:34:11.207Z,1704494051.207 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2024-01-05T22:34:11.208Z,1704494051.208 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2024-01-05T22:34:11.398Z,1704494051.398 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2024-01-05T22:34:11.398Z,1704494051.398 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2024-01-05T22:34:11.965Z,1704494051.965 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2024-01-05T22:34:12.282Z,1704494052.282 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2024-01-05T22:34:12.685Z,1704494052.685 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2024-01-05T22:34:12.686Z,1704494052.686 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2024-01-05T22:34:12.910Z,1704494052.910 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2024-01-05T22:34:12.912Z,1704494052.912 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2024-01-05T22:34:13.289Z,1704494053.289 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2024-01-05T22:34:13.290Z,1704494053.290 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2024-01-05T22:34:13.645Z,1704494053.645 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2024-01-05T22:34:13.647Z,1704494053.647 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-pontus/
2024-01-05T22:34:13.649Z,1704494053.649 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/secure.cfg
2024-01-05T22:34:13.734Z,1704494053.734 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Sensor.cfg
2024-01-05T22:34:13.901Z,1704494053.901 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Servo.cfg
2024-01-05T22:34:14.004Z,1704494054.004 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Simulator.cfg
2024-01-05T22:34:14.091Z,1704494054.091 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/logger.cfg
2024-01-05T22:34:14.187Z,1704494054.187 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/vehicle.cfg
2024-01-05T22:34:14.303Z,1704494054.303 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Battery.cfg
2024-01-05T22:34:14.570Z,1704494054.570 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2024-01-05T22:34:14.571Z,1704494054.571 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Navigation.cfg
2024-01-05T22:34:14.665Z,1704494054.665 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/BIT.cfg
2024-01-05T22:34:14.765Z,1704494054.765 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Science.cfg
2024-01-05T22:34:14.905Z,1704494054.905 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Control.cfg
2024-01-05T22:34:15.005Z,1704494055.005 [Supervisor](FAULT): Ignoring configuration overrides from Data/persisted.cfg
2024-01-05T22:34:15.011Z,1704494055.011 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2024-01-05T22:34:15.160Z,1704494055.160 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2024-01-05T22:34:15.160Z,1704494055.160 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2024-01-05T22:34:15.233Z,1704494055.233 [VerticalControl](DEBUG): Construct VerticalControl.
2024-01-05T22:34:15.294Z,1704494055.294 [VerticalControl] Loaded
2024-01-05T22:34:15.294Z,1704494055.294 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2024-01-05T22:34:15.297Z,1704494055.297 [HorizontalControl](DEBUG): Construct HorizontalControl.
2024-01-05T22:34:15.339Z,1704494055.339 [HorizontalControl] Loaded
2024-01-05T22:34:15.339Z,1704494055.339 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2024-01-05T22:34:15.341Z,1704494055.341 [SpeedControl](DEBUG): Construct SpeedControl.
2024-01-05T22:34:15.345Z,1704494055.345 [SpeedControl] Loaded
2024-01-05T22:34:15.345Z,1704494055.345 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2024-01-05T22:34:15.348Z,1704494055.348 [LoopControl](DEBUG): Construct LoopControl.
2024-01-05T22:34:15.348Z,1704494055.348 [LoopControl] Loaded
2024-01-05T22:34:15.348Z,1704494055.348 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2024-01-05T22:34:15.349Z,1704494055.349 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2024-01-05T22:34:15.349Z,1704494055.349 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2024-01-05T22:34:15.420Z,1704494055.420 [DepthRateCalculator] Loaded
2024-01-05T22:34:15.421Z,1704494055.421 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2024-01-05T22:34:15.426Z,1704494055.426 [PitchRateCalculator] Loaded
2024-01-05T22:34:15.426Z,1704494055.426 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2024-01-05T22:34:15.436Z,1704494055.436 [SpeedCalculator] Loaded
2024-01-05T22:34:15.437Z,1704494055.437 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2024-01-05T22:34:15.441Z,1704494055.441 [YawRateCalculator] Loaded
2024-01-05T22:34:15.441Z,1704494055.441 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2024-01-05T22:34:15.459Z,1704494055.459 [ElevatorOffsetCalculator] Loaded
2024-01-05T22:34:15.460Z,1704494055.460 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2024-01-05T22:34:15.460Z,1704494055.460 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2024-01-05T22:34:15.461Z,1704494055.461 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2024-01-05T22:34:15.504Z,1704494055.504 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2024-01-05T22:34:15.505Z,1704494055.505 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2024-01-05T22:34:15.607Z,1704494055.607 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2024-01-05T22:34:15.607Z,1704494055.607 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2024-01-05T22:34:16.020Z,1704494056.020 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2024-01-05T22:34:16.020Z,1704494056.020 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2024-01-05T22:34:16.208Z,1704494056.208 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2024-01-05T22:34:16.209Z,1704494056.209 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2024-01-05T22:34:17.030Z,1704494057.030 [AHRS_M2] Loaded
2024-01-05T22:34:17.030Z,1704494057.030 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2024-01-05T22:34:17.281Z,1704494057.281 [BackseatComponent] Loaded
2024-01-05T22:34:17.281Z,1704494057.281 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread.
2024-01-05T22:34:17.282Z,1704494057.282 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 409C04E0
2024-01-05T22:34:17.283Z,1704494057.283 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 926
2024-01-05T22:34:17.285Z,1704494057.285 [LcmUniversalReporter] Loaded
2024-01-05T22:34:17.286Z,1704494057.286 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread.
2024-01-05T22:34:18.573Z,1704494058.573 [BPC1] Loaded
2024-01-05T22:34:18.574Z,1704494058.574 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2024-01-05T22:34:18.657Z,1704494058.657 [DATMMP] Loaded
2024-01-05T22:34:18.658Z,1704494058.658 [ComponentRegistry](DEBUG): Component "DATMMP" handled in its own thread.
2024-01-05T22:34:18.659Z,1704494058.659 [DATMMP ThreadHandler](DEBUG): Created PCaller Thread at 409F14E0
2024-01-05T22:34:18.659Z,1704494058.659 [DATMMP ThreadHandler](INFO): Protected caller Thread ID is 927
2024-01-05T22:34:18.798Z,1704494058.798 [DataOverHttps] Loaded
2024-01-05T22:34:18.798Z,1704494058.798 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2024-01-05T22:34:18.799Z,1704494058.799 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 40A214E0
2024-01-05T22:34:18.800Z,1704494058.800 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 928
2024-01-05T22:34:18.821Z,1704494058.821 [Depth_Keller] Loaded
2024-01-05T22:34:18.821Z,1704494058.821 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2024-01-05T22:34:18.826Z,1704494058.826 [DropWeight] Loaded
2024-01-05T22:34:18.826Z,1704494058.826 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2024-01-05T22:34:18.888Z,1704494058.888 [NAL9602] Loaded
2024-01-05T22:34:18.889Z,1704494058.889 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2024-01-05T22:34:18.919Z,1704494058.919 [Onboard] Loaded
2024-01-05T22:34:18.919Z,1704494058.919 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2024-01-05T22:34:18.920Z,1704494058.920 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 40A514E0
2024-01-05T22:34:18.920Z,1704494058.920 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 929
2024-01-05T22:34:18.926Z,1704494058.926 [PowerOnly](INFO): Adding load control power supply at /dev/loadB1
2024-01-05T22:34:18.938Z,1704494058.938 [PowerOnly] Loaded
2024-01-05T22:34:18.938Z,1704494058.938 [ComponentRegistry](DEBUG): SyncComponent "PowerOnly" handled in the control thread.
2024-01-05T22:34:18.950Z,1704494058.950 [Power24vConverter] Loaded
2024-01-05T22:34:18.950Z,1704494058.950 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2024-01-05T22:34:18.963Z,1704494058.963 [Radio_Surface] Loaded
2024-01-05T22:34:18.963Z,1704494058.963 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2024-01-05T22:34:18.965Z,1704494058.965 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 40A814E0
2024-01-05T22:34:18.965Z,1704494058.965 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 930
2024-01-05T22:34:19.009Z,1704494059.009 [RDI_Pathfinder] Loaded
2024-01-05T22:34:19.010Z,1704494059.010 [ComponentRegistry](DEBUG): SyncComponent "RDI_Pathfinder" handled in the control thread.
2024-01-05T22:34:19.011Z,1704494059.011 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2024-01-05T22:34:19.011Z,1704494059.011 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2024-01-05T22:34:19.151Z,1704494059.151 [DeadReckonUsingMultipleVelocitySources] Loaded
2024-01-05T22:34:19.151Z,1704494059.151 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2024-01-05T22:34:19.165Z,1704494059.165 [NavChart] Loaded
2024-01-05T22:34:19.165Z,1704494059.165 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2024-01-05T22:34:19.171Z,1704494059.171 [UniversalFixResidualReporter] Loaded
2024-01-05T22:34:19.172Z,1704494059.172 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2024-01-05T22:34:19.172Z,1704494059.172 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2024-01-05T22:34:19.174Z,1704494059.174 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2024-01-05T22:34:19.350Z,1704494059.350 [SBIT](DEBUG): Construct Startup Built In Test.
2024-01-05T22:34:19.359Z,1704494059.359 [SBIT] Loaded
2024-01-05T22:34:19.360Z,1704494059.360 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2024-01-05T22:34:19.363Z,1704494059.363 [IBIT](DEBUG): Construct Initiated Built In Test.
2024-01-05T22:34:19.376Z,1704494059.376 [IBIT] Loaded
2024-01-05T22:34:19.376Z,1704494059.376 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2024-01-05T22:34:19.382Z,1704494059.382 [CBIT](DEBUG): Construct Continuous Built In Test.
2024-01-05T22:34:19.488Z,1704494059.488 [CBIT] Loaded
2024-01-05T22:34:19.488Z,1704494059.488 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2024-01-05T22:34:19.489Z,1704494059.489 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2024-01-05T22:34:19.489Z,1704494059.489 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2024-01-05T22:34:19.654Z,1704494059.654 [BuoyancyServo] Loaded
2024-01-05T22:34:19.654Z,1704494059.654 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2024-01-05T22:34:19.675Z,1704494059.675 [ElevatorServo] Loaded
2024-01-05T22:34:19.675Z,1704494059.675 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2024-01-05T22:34:19.695Z,1704494059.695 [MassServo] Loaded
2024-01-05T22:34:19.695Z,1704494059.695 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2024-01-05T22:34:19.714Z,1704494059.714 [RudderServo] Loaded
2024-01-05T22:34:19.714Z,1704494059.714 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2024-01-05T22:34:19.732Z,1704494059.732 [ThrusterServo] Loaded
2024-01-05T22:34:19.732Z,1704494059.732 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2024-01-05T22:34:19.732Z,1704494059.732 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2024-01-05T22:34:19.733Z,1704494059.733 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2024-01-05T22:34:19.749Z,1704494059.749 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2024-01-05T22:34:19.750Z,1704494059.750 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2024-01-05T22:34:19.975Z,1704494059.975 [CTD_Seabird] Loaded
2024-01-05T22:34:19.975Z,1704494059.975 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2024-01-05T22:34:19.977Z,1704494059.977 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40BCC4E0
2024-01-05T22:34:19.977Z,1704494059.977 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 931
2024-01-05T22:34:19.998Z,1704494059.998 [PAR_Licor] Loaded
2024-01-05T22:34:19.998Z,1704494059.998 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2024-01-05T22:34:20.040Z,1704494060.040 [WetLabsBB2FL] Loaded
2024-01-05T22:34:20.040Z,1704494060.040 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2024-01-05T22:34:20.041Z,1704494060.041 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40BFC4E0
2024-01-05T22:34:20.042Z,1704494060.042 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 932
2024-01-05T22:34:20.062Z,1704494060.062 [WetLabsUBAT] Loaded
2024-01-05T22:34:20.062Z,1704494060.062 [ComponentRegistry](DEBUG): Component "WetLabsUBAT" handled in its own thread.
2024-01-05T22:34:20.063Z,1704494060.063 [WetLabsUBAT ThreadHandler](DEBUG): Created PCaller Thread at 40C2C4E0
2024-01-05T22:34:20.063Z,1704494060.063 [WetLabsUBAT ThreadHandler](INFO): Protected caller Thread ID is 933
2024-01-05T22:34:20.064Z,1704494060.064 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2024-01-05T22:34:20.070Z,1704494060.070 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2024-01-05T22:34:20.073Z,1704494060.073 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2024-01-05T22:34:20.084Z,1704494060.084 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2024-01-05T22:34:20.085Z,1704494060.085 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C5C4E0
2024-01-05T22:34:20.085Z,1704494060.085 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 934
2024-01-05T22:34:20.089Z,1704494060.089 [Supervisor](INFO): Main Thread ID is 830
2024-01-05T22:34:20.090Z,1704494060.090 [Supervisor](DEBUG): Running supervisor.
2024-01-05T22:34:20.090Z,1704494060.090 [CommandExec ThreadHandler](INFO): Handler Thread ID is 935
2024-01-05T22:34:20.091Z,1704494060.091 [CommandExec](INFO): Initializing the command executive.
2024-01-05T22:34:20.092Z,1704494060.092 [CommandLine ThreadHandler](INFO): Handler Thread ID is 936
2024-01-05T22:34:20.094Z,1704494060.094 [controlThread ThreadHandler](INFO): Handler Thread ID is 937
2024-01-05T22:34:20.095Z,1704494060.095 [controlThread](DEBUG): Initializing ControlThread
2024-01-05T22:34:20.095Z,1704494060.095 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2024-01-05T22:34:20.097Z,1704494060.097 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2024-01-05T22:34:20.098Z,1704494060.098 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2024-01-05T22:34:20.099Z,1704494060.099 [LoopControl](DEBUG): Initialize LoopControlComponent.
2024-01-05T22:34:20.099Z,1704494060.099 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2024-01-05T22:34:20.099Z,1704494060.099 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2024-01-05T22:34:20.100Z,1704494060.100 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2024-01-05T22:34:20.100Z,1704494060.100 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2024-01-05T22:34:20.100Z,1704494060.100 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2024-01-05T22:34:20.106Z,1704494060.106 [NavChart](DEBUG): Initialize NavChart Navigation.
2024-01-05T22:34:20.107Z,1704494060.107 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2024-01-05T22:34:20.107Z,1704494060.107 [SBIT](INFO): Initialize SBIT Component.
2024-01-05T22:34:20.108Z,1704494060.108 [SBIT](IMPORTANT): git: 2023-12-22_A-90-g81485f242
2024-01-05T22:34:20.108Z,1704494060.108 [SBIT](INFO): git hash: 81485f24231abbda79e1465b5e187a00d34cbcf8
2024-01-05T22:34:20.108Z,1704494060.108 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2024-01-05T22:34:20.109Z,1704494060.109 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #1 PREEMPT Thu Feb 21 11:17:40 PST 2019
Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021
2024-01-05T22:34:20.110Z,1704494060.110 [SBIT](INFO): Beginning SBIT in 46.000000 seconds.
2024-01-05T22:34:20.111Z,1704494060.111 [IBIT](INFO): Initialize IBIT Component.
2024-01-05T22:34:20.112Z,1704494060.112 [CBIT](DEBUG): Initialize CBIT Component.
2024-01-05T22:34:20.113Z,1704494060.113 [logger ThreadHandler](INFO): Handler Thread ID is 938
2024-01-05T22:34:20.124Z,1704494060.124 [CBIT](DEBUG): Initialized mux pins.
2024-01-05T22:34:20.124Z,1704494060.124 [CBIT](FAULT): LAST RESTART WAS UNINTENTIONAL.
2024-01-05T22:34:20.124Z,1704494060.124 [CBIT](DEBUG): Initializing the watchdog timer.
2024-01-05T22:34:20.132Z,1704494060.132 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 939
2024-01-05T22:34:20.144Z,1704494060.144 [DATMMP ThreadHandler](INFO): Handler Thread ID is 940
2024-01-05T22:34:20.145Z,1704494060.145 [DATMMP](INFO): Start
2024-01-05T22:34:20.145Z,1704494060.145 [DATMMP](INFO): Powering up
2024-01-05T22:34:20.145Z,1704494060.145 [DATMMP](DEBUG): Initializing DATMMP.
2024-01-05T22:34:20.148Z,1704494060.148 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2024-01-05T22:34:20.148Z,1704494060.148 [CBIT](DEBUG): Initializing heartbeat.
2024-01-05T22:34:20.150Z,1704494060.150 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 942
2024-01-05T22:34:20.152Z,1704494060.152 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2024-01-05T22:34:20.161Z,1704494060.161 [Onboard ThreadHandler](INFO): Handler Thread ID is 943
2024-01-05T22:34:20.190Z,1704494060.190 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 944
2024-01-05T22:34:20.205Z,1704494060.205 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 945
2024-01-05T22:34:20.205Z,1704494060.205 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2024-01-05T22:34:20.209Z,1704494060.209 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 947
2024-01-05T22:34:20.212Z,1704494060.212 [WetLabsBB2FL](INFO): Powering up
2024-01-05T22:34:20.214Z,1704494060.214 [WetLabsUBAT ThreadHandler](INFO): Handler Thread ID is 949
2024-01-05T22:34:20.216Z,1704494060.216 [WetLabsUBAT](INFO): Powering up
2024-01-05T22:34:20.217Z,1704494060.217 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 951
2024-01-05T22:34:20.220Z,1704494060.220 [CBIT](DEBUG): Deactivating GF circuits.
2024-01-05T22:34:20.220Z,1704494060.220 [CBIT](DEBUG): Deactivating emergency mode.
2024-01-05T22:34:20.227Z,1704494060.227 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2024-01-05T22:34:20.227Z,1704494060.227 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2024-01-05T22:34:20.227Z,1704494060.227 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2024-01-05T22:34:20.227Z,1704494060.227 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2024-01-05T22:34:20.228Z,1704494060.228 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2024-01-05T22:34:20.228Z,1704494060.228 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2024-01-05T22:34:20.228Z,1704494060.228 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2024-01-05T22:34:20.228Z,1704494060.228 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2024-01-05T22:34:20.260Z,1704494060.260 [CBIT](DEBUG): Backplane powered.
2024-01-05T22:34:20.265Z,1704494060.265 [MissionManager](INFO): Loading Mission from file: Missions/Startup.xml
2024-01-05T22:34:20.301Z,1704494060.301 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2024-01-05T22:34:20.340Z,1704494060.340 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns="Tethys"
       xmlns:Control="Tethys/Control"
       xmlns:Guidance="Tethys/Guidance" 
       xmlns:Units="Tethys/Units"
       xmlns:Universal="Tethys/Universal"
       xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
       xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                           Tethys/Control http://okeanids.mbari.org/tethys/Xml/Control.xsd
                           Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                           Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                           Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
       Id="Startup">

    <Guidance:GoToSurface>
        <Progression/>
    </Guidance:GoToSurface>

    <Aggregate Id="StartupSatComms">

        <Sequence/>

        <ReadDatum>
            <Timeout Duration="P1M" />
            <Universal:latitude_fix/>
        </ReadDatum>

        <ReadDatum>
            <Timeout Duration="P1M" />
            <Universal:platform_communications/>
        </ReadDatum>

    </Aggregate>

</Mission>


2024-01-05T22:34:20.341Z,1704494060.341 [MissionManager](INFO): Loading Mission from file: Missions/Default.xml
2024-01-05T22:34:20.396Z,1704494060.396 [DATMMP](INFO): Starting
2024-01-05T22:34:20.424Z,1704494060.424 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2024-01-05T22:34:20.426Z,1704494060.426 [Default:A.Wait](DEBUG): Construct Wait.
2024-01-05T22:34:20.428Z,1704494060.428 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2024-01-05T22:34:20.455Z,1704494060.455 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2024-01-05T22:34:20.472Z,1704494060.472 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2024-01-05T22:34:20.494Z,1704494060.494 [Default:E.Execute](DEBUG): Construct Execute.
2024-01-05T22:34:20.513Z,1704494060.513 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
         xmlns="Tethys"
         xmlns:Units="Tethys/Units"
         xmlns:Guidance="Tethys/Guidance"
         xmlns:Universal="Tethys/Universal"
         xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                             Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                             Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                             Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
         Id="Default">

    <DefineArg Name="ElapsedSinceDefaultStarted"><Units:minute/><Value>0</Value></DefineArg>

    <Guidance:Wait>
        <Description>
            Wait a moment to see if the scheduler starts a new mission before
            starting to actually run Default.
        </Description>
        <Sequence/>
        <Setting><Guidance:Wait.duration/><Units:second/><Value>13</Value></Setting>
    </Guidance:Wait>

    <Guidance:GoToSurface>
        <Progression/>
    </Guidance:GoToSurface>

    <Aggregate Id="CheckIn">

        <Sequence Repeat="288"/>

        <ReadDatum Id="Read_GPS">
            <Timeout Duration="P5M"/>
            <Universal:time_fix/>
        </ReadDatum>

        <ReadDatum Id="Read_Iridium">
            <Timeout Duration="P4H">
                <Guidance:Execute>
                    <Sequence/>
                    <Setting><Guidance:Execute.command/><String>Burn on</String></Setting>
                </Guidance:Execute>
                <Syslog Severity="Critical">Dropped weight due to communications timeout.</Syslog>
            </Timeout>
            <Universal:platform_communications/>
        </ReadDatum>

        <Guidance:Wait>
            <Sequence/>
            <Setting><Guidance:Wait.duration/><Units:minute/><Value>5</Value></Setting>
        </Guidance:Wait>

        <Assign><Sequence/><Arg Name="ElapsedSinceDefaultStarted"/><Elapsed><Universal:mission_started/></Elapsed></Assign>

        <Syslog Severity="Important">Default mission has been running for <Arg Name="ElapsedSinceDefaultStarted"/><Units:minute/></Syslog>

    </Aggregate>

    <Syslog Severity="Important">Restarting logs and Default mission.</Syslog>

    <Guidance:Execute>
        <Sequence/>
        <Setting><Guidance:Execute.command/><String>restart logs</String></Setting>
    </Guidance:Execute>

</Mission>


2024-01-05T22:34:20.518Z,1704494060.518 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,NAL9602,PowerOnly,Power24vConverter,RDI_Pathfinder,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter,
2024-01-05T22:34:20.543Z,1704494060.543 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2024-01-05T22:34:20.592Z,1704494060.592 [Radio_Surface](INFO): Powering up
2024-01-05T22:34:20.648Z,1704494060.648 [DATMMP](INFO): Starting
2024-01-05T22:34:20.714Z,1704494060.714 [Depth_Keller](ERROR): Pressure or depth reading out of range: -1.000394 decibar, -0.993016 m
2024-01-05T22:34:20.716Z,1704494060.716 [PowerOnly](INFO): Powering up loadControl
2024-01-05T22:34:20.736Z,1704494060.736 [Power24vConverter](INFO): Powering up.
2024-01-05T22:34:20.737Z,1704494060.737 [RDI_Pathfinder](IMPORTANT): Expecting PD13 message format
2024-01-05T22:34:20.758Z,1704494060.758 [DepthRateCalculator](ERROR): Depth measurement is not active
2024-01-05T22:34:20.778Z,1704494060.778 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2024-01-05T22:34:20.785Z,1704494060.785 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2024-01-05T22:34:20.786Z,1704494060.786 [ElevatorServo](DEBUG): Initializing EZServoServo.
2024-01-05T22:34:20.792Z,1704494060.792 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2024-01-05T22:34:20.793Z,1704494060.793 [MassServo](DEBUG): Initializing EZServoServo.
2024-01-05T22:34:20.800Z,1704494060.800 [MassServo](DEBUG): Initializing MassServo.
2024-01-05T22:34:20.801Z,1704494060.801 [RudderServo](DEBUG): Initializing EZServoServo.
2024-01-05T22:34:20.808Z,1704494060.808 [RudderServo](DEBUG): Initializing RudderServo.
2024-01-05T22:34:20.809Z,1704494060.809 [ThrusterServo](DEBUG): Initializing EZServoServo.
2024-01-05T22:34:20.817Z,1704494060.817 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2024-01-05T22:34:20.900Z,1704494060.900 [DATMMP](INFO): Starting
2024-01-05T22:34:20.973Z,1704494060.973 [DropWeight](CRITICAL): DROP WEIGHT MISSING.

2024-01-05T22:34:20.973Z,1704494060.973 [DropWeight] Hardware Fault, FailCount= 1
2024-01-05T22:34:20.973Z,1704494060.973 [DropWeight](ERROR): Hardware Fault
2024-01-05T22:34:20.999Z,1704494060.999 [CommandExec](FAULT): Scheduling is paused
2024-01-05T22:34:20.999Z,1704494060.999 [CBIT](INFO): Critical error at 20240105T223420
2024-01-05T22:34:20.999Z,1704494060.999 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2024-01-05T22:34:21.010Z,1704494061.010 [CBIT](ERROR): Hardware Fault in component: DropWeight
2024-01-05T22:34:21.011Z,1704494061.011 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2024-01-05T22:34:21.152Z,1704494061.152 [DATMMP](INFO): Starting
2024-01-05T22:34:21.358Z,1704494061.358 [CBIT](INFO): Critical error at 20240105T223421
2024-01-05T22:34:21.404Z,1704494061.404 [DATMMP](INFO): Starting
2024-01-05T22:34:21.656Z,1704494061.656 [DATMMP](INFO): Starting
2024-01-05T22:34:21.908Z,1704494061.908 [DATMMP](INFO): Starting
2024-01-05T22:34:22.160Z,1704494062.160 [DATMMP](INFO): Starting
2024-01-05T22:34:22.412Z,1704494062.412 [DATMMP](INFO): Starting
2024-01-05T22:34:22.664Z,1704494062.664 [DATMMP](INFO): Starting
2024-01-05T22:34:22.824Z,1704494062.824 [WetLabsBB2FL](INFO): Powering down
2024-01-05T22:34:22.916Z,1704494062.916 [DATMMP](INFO): Starting
2024-01-05T22:34:23.168Z,1704494063.168 [DATMMP](INFO): Starting
2024-01-05T22:34:23.421Z,1704494063.421 [DATMMP](INFO): Starting
2024-01-05T22:34:23.672Z,1704494063.672 [DATMMP](INFO): Starting
2024-01-05T22:34:23.924Z,1704494063.924 [DATMMP](INFO): Starting
2024-01-05T22:34:24.177Z,1704494064.177 [DATMMP](INFO): Starting
2024-01-05T22:34:24.428Z,1704494064.428 [DATMMP](INFO): Starting
2024-01-05T22:34:24.680Z,1704494064.680 [DATMMP](INFO): Starting
2024-01-05T22:34:24.932Z,1704494064.932 [DATMMP](INFO): Starting
2024-01-05T22:34:25.184Z,1704494065.184 [DATMMP](INFO): Starting
2024-01-05T22:34:25.436Z,1704494065.436 [DATMMP](INFO): Starting
2024-01-05T22:34:25.688Z,1704494065.688 [DATMMP](INFO): Starting
2024-01-05T22:34:25.940Z,1704494065.940 [DATMMP](INFO): Starting
2024-01-05T22:34:26.193Z,1704494066.193 [DATMMP](INFO): Starting
2024-01-05T22:34:26.444Z,1704494066.444 [DATMMP](INFO): Starting
2024-01-05T22:34:26.696Z,1704494066.696 [DATMMP](INFO): Starting
2024-01-05T22:34:26.948Z,1704494066.948 [DATMMP](INFO): Starting
2024-01-05T22:34:27.200Z,1704494067.200 [DATMMP](INFO): Starting
2024-01-05T22:34:27.452Z,1704494067.452 [DATMMP](INFO): Starting
2024-01-05T22:34:27.704Z,1704494067.704 [DATMMP](INFO): Starting
2024-01-05T22:34:27.956Z,1704494067.956 [DATMMP](INFO): Starting
2024-01-05T22:34:28.210Z,1704494068.210 [DATMMP](INFO): Starting
2024-01-05T22:34:28.460Z,1704494068.460 [DATMMP](INFO): Starting
2024-01-05T22:34:28.713Z,1704494068.713 [DATMMP](INFO): Starting
2024-01-05T22:34:28.964Z,1704494068.964 [DATMMP](INFO): Starting
2024-01-05T22:34:29.216Z,1704494069.216 [DATMMP](INFO): Starting
2024-01-05T22:34:29.468Z,1704494069.468 [DATMMP](INFO): Starting
2024-01-05T22:34:29.540Z,1704494069.540 [WetLabsUBAT](INFO): Powering down
2024-01-05T22:34:29.720Z,1704494069.720 [DATMMP](INFO): Starting
2024-01-05T22:34:29.972Z,1704494069.972 [DATMMP](INFO): Starting
2024-01-05T22:34:30.224Z,1704494070.224 [DATMMP](INFO): Starting
2024-01-05T22:34:30.476Z,1704494070.476 [DATMMP](INFO): Starting
2024-01-05T22:34:30.728Z,1704494070.728 [DATMMP](INFO): Starting
2024-01-05T22:34:30.980Z,1704494070.980 [DATMMP](INFO): Starting
2024-01-05T22:34:31.232Z,1704494071.232 [DATMMP](INFO): Starting
2024-01-05T22:34:31.484Z,1704494071.484 [DATMMP](INFO): Starting
2024-01-05T22:34:31.736Z,1704494071.736 [DATMMP](INFO): Starting
2024-01-05T22:34:31.988Z,1704494071.988 [DATMMP](INFO): Starting
2024-01-05T22:34:32.240Z,1704494072.240 [DATMMP](INFO): Starting
2024-01-05T22:34:32.492Z,1704494072.492 [DATMMP](INFO): Starting
2024-01-05T22:34:32.493Z,1704494072.493 [DATMMP](INFO): DAT read: 

2024-01-05T22:34:32.494Z,1704494072.494 [DATMMP](INFO): DAT read: Teledyne Benthos DAT-900 Series

2024-01-05T22:34:32.744Z,1704494072.744 [DATMMP](INFO): Starting
2024-01-05T22:34:32.996Z,1704494072.996 [DATMMP](INFO): Starting
2024-01-05T22:34:33.248Z,1704494073.248 [DATMMP](INFO): Starting
2024-01-05T22:34:33.500Z,1704494073.500 [DATMMP](INFO): Starting
2024-01-05T22:34:33.752Z,1704494073.752 [DATMMP](INFO): Starting
2024-01-05T22:34:34.004Z,1704494074.004 [DATMMP](INFO): Starting
2024-01-05T22:34:34.256Z,1704494074.256 [DATMMP](INFO): Starting
2024-01-05T22:34:34.257Z,1704494074.257 [DATMMP](INFO): DAT read: MF Frequency Band

2024-01-05T22:34:34.258Z,1704494074.258 [DATMMP](INFO): DAT read: Directional Acoustic Transponder version 8.15.0

2024-01-05T22:34:34.259Z,1704494074.259 [DATMMP](INFO): DAT read: Jan  5 2000 22:34:28 

2024-01-05T22:34:34.508Z,1704494074.508 [DATMMP](INFO): Starting
2024-01-05T22:34:34.760Z,1704494074.760 [DATMMP](INFO): Starting
2024-01-05T22:34:35.012Z,1704494075.012 [DATMMP](INFO): Starting
2024-01-05T22:34:35.264Z,1704494075.264 [DATMMP](INFO): Starting
2024-01-05T22:34:35.265Z,1704494075.265 [DATMMP](INFO): DAT read: Features enabled [Bearing]

2024-01-05T22:34:35.266Z,1704494075.266 [DATMMP](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP

2024-01-05T22:34:35.266Z,1704494075.266 [DATMMP](INFO): commRate: 800
2024-01-05T22:34:35.516Z,1704494075.516 [DATMMP](INFO): Starting
2024-01-05T22:34:35.768Z,1704494075.768 [DATMMP](INFO): Starting
2024-01-05T22:34:36.020Z,1704494076.020 [DATMMP](INFO): Starting
2024-01-05T22:34:36.272Z,1704494076.272 [DATMMP](INFO): Starting
2024-01-05T22:34:36.524Z,1704494076.524 [DATMMP](INFO): Starting
2024-01-05T22:34:36.776Z,1704494076.776 [DATMMP](INFO): Starting
2024-01-05T22:34:37.028Z,1704494077.028 [DATMMP](INFO): Starting
2024-01-05T22:34:37.280Z,1704494077.280 [DATMMP](INFO): Starting
2024-01-05T22:34:37.332Z,1704494077.332 [DATMMP](INFO): entering command mode
2024-01-05T22:34:37.532Z,1704494077.532 [DATMMP](INFO): Starting
2024-01-05T22:34:37.532Z,1704494077.532 [DATMMP](INFO): DAT read: 

2024-01-05T22:34:37.533Z,1704494077.533 [DATMMP](INFO): DAT read: user:1>

2024-01-05T22:34:37.533Z,1704494077.533 [DATMMP](DEBUG): read user prompt 1: user:1>

2024-01-05T22:34:37.533Z,1704494077.533 [DATMMP](INFO): entering MMP mode
2024-01-05T22:34:37.784Z,1704494077.784 [DATMMP](INFO): Starting
2024-01-05T22:34:37.785Z,1704494077.785 [DATMMP](INFO): GSXN notify for xid: 0
2024-01-05T22:34:37.786Z,1704494077.786 [DATMMP](INFO): status rx: 	 x1
2024-01-05T22:34:37.787Z,1704494077.787 [DATMMP](INFO): MMP status: 1: started
2024-01-05T22:34:37.787Z,1704494077.787 [DATMMP](INFO): Received message type: status
2024-01-05T22:34:37.787Z,1704494077.787 [DATMMP](INFO): Handled
2024-01-05T22:34:38.036Z,1704494078.036 [DATMMP](INFO): Starting
2024-01-05T22:34:38.037Z,1704494078.037 [DATMMP](INFO): Sent Tx Power Config 2
2024-01-05T22:34:38.038Z,1704494078.038 [DATMMP](INFO): Setting local address: 10
2024-01-05T22:34:38.039Z,1704494078.039 [DATMMP](INFO): Setting time to: 22:34:38 And date to:1/5/2024
2024-01-05T22:34:38.288Z,1704494078.288 [DATMMP](INFO): Starting
2024-01-05T22:34:38.288Z,1704494078.288 [DATMMP](INFO): GSXN notify for xid: 0
2024-01-05T22:34:38.289Z,1704494078.289 [DATMMP](INFO): mdmpower rx: 	 x2	 x0	 x5	 x0
2024-01-05T22:34:38.289Z,1704494078.289 [DATMMP](INFO): Received message type: mdmpower
2024-01-05T22:34:38.290Z,1704494078.290 [DATMMP](INFO): Handled
2024-01-05T22:34:38.540Z,1704494078.540 [DATMMP](INFO): Starting
2024-01-05T22:34:38.541Z,1704494078.541 [DATMMP](INFO): GSXN notify for xid: 10
2024-01-05T22:34:38.541Z,1704494078.541 [DATMMP](INFO): sreg_txpower rx: 	 x2
2024-01-05T22:34:38.541Z,1704494078.541 [DATMMP](INFO): Received message type: sreg_txpower
2024-01-05T22:34:38.541Z,1704494078.541 [DATMMP](INFO): Match for : sreg_txpower
2024-01-05T22:34:38.542Z,1704494078.542 [DATMMP](INFO): ACK
2024-01-05T22:34:38.792Z,1704494078.792 [DATMMP](INFO): Starting
2024-01-05T22:34:38.792Z,1704494078.792 [DATMMP](INFO): GSXN notify for xid: 0
2024-01-05T22:34:38.793Z,1704494078.793 [DATMMP](INFO): mdmlocal rx: 	 xA	 x0	 x0	 x0
2024-01-05T22:34:38.794Z,1704494078.794 [DATMMP](INFO): Received message type: mdmlocal
2024-01-05T22:34:38.794Z,1704494078.794 [DATMMP](INFO): Handled
2024-01-05T22:34:39.044Z,1704494079.044 [DATMMP](INFO): Starting
2024-01-05T22:34:39.044Z,1704494079.044 [DATMMP](INFO): GSXN notify for xid: 11
2024-01-05T22:34:39.045Z,1704494079.045 [DATMMP](INFO): sreg_locaddr rx: 	 xA
2024-01-05T22:34:39.045Z,1704494079.045 [DATMMP](INFO): Received message type: sreg_locaddr
2024-01-05T22:34:39.045Z,1704494079.045 [DATMMP](INFO): Match for : sreg_locaddr
2024-01-05T22:34:39.046Z,1704494079.046 [DATMMP](INFO): ACK
2024-01-05T22:34:39.296Z,1704494079.296 [DATMMP](INFO): Starting
2024-01-05T22:34:39.297Z,1704494079.297 [DATMMP](INFO): GSXN notify for xid: 12
2024-01-05T22:34:39.298Z,1704494079.298 [DATMMP](INFO): timedate rx: 	 x0	 x16	 x22	 x26	 x0	 x5	 x7C	 x0
2024-01-05T22:34:39.298Z,1704494079.298 [DATMMP](INFO): Received message type: timedate
2024-01-05T22:34:39.298Z,1704494079.298 [DATMMP](INFO): Match for : timedate
2024-01-05T22:34:39.299Z,1704494079.299 [DATMMP](INFO): ACK
2024-01-05T22:34:39.548Z,1704494079.548 [DATMMP](INFO): Starting
2024-01-05T22:34:39.548Z,1704494079.548 [DATMMP](INFO): GSXN notify for xid: 0
2024-01-05T22:34:39.549Z,1704494079.549 [DATMMP](INFO): sys_verb rx: 	 x0	 x0	 x0	 x0
2024-01-05T22:34:39.550Z,1704494079.550 [DATMMP](INFO): Received message type: sys_verb
2024-01-05T22:34:39.550Z,1704494079.550 [DATMMP](INFO): Handled
2024-01-05T22:34:39.800Z,1704494079.800 [DATMMP](INFO): Starting
2024-01-05T22:34:39.800Z,1704494079.800 [DATMMP](INFO): GSXN notify for xid: 13
2024-01-05T22:34:39.801Z,1704494079.801 [DATMMP](INFO): sreg_verbosity rx: 	 x0
2024-01-05T22:34:39.801Z,1704494079.801 [DATMMP](INFO): Received message type: sreg_verbosity
2024-01-05T22:34:39.801Z,1704494079.801 [DATMMP](INFO): Match for : sreg_verbosity
2024-01-05T22:34:39.801Z,1704494079.801 [DATMMP](INFO): ACK
2024-01-05T22:34:40.052Z,1704494080.052 [DATMMP](INFO): Starting
2024-01-05T22:34:40.052Z,1704494080.052 [DATMMP](INFO): GSXN notify for xid: 14
2024-01-05T22:34:40.053Z,1704494080.053 [DATMMP](INFO): version rx: 	 x2	 x5
2024-01-05T22:34:40.053Z,1704494080.053 [DATMMP](INFO): DatMMPVersion: 2.5
2024-01-05T22:34:40.054Z,1704494080.054 [DATMMP](INFO): Received message type: version
2024-01-05T22:34:40.054Z,1704494080.054 [DATMMP](INFO): Match for : version
2024-01-05T22:34:40.054Z,1704494080.054 [DATMMP](INFO): ACK
2024-01-05T22:34:40.054Z,1704494080.054 [DATMMP](INFO): in MMP mode: config complete going to runnable
2024-01-05T22:34:49.213Z,1704494089.213 [NAL9602](INFO): Powering up NAL9602
2024-01-05T22:34:54.669Z,1704494094.669 [DATMMP](INFO): GSXN notify for xid: 0
2024-01-05T22:34:54.669Z,1704494094.669 [DATMMP](INFO): timesync rx: 	 x0	 x1	 x1	 x0
2024-01-05T22:34:54.670Z,1704494094.670 [DATMMP](INFO): Received message type: timesync
2024-01-05T22:34:54.670Z,1704494094.670 [DATMMP](INFO): Handled
2024-01-05T22:35:00.121Z,1704494100.121 [NAL9602](INFO): NAL9602 initialized
2024-01-05T22:35:04.748Z,1704494104.748 [DATMMP](INFO): GSXN notify for xid: 0
2024-01-05T22:35:04.749Z,1704494104.749 [DATMMP](INFO): timesync rx: 	 x1	 x0	 x1	 x0
2024-01-05T22:35:04.750Z,1704494104.750 [DATMMP](INFO): Received message type: timesync
2024-01-05T22:35:04.750Z,1704494104.750 [DATMMP](INFO): Handled
2024-01-05T22:35:06.658Z,1704494106.658 [SBIT](IMPORTANT): Beginning Startup BIT
2024-01-05T22:35:06.668Z,1704494106.668 [CBIT](IMPORTANT): Beginning ground fault scan
2024-01-05T22:35:10.800Z,1704494110.800 [DATMMP](INFO): GSXN notify for xid: 0
2024-01-05T22:35:10.801Z,1704494110.801 [DATMMP](INFO): doppler rx: 	 x0
2024-01-05T22:35:10.801Z,1704494110.801 [DATMMP](INFO): Received message type: doppler
2024-01-05T22:35:10.801Z,1704494110.801 [DATMMP](INFO): Handled
2024-01-05T22:35:11.053Z,1704494111.053 [DATMMP](INFO): GSXN notify for xid: 0
2024-01-05T22:35:11.054Z,1704494111.054 [DATMMP](INFO): timestamp rx: 	 x1	 x16	 x23	 x9	 xF0F
2024-01-05T22:35:11.054Z,1704494111.054 [DATMMP](INFO): Rx dataTimestamp_ set to:1704494146.677888
2024-01-05T22:35:11.055Z,1704494111.055 [DATMMP](INFO): Rx ping set to:1704494111.053599
2024-01-05T22:35:11.055Z,1704494111.055 [DATMMP](INFO): Received message type: timestamp
2024-01-05T22:35:11.055Z,1704494111.055 [DATMMP](INFO): Handled
2024-01-05T22:35:11.557Z,1704494111.557 [DATMMP](INFO): GSXN notify for xid: 0
2024-01-05T22:35:11.558Z,1704494111.558 [DATMMP](INFO): nav_stat rx: 	 x0	 x1	 x1
2024-01-05T22:35:11.558Z,1704494111.558 [DATMMP](INFO): Received message type: nav_stat
2024-01-05T22:35:11.558Z,1704494111.558 [DATMMP](INFO): Handled
2024-01-05T22:35:11.808Z,1704494111.808 [DATMMP](INFO): GSXN notify for xid: 0
2024-01-05T22:35:11.810Z,1704494111.810 [DATMMP](INFO): directional_debug rx: 	 x98	 x7F	 x33	 xD6	 x2680	 x2E91	 x3962	 x3FF3
2024-01-05T22:35:11.811Z,1704494111.811 [DATMMP](INFO): Received message type: directional_debug
2024-01-05T22:35:11.811Z,1704494111.811 [DATMMP](INFO): Handled
2024-01-05T22:35:12.062Z,1704494112.062 [DATMMP](INFO): GSXN notify for xid: 0
2024-01-05T22:35:12.067Z,1704494112.067 [DATMMP](INFO): directional rx: 	 x94	 x82	 x544	 xFF81	 x19A	 xFF8A	 x0	 xA69	 x4	 xFFF0	 x27B5966	 x-43569E0
2024-01-05T22:35:12.069Z,1704494112.069 [DATMMP](INFO): Received message type: directional
2024-01-05T22:35:12.069Z,1704494112.069 [DATMMP](INFO): Handled
2024-01-05T22:35:12.313Z,1704494112.313 [DATMMP](INFO): GSXN notify for xid: 0
2024-01-05T22:35:12.315Z,1704494112.315 [DATMMP](INFO): remote_header rx: 	 x0	 x62	 x1	 xA1	 x1	 xA	 xC	 x0
2024-01-05T22:35:12.317Z,1704494112.317 [DATMMP](INFO): DATA Src=12, Dst=10
2024-01-05T22:35:12.317Z,1704494112.317 [DATMMP](INFO): Received message type: remote_header
2024-01-05T22:35:12.318Z,1704494112.318 [DATMMP](INFO): Handled
2024-01-05T22:35:12.565Z,1704494112.565 [DATMMP](INFO): GSXN notify for xid: 0
2024-01-05T22:35:12.567Z,1704494112.567 [DATMMP](INFO): acstats rx: 	 xC	 x0	 x0	 x1E8	 x27	 x61	 xFC	 xFA	 xE	 xFFFF	 x0	 x35	 x0	 x0
2024-01-05T22:35:12.567Z,1704494112.567 [DATMMP](INFO): Received message type: acstats
2024-01-05T22:35:12.567Z,1704494112.567 [DATMMP](INFO): Handled
2024-01-05T22:35:12.817Z,1704494112.817 [DATMMP](INFO): GSXN notify for xid: 0
2024-01-05T22:35:12.818Z,1704494112.818 [DATMMP](INFO): timestamp rx: 	 x0	 x16	 x23	 xA	 x269B
2024-01-05T22:35:12.818Z,1704494112.818 [DATMMP](INFO): Received message type: timestamp
2024-01-05T22:35:12.818Z,1704494112.818 [DATMMP](INFO): Handled
2024-01-05T22:35:17.565Z,1704494117.565 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.006984
CHAN A1 (24V): 0.002482
CHAN A2 (12V): -0.005758
CHAN A3 (5V): -0.000651
CHAN B0 (3.3V): 0.000166
CHAN B1 (3.15aV): 0.000105
CHAN B2 (3.15bV): 0.000602
CHAN B3 (GND): 0.001819
OPEN: -0.003955
Full Scale: +/- 1 mA
2024-01-05T22:36:00.397Z,1704494160.397 [SBIT](IMPORTANT): SBIT PASSED
2024-01-05T22:36:00.397Z,1704494160.397 [SBIT](FAULT): Ignoring configuration overrides from Data/persisted.cfg
2024-01-05T22:36:00.824Z,1704494160.824 [MissionManager](IMPORTANT): Started mission Startup
2024-01-05T22:36:00.825Z,1704494160.825 [Startup] Running Loop=1
2024-01-05T22:36:00.825Z,1704494160.825 [Startup](DEBUG): Aggregate::initialize Startup
2024-01-05T22:36:00.825Z,1704494160.825 [Startup:A.GoToSurface] Running Loop=1
2024-01-05T22:36:00.825Z,1704494160.825 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2024-01-05T22:36:00.825Z,1704494160.825 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2024-01-05T22:36:00.826Z,1704494160.826 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2024-01-05T22:36:00.826Z,1704494160.826 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2024-01-05T22:36:00.826Z,1704494160.826 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2024-01-05T22:36:00.827Z,1704494160.827 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2024-01-05T22:36:00.828Z,1704494160.828 [Startup:StartupSatComms] Running Loop=1
2024-01-05T22:36:00.828Z,1704494160.828 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2024-01-05T22:36:00.829Z,1704494160.829 [Startup:StartupSatComms:A] Running Loop=1
2024-01-05T22:36:01.179Z,1704494161.179 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2024-01-05T22:37:00.952Z,1704494220.952 [Startup:StartupSatComms:A](INFO): Timed out from 2024-01-05T22:36:00.8Z
2024-01-05T22:37:00.952Z,1704494220.952 [Startup:StartupSatComms:A] Stopped
2024-01-05T22:37:00.952Z,1704494220.952 [Startup:StartupSatComms:B] Running Loop=1
2024-01-05T22:37:01.335Z,1704494221.335 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2024-01-05T22:37:06.486Z,1704494226.486 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004644
2024-01-05T22:37:14.072Z,1704494234.072 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20240104T224325/Courier0409.lzma
2024-01-05T22:37:15.074Z,1704494235.074 [DataOverHttps](INFO): Moved sent file to Logs/20240104T224325/Courier0409.lzma.bak
2024-01-05T22:37:15.074Z,1704494235.074 [DataOverHttps](INFO): SBD MOMSN=19142323
2024-01-05T22:37:20.475Z,1704494240.475 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2024-01-05T22:37:20.480Z,1704494240.480 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-01-05T22:37:20.495Z,1704494240.495 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-01-05T22:37:20.837Z,1704494240.837 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-01-05T22:37:20.838Z,1704494240.838 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2024-01-05T22:37:30.919Z,1704494250.919 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20240105T223130/Courier0000.lzma
2024-01-05T22:37:31.922Z,1704494251.922 [DataOverHttps](INFO): Moved sent file to Logs/20240105T223130/Courier0000.lzma.bak
2024-01-05T22:37:31.922Z,1704494251.922 [DataOverHttps](INFO): SBD MOMSN=19142325
2024-01-05T22:37:48.764Z,1704494268.764 [DataOverHttps](INFO): Sending 242 bytes from file Logs/20240105T223408/Courier0000.lzma
2024-01-05T22:37:49.766Z,1704494269.766 [DataOverHttps](INFO): Moved sent file to Logs/20240105T223408/Courier0000.lzma.bak
2024-01-05T22:37:49.766Z,1704494269.766 [DataOverHttps](INFO): SBD MOMSN=19142328
2024-01-05T22:38:01.210Z,1704494281.210 [Startup:StartupSatComms:B](INFO): Timed out from 2024-01-05T22:37:00.0Z
2024-01-05T22:38:01.210Z,1704494281.210 [Startup:StartupSatComms:B] Stopped
2024-01-05T22:38:01.210Z,1704494281.210 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2024-01-05T22:38:01.211Z,1704494281.211 [Startup:StartupSatComms] Stopped
2024-01-05T22:38:01.211Z,1704494281.211 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2024-01-05T22:38:01.211Z,1704494281.211 [Startup](INFO): Completed Startup
2024-01-05T22:38:01.244Z,1704494281.244 [MissionManager](INFO): Startup is completed.
2024-01-05T22:38:01.244Z,1704494281.244 [MissionManager](INFO): Uninitializing Mission Startup
2024-01-05T22:38:01.244Z,1704494281.244 [Startup] Stopped
2024-01-05T22:38:01.244Z,1704494281.244 [Startup](DEBUG): Aggregate::uninitialize Startup
2024-01-05T22:38:01.244Z,1704494281.244 [Startup:A.GoToSurface] Stopped
2024-01-05T22:38:01.244Z,1704494281.244 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2024-01-05T22:38:01.706Z,1704494281.706 [MissionManager](IMPORTANT): Started mission Default
2024-01-05T22:38:01.706Z,1704494281.706 [Default] Running Loop=1
2024-01-05T22:38:01.706Z,1704494281.706 [Default](DEBUG): Aggregate::initialize Default
2024-01-05T22:38:01.707Z,1704494281.707 [Default:B.GoToSurface] Running Loop=1
2024-01-05T22:38:01.707Z,1704494281.707 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2024-01-05T22:38:01.707Z,1704494281.707 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2024-01-05T22:38:01.707Z,1704494281.707 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2024-01-05T22:38:01.707Z,1704494281.707 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2024-01-05T22:38:01.712Z,1704494281.712 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2024-01-05T22:38:01.712Z,1704494281.712 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2024-01-05T22:38:01.713Z,1704494281.713 [Default:A.Wait] Running Loop=1
2024-01-05T22:38:01.713Z,1704494281.713 [Default:A.Wait](DEBUG): Initialize Wait Component.
2024-01-05T22:38:05.960Z,1704494285.960 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20240104T224325/Express0410.lzma
2024-01-05T22:38:06.962Z,1704494286.962 [DataOverHttps](INFO): Moved sent file to Logs/20240104T224325/Express0410.lzma.bak
2024-01-05T22:38:06.962Z,1704494286.962 [DataOverHttps](INFO): SBD MOMSN=19142333
2024-01-05T22:38:14.933Z,1704494294.933 [Default:A.Wait](INFO): Done Waiting.
2024-01-05T22:38:14.933Z,1704494294.933 [Default:A.Wait] Stopped
2024-01-05T22:38:14.933Z,1704494294.933 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2024-01-05T22:38:15.418Z,1704494295.418 [Default:CheckIn] Running Loop=1
2024-01-05T22:38:15.418Z,1704494295.418 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-01-05T22:38:15.418Z,1704494295.418 [Default:CheckIn:Read_GPS] Running Loop=1
2024-01-05T22:38:15.799Z,1704494295.799 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2024-01-05T22:39:45.832Z,1704494385.832 [BPC1](ERROR): BPC1B: No match for serial number 1717 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2024-01-05T22:40:03.597Z,1704494403.597 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2024-01-05T22:40:10.567Z,1704494410.567 [RDI_Pathfinder](ERROR): only read 2 of 4 data items for bottom velocity. Device response is::BS,-3278,-32768,V
2024-01-05T22:40:21.385Z,1704494421.385 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2024-01-05T22:40:21.386Z,1704494421.386 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-01-05T22:40:21.397Z,1704494421.397 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-01-05T22:40:21.868Z,1704494421.868 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-01-05T22:40:21.868Z,1704494421.868 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2024-01-05T22:41:42.581Z,1704494502.581 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6.
2024-01-05T22:41:42.585Z,1704494502.585 [BPC1](INFO): Received data from all battery sticks.
2024-01-05T22:43:15.511Z,1704494595.511 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-01-05T22:38:15.4Z
2024-01-05T22:43:15.511Z,1704494595.511 [Default:CheckIn:Read_GPS] Stopped
2024-01-05T22:43:15.511Z,1704494595.511 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-01-05T22:43:15.927Z,1704494595.927 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2024-01-05T22:43:22.410Z,1704494602.410 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2024-01-05T22:43:22.410Z,1704494602.410 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-01-05T22:43:22.425Z,1704494602.425 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-01-05T22:43:22.817Z,1704494602.817 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-01-05T22:43:22.817Z,1704494602.817 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2024-01-05T22:43:22.864Z,1704494602.864 [DataOverHttps](INFO): Sending 168 bytes from file Logs/20240105T223408/Courier0004.lzma
2024-01-05T22:43:23.866Z,1704494603.866 [DataOverHttps](INFO): Moved sent file to Logs/20240105T223408/Courier0004.lzma.bak
2024-01-05T22:43:23.866Z,1704494603.866 [DataOverHttps](INFO): SBD MOMSN=19142387
2024-01-05T22:43:39.731Z,1704494619.731 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20240105T223130/Express0001.lzma
2024-01-05T22:43:40.734Z,1704494620.734 [DataOverHttps](INFO): Moved sent file to Logs/20240105T223130/Express0001.lzma.bak
2024-01-05T22:43:40.734Z,1704494620.734 [DataOverHttps](INFO): SBD MOMSN=19142389
2024-01-05T22:43:56.846Z,1704494636.846 [DataOverHttps](INFO): Sending 695 bytes from file Logs/20240105T223408/Express0001.lzma
2024-01-05T22:43:57.846Z,1704494637.846 [DataOverHttps](INFO): Moved sent file to Logs/20240105T223408/Express0001.lzma.bak
2024-01-05T22:43:57.846Z,1704494637.846 [DataOverHttps](INFO): SBD MOMSN=19142391
2024-01-05T22:44:13.792Z,1704494653.792 [DataOverHttps](INFO): Sending 187 bytes from file Logs/20240105T223408/Express0005.lzma
2024-01-05T22:44:14.794Z,1704494654.794 [DataOverHttps](INFO): Moved sent file to Logs/20240105T223408/Express0005.lzma.bak
2024-01-05T22:44:14.794Z,1704494654.794 [DataOverHttps](INFO): SBD MOMSN=19142405
2024-01-05T22:44:16.131Z,1704494656.131 [Default:CheckIn:Read_Iridium] Stopped
2024-01-05T22:44:16.131Z,1704494656.131 [Default:CheckIn:C.Wait] Running Loop=1
2024-01-05T22:44:16.131Z,1704494656.131 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-01-05T22:45:01.753Z,1704494701.753 [NAL9602](FAULT): GPS failed to acquire within timeout.
2024-01-05T22:45:01.753Z,1704494701.753 [NAL9602] Data Fault, FailCount= 1
2024-01-05T22:45:01.753Z,1704494701.753 [NAL9602](ERROR): Data Fault
2024-01-05T22:45:01.772Z,1704494701.772 [CBIT](ERROR): Data Fault in component: NAL9602
2024-01-05T22:45:02.157Z,1704494702.157 [NAL9602](INFO): Powering down
2024-01-05T22:45:02.000Z,1704494703.000 [CBIT](INFO): Clearing failed state for component NAL9602
2024-01-05T22:45:02.000Z,1704494703.000 [NAL9602] No Fault, FailCount= 1
2024-01-05T22:45:32.485Z,1704494732.485 [NAL9602](INFO): Powering up NAL9602
2024-01-05T22:45:43.365Z,1704494743.365 [NAL9602](INFO): NAL9602 initialized
2024-01-05T22:46:23.370Z,1704494783.370 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2024-01-05T22:46:23.370Z,1704494783.370 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-01-05T22:46:23.381Z,1704494783.381 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-01-05T22:46:23.809Z,1704494783.809 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-01-05T22:46:23.809Z,1704494783.809 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2024-01-05T22:49:16.758Z,1704494956.758 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-01-05T22:49:16.758Z,1704494956.758 [Default:CheckIn:C.Wait] Stopped
2024-01-05T22:49:16.758Z,1704494956.758 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-01-05T22:49:16.758Z,1704494956.758 [Default:CheckIn:D] Running Loop=1
2024-01-05T22:49:17.128Z,1704494957.128 [Default:CheckIn:D] Stopped
2024-01-05T22:49:17.128Z,1704494957.128 [Default:CheckIn:E] Running Loop=1
2024-01-05T22:49:17.530Z,1704494957.530 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 11.257019 min 
2024-01-05T22:49:17.530Z,1704494957.530 [Default:CheckIn:E] Stopped
2024-01-05T22:49:17.530Z,1704494957.530 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-01-05T22:49:17.530Z,1704494957.530 [Default:CheckIn] Stopped
2024-01-05T22:49:17.530Z,1704494957.530 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-01-05T22:49:17.530Z,1704494957.530 [Default:CheckIn](INFO): Running loop #2
2024-01-05T22:49:17.530Z,1704494957.530 [Default:CheckIn] Running Loop=2
2024-01-05T22:49:17.530Z,1704494957.530 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-01-05T22:49:17.530Z,1704494957.530 [Default:CheckIn:Read_GPS] Running Loop=1
2024-01-05T22:49:21.179Z,1704494961.179 [CBIT](INFO): Clearing failed state for component DropWeight
2024-01-05T22:49:21.179Z,1704494961.179 [DropWeight] No Fault, FailCount= 1
2024-01-05T22:49:24.390Z,1704494964.390 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5
2024-01-05T22:49:24.390Z,1704494964.390 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-01-05T22:49:24.400Z,1704494964.400 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-01-05T22:49:24.821Z,1704494964.821 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-01-05T22:49:24.821Z,1704494964.821 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5
2024-01-05T22:52:14.288Z,1704495134.288 [DATMMP](INFO): GSXN notify for xid: 0
2024-01-05T22:52:14.289Z,1704495134.289 [DATMMP](INFO): doppler rx: 	 xFFFF
2024-01-05T22:52:14.289Z,1704495134.289 [DATMMP](INFO): Received message type: doppler
2024-01-05T22:52:14.289Z,1704495134.289 [DATMMP](INFO): Handled
2024-01-05T22:52:14.540Z,1704495134.540 [DATMMP](INFO): GSXN notify for xid: 0
2024-01-05T22:52:14.541Z,1704495134.541 [DATMMP](INFO): timestamp rx: 	 x1	 x16	 x34	 xC	 x18D4
2024-01-05T22:52:14.542Z,1704495134.542 [DATMMP](INFO): Rx dataTimestamp_ set to:1704495194.073728
2024-01-05T22:52:14.542Z,1704495134.542 [DATMMP](INFO): Rx ping set to:1704495134.541481
2024-01-05T22:52:14.542Z,1704495134.542 [DATMMP](INFO): Received message type: timestamp
2024-01-05T22:52:14.543Z,1704495134.543 [DATMMP](INFO): Handled
2024-01-05T22:52:14.793Z,1704495134.793 [DATMMP](INFO): GSXN notify for xid: 0
2024-01-05T22:52:14.793Z,1704495134.793 [DATMMP](INFO): nav_stat rx: 	 x0	 x1	 x1
2024-01-05T22:52:14.793Z,1704495134.793 [DATMMP](INFO): Received message type: nav_stat
2024-01-05T22:52:14.794Z,1704495134.794 [DATMMP](INFO): Handled
2024-01-05T22:52:15.045Z,1704495135.045 [DATMMP](INFO): GSXN notify for xid: 0
2024-01-05T22:52:15.046Z,1704495135.046 [DATMMP](INFO): directional_debug rx: 	 xDA5	 x1FF	 x45	 x241	 x2B10	 x1EA1	 x3212	 x3E23
2024-01-05T22:52:15.047Z,1704495135.047 [DATMMP](INFO): Received message type: directional_debug
2024-01-05T22:52:15.047Z,1704495135.047 [DATMMP](INFO): Handled
2024-01-05T22:52:15.296Z,1704495135.296 [DATMMP](INFO): GSXN notify for xid: 0
2024-01-05T22:52:15.298Z,1704495135.298 [DATMMP](INFO): directional rx: 	 xDAD	 x1DB	 x647	 xFE01	 x28B	 xFE05	 x0	 xA69	 x3	 xFFEF	 x27B5966	 x-43569E0
2024-01-05T22:52:15.300Z,1704495135.300 [DATMMP](INFO): Received message type: directional
2024-01-05T22:52:15.300Z,1704495135.300 [DATMMP](INFO): Handled
2024-01-05T22:52:15.548Z,1704495135.548 [DATMMP](INFO): GSXN notify for xid: 0
2024-01-05T22:52:15.550Z,1704495135.550 [DATMMP](INFO): remote_header rx: 	 x0	 x62	 x1	 x21	 x0	 x32	 x6	 x0
2024-01-05T22:52:15.550Z,1704495135.550 [DATMMP](INFO): DATA Src=6, Dst=50
2024-01-05T22:52:15.550Z,1704495135.550 [DATMMP](INFO): Received message type: remote_header
2024-01-05T22:52:15.550Z,1704495135.550 [DATMMP](INFO): Handled
2024-01-05T22:52:15.800Z,1704495135.800 [DATMMP](INFO): GSXN notify for xid: 0
2024-01-05T22:52:15.802Z,1704495135.802 [DATMMP](INFO): acstats rx: 	 x6	 x0	 xFFFF	 x12B	 x7A	 x1B	 xA4	 x9E	 xB	 xFFFF	 x0	 x48	 x0	 x0
2024-01-05T22:52:15.802Z,1704495135.802 [DATMMP](INFO): Received message type: acstats
2024-01-05T22:52:15.803Z,1704495135.803 [DATMMP](INFO): Handled
2024-01-05T22:52:24.625Z,1704495144.625 [DATMMP](INFO): GSXN notify for xid: 0
2024-01-05T22:52:24.625Z,1704495144.625 [DATMMP](INFO): doppler rx: 	 xFFFD
2024-01-05T22:52:24.625Z,1704495144.625 [DATMMP](INFO): Received message type: doppler
2024-01-05T22:52:24.625Z,1704495144.625 [DATMMP](INFO): Handled
2024-01-05T22:52:24.876Z,1704495144.876 [DATMMP](INFO): GSXN notify for xid: 0
2024-01-05T22:52:24.877Z,1704495144.877 [DATMMP](INFO): timestamp rx: 	 x1	 x16	 x34	 x16	 x2681
2024-01-05T22:52:24.878Z,1704495144.878 [DATMMP](INFO): Rx dataTimestamp_ set to:1704495174.272384
2024-01-05T22:52:24.878Z,1704495144.878 [DATMMP](INFO): Rx ping set to:1704495144.877480
2024-01-05T22:52:24.878Z,1704495144.878 [DATMMP](INFO): Received message type: timestamp
2024-01-05T22:52:24.879Z,1704495144.879 [DATMMP](INFO): Handled
2024-01-05T22:52:25.128Z,1704495145.128 [DATMMP](INFO): GSXN notify for xid: 0
2024-01-05T22:52:25.129Z,1704495145.129 [DATMMP](INFO): nav_stat rx: 	 x0	 x1	 x1
2024-01-05T22:52:25.129Z,1704495145.129 [DATMMP](INFO): Received message type: nav_stat
2024-01-05T22:52:25.130Z,1704495145.130 [DATMMP](INFO): Handled
2024-01-05T22:52:25.380Z,1704495145.380 [DATMMP](INFO): GSXN notify for xid: 0
2024-01-05T22:52:25.382Z,1704495145.382 [DATMMP](INFO): directional_debug rx: 	 xCC2	 x1F9	 x44	 x1F7	 x2E80	 x1DF1	 x37B2	 x31C3
2024-01-05T22:52:25.383Z,1704495145.383 [DATMMP](INFO): Received message type: directional_debug
2024-01-05T22:52:25.383Z,1704495145.383 [DATMMP](INFO): Handled
2024-01-05T22:52:25.385Z,1704495145.385 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6
2024-01-05T22:52:25.385Z,1704495145.385 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-01-05T22:52:25.395Z,1704495145.395 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-01-05T22:52:25.633Z,1704495145.633 [DATMMP](INFO): GSXN notify for xid: 0
2024-01-05T22:52:25.634Z,1704495145.634 [DATMMP](INFO): directional rx: 	 xCBF	 x1DA	 x72A	 xFE07	 x36B	 xFE02	 x0	 xA66	 x4	 xFFEF	 x27B5966	 x-43569E0
2024-01-05T22:52:25.636Z,1704495145.636 [DATMMP](INFO): Received message type: directional
2024-01-05T22:52:25.636Z,1704495145.636 [DATMMP](INFO): Handled
2024-01-05T22:52:25.832Z,1704495145.832 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-01-05T22:52:25.832Z,1704495145.832 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6
2024-01-05T22:52:25.884Z,1704495145.884 [DATMMP](INFO): GSXN notify for xid: 0
2024-01-05T22:52:25.886Z,1704495145.886 [DATMMP](INFO): remote_header rx: 	 x0	 x62	 x1	 x21	 x0	 x32	 x6	 x0
2024-01-05T22:52:25.886Z,1704495145.886 [DATMMP](INFO): DATA Src=6, Dst=50
2024-01-05T22:52:25.886Z,1704495145.886 [DATMMP](INFO): Received message type: remote_header
2024-01-05T22:52:25.886Z,1704495145.886 [DATMMP](INFO): Handled
2024-01-05T22:52:26.136Z,1704495146.136 [DATMMP](INFO): GSXN notify for xid: 0
2024-01-05T22:52:26.138Z,1704495146.138 [DATMMP](INFO): acstats rx: 	 x6	 x0	 xFFFD	 x12F	 x84	 x1E	 x4B	 x68	 xB	 xFFFF	 x0	 x4A	 x0	 x0
2024-01-05T22:52:26.138Z,1704495146.138 [DATMMP](INFO): Received message type: acstats
2024-01-05T22:52:26.138Z,1704495146.138 [DATMMP](INFO): Handled
2024-01-05T22:52:45.296Z,1704495165.296 [DATMMP](INFO): GSXN notify for xid: 0
2024-01-05T22:52:45.297Z,1704495165.297 [DATMMP](INFO): doppler rx: 	 xFFFD
2024-01-05T22:52:45.297Z,1704495165.297 [DATMMP](INFO): Received message type: doppler
2024-01-05T22:52:45.297Z,1704495165.297 [DATMMP](INFO): Handled
2024-01-05T22:52:45.548Z,1704495165.548 [DATMMP](INFO): GSXN notify for xid: 0
2024-01-05T22:52:45.549Z,1704495165.549 [DATMMP](INFO): timestamp rx: 	 x1	 x16	 x34	 x2B	 x18D7
2024-01-05T22:52:45.550Z,1704495165.550 [DATMMP](INFO): Rx dataTimestamp_ set to:1704495225.104448
2024-01-05T22:52:45.550Z,1704495165.550 [DATMMP](INFO): Rx ping set to:1704495165.549386
2024-01-05T22:52:45.550Z,1704495165.550 [DATMMP](INFO): Received message type: timestamp
2024-01-05T22:52:45.550Z,1704495165.550 [DATMMP](INFO): Handled
2024-01-05T22:52:45.801Z,1704495165.801 [DATMMP](INFO): GSXN notify for xid: 0
2024-01-05T22:52:45.801Z,1704495165.801 [DATMMP](INFO): nav_stat rx: 	 x0	 x1	 x1
2024-01-05T22:52:45.802Z,1704495165.802 [DATMMP](INFO): Received message type: nav_stat
2024-01-05T22:52:45.802Z,1704495165.802 [DATMMP](INFO): Handled
2024-01-05T22:52:46.052Z,1704495166.052 [DATMMP](INFO): GSXN notify for xid: 0
2024-01-05T22:52:46.054Z,1704495166.054 [DATMMP](INFO): directional_debug rx: 	 xDF8	 xFFE8	 x45	 xAEF	 x35F0	 x25B1	 x3B62	 x42A3
2024-01-05T22:52:46.055Z,1704495166.055 [DATMMP](INFO): Received message type: directional_debug
2024-01-05T22:52:46.055Z,1704495166.055 [DATMMP](INFO): Handled
2024-01-05T22:52:46.305Z,1704495166.305 [DATMMP](INFO): GSXN notify for xid: 0
2024-01-05T22:52:46.306Z,1704495166.306 [DATMMP](INFO): directional rx: 	 xDF7	 x13	 x5F4	 x18	 x24B	 x1E	 x0	 xA66	 x3	 xFFEE	 x27B5966	 x-43569E0
2024-01-05T22:52:46.308Z,1704495166.308 [DATMMP](INFO): Received message type: directional
2024-01-05T22:52:46.308Z,1704495166.308 [DATMMP](INFO): Handled
2024-01-05T22:52:46.556Z,1704495166.556 [DATMMP](INFO): GSXN notify for xid: 0
2024-01-05T22:52:46.558Z,1704495166.558 [DATMMP](INFO): remote_header rx: 	 x0	 x62	 x1	 x21	 x0	 x32	 x6	 x0
2024-01-05T22:52:46.558Z,1704495166.558 [DATMMP](INFO): DATA Src=6, Dst=50
2024-01-05T22:52:46.558Z,1704495166.558 [DATMMP](INFO): Received message type: remote_header
2024-01-05T22:52:46.558Z,1704495166.558 [DATMMP](INFO): Handled
2024-01-05T22:52:46.809Z,1704495166.809 [DATMMP](INFO): GSXN notify for xid: 0
2024-01-05T22:52:46.810Z,1704495166.810 [DATMMP](INFO): acstats rx: 	 x6	 x0	 xFFFD	 x12A	 x7D	 x27	 xB9	 xA6	 xB	 xFFFF	 x0	 x4A	 x0	 x0
2024-01-05T22:52:46.811Z,1704495166.811 [DATMMP](INFO): Received message type: acstats
2024-01-05T22:52:46.811Z,1704495166.811 [DATMMP](INFO): Handled
2024-01-05T22:52:55.628Z,1704495175.628 [DATMMP](INFO): GSXN notify for xid: 0
2024-01-05T22:52:55.629Z,1704495175.629 [DATMMP](INFO): doppler rx: 	 xFFFF
2024-01-05T22:52:55.629Z,1704495175.629 [DATMMP](INFO): Received message type: doppler
2024-01-05T22:52:55.629Z,1704495175.629 [DATMMP](INFO): Handled
2024-01-05T22:52:55.880Z,1704495175.880 [DATMMP](INFO): GSXN notify for xid: 0
2024-01-05T22:52:55.881Z,1704495175.881 [DATMMP](INFO): timestamp rx: 	 x1	 x16	 x34	 x35	 x268C
2024-01-05T22:52:55.882Z,1704495175.882 [DATMMP](INFO): Rx dataTimestamp_ set to:1704495205.385024
2024-01-05T22:52:55.882Z,1704495175.882 [DATMMP](INFO): Rx ping set to:1704495175.881482
2024-01-05T22:52:55.882Z,1704495175.882 [DATMMP](INFO): Received message type: timestamp
2024-01-05T22:52:55.883Z,1704495175.883 [DATMMP](INFO): Handled
2024-01-05T22:52:56.133Z,1704495176.133 [DATMMP](INFO): GSXN notify for xid: 0
2024-01-05T22:52:56.133Z,1704495176.133 [DATMMP](INFO): nav_stat rx: 	 x0	 x1	 x1
2024-01-05T22:52:56.134Z,1704495176.134 [DATMMP](INFO): Received message type: nav_stat
2024-01-05T22:52:56.134Z,1704495176.134 [DATMMP](INFO): Handled
2024-01-05T22:52:56.384Z,1704495176.384 [DATMMP](INFO): GSXN notify for xid: 0
2024-01-05T22:52:56.386Z,1704495176.386 [DATMMP](INFO): directional_debug rx: 	 xBB5	 xFFD6	 x45	 x9D0	 x3830	 x2861	 x3C82	 x3753
2024-01-05T22:52:56.387Z,1704495176.387 [DATMMP](INFO): Received message type: directional_debug
2024-01-05T22:52:56.387Z,1704495176.387 [DATMMP](INFO): Handled
2024-01-05T22:52:56.637Z,1704495176.637 [DATMMP](INFO): GSXN notify for xid: 0
2024-01-05T22:52:56.638Z,1704495176.638 [DATMMP](INFO): directional rx: 	 xBBE	 x3	 x837	 x2A	 x48F	 x1E	 x0	 xA67	 x3	 xFFED	 x27B5966	 x-43569E0
2024-01-05T22:52:56.640Z,1704495176.640 [DATMMP](INFO): Received message type: directional
2024-01-05T22:52:56.640Z,1704495176.640 [DATMMP](INFO): Handled
2024-01-05T22:52:56.889Z,1704495176.889 [DATMMP](INFO): GSXN notify for xid: 0
2024-01-05T22:52:56.890Z,1704495176.890 [DATMMP](INFO): remote_header rx: 	 x0	 x62	 x1	 x21	 x0	 x32	 x6	 x0
2024-01-05T22:52:56.890Z,1704495176.890 [DATMMP](INFO): DATA Src=6, Dst=50
2024-01-05T22:52:56.890Z,1704495176.890 [DATMMP](INFO): Received message type: remote_header
2024-01-05T22:52:56.891Z,1704495176.891 [DATMMP](INFO): Handled
2024-01-05T22:52:57.140Z,1704495177.140 [DATMMP](INFO): GSXN notify for xid: 0
2024-01-05T22:52:57.142Z,1704495177.142 [DATMMP](INFO): acstats rx: 	 x6	 x0	 xFFFF	 x10E	 x8F	 x1C	 xA8	 x9A	 xC	 xFFFF	 x0	 x4C	 x0	 x0
2024-01-05T22:52:57.142Z,1704495177.142 [DATMMP](INFO): Received message type: acstats
2024-01-05T22:52:57.143Z,1704495177.143 [DATMMP](INFO): Handled
2024-01-05T22:53:05.964Z,1704495185.964 [DATMMP](INFO): GSXN notify for xid: 0
2024-01-05T22:53:05.965Z,1704495185.965 [DATMMP](INFO): doppler rx: 	 x0
2024-01-05T22:53:05.965Z,1704495185.965 [DATMMP](INFO): Received message type: doppler
2024-01-05T22:53:05.965Z,1704495185.965 [DATMMP](INFO): Handled
2024-01-05T22:53:06.217Z,1704495186.217 [DATMMP](INFO): GSXN notify for xid: 0
2024-01-05T22:53:06.218Z,1704495186.218 [DATMMP](INFO): timestamp rx: 	 x1	 x16	 x35	 x4	 xD29
2024-01-05T22:53:06.218Z,1704495186.218 [DATMMP](INFO): Rx dataTimestamp_ set to:1704495216.944128
2024-01-05T22:53:06.218Z,1704495186.218 [DATMMP](INFO): Rx ping set to:1704495186.217615
2024-01-05T22:53:06.219Z,1704495186.219 [DATMMP](INFO): Received message type: timestamp
2024-01-05T22:53:06.219Z,1704495186.219 [DATMMP](INFO): Handled
2024-01-05T22:53:06.470Z,1704495186.470 [DATMMP](INFO): GSXN notify for xid: 0
2024-01-05T22:53:06.472Z,1704495186.472 [DATMMP](INFO): nav_stat rx: 	 x0	 x1	 x1
2024-01-05T22:53:06.473Z,1704495186.473 [DATMMP](INFO): Received message type: nav_stat
2024-01-05T22:53:06.473Z,1704495186.473 [DATMMP](INFO): Handled
2024-01-05T22:53:06.720Z,1704495186.720 [DATMMP](INFO): GSXN notify for xid: 0
2024-01-05T22:53:06.722Z,1704495186.722 [DATMMP](INFO): directional_debug rx: 	 xC88	 xFE65	 x46	 x1A3	 x39E0	 x22F1	 x4792	 x3DB3
2024-01-05T22:53:06.723Z,1704495186.723 [DATMMP](INFO): Received message type: directional_debug
2024-01-05T22:53:06.723Z,1704495186.723 [DATMMP](INFO): Handled
2024-01-05T22:53:06.972Z,1704495186.972 [DATMMP](INFO): GSXN notify for xid: 0
2024-01-05T22:53:06.974Z,1704495186.974 [DATMMP](INFO): directional rx: 	 xC8F	 xFE8D	 x764	 x19B	 x3CC	 x195	 x0	 xA68	 x2	 xFFED	 x27B5966	 x-43569E0
2024-01-05T22:53:06.976Z,1704495186.976 [DATMMP](INFO): Received message type: directional
2024-01-05T22:53:06.976Z,1704495186.976 [DATMMP](INFO): Handled
2024-01-05T22:53:07.225Z,1704495187.225 [DATMMP](INFO): GSXN notify for xid: 0
2024-01-05T22:53:07.226Z,1704495187.226 [DATMMP](INFO): remote_header rx: 	 x0	 x62	 x1	 x21	 x0	 x32	 x6	 x0
2024-01-05T22:53:07.226Z,1704495187.226 [DATMMP](INFO): DATA Src=6, Dst=50
2024-01-05T22:53:07.226Z,1704495187.226 [DATMMP](INFO): Received message type: remote_header
2024-01-05T22:53:07.227Z,1704495187.227 [DATMMP](INFO): Handled
2024-01-05T22:53:07.476Z,1704495187.476 [DATMMP](INFO): GSXN notify for xid: 0
2024-01-05T22:53:07.478Z,1704495187.478 [DATMMP](INFO): acstats rx: 	 x6	 x0	 x0	 x11E	 x81	 x20	 xA5	 x99	 xC	 xFFFF	 x0	 x4D	 x0	 x0
2024-01-05T22:53:07.478Z,1704495187.478 [DATMMP](INFO): Received message type: acstats
2024-01-05T22:53:07.479Z,1704495187.479 [DATMMP](INFO): Handled
2024-01-05T22:54:17.686Z,1704495257.686 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-01-05T22:49:17.5Z
2024-01-05T22:54:17.686Z,1704495257.686 [Default:CheckIn:Read_GPS] Stopped
2024-01-05T22:54:17.686Z,1704495257.686 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-01-05T22:54:25.087Z,1704495265.087 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240105T223408/Courier0007.lzma
2024-01-05T22:54:26.090Z,1704495266.090 [DataOverHttps](INFO): Moved sent file to Logs/20240105T223408/Courier0007.lzma.bak
2024-01-05T22:54:26.090Z,1704495266.090 [DataOverHttps](INFO): SBD MOMSN=19142415
2024-01-05T22:54:41.908Z,1704495281.908 [DataOverHttps](INFO): Sending 181 bytes from file Logs/20240105T223408/Express0008.lzma
2024-01-05T22:54:42.910Z,1704495282.910 [DataOverHttps](INFO): Moved sent file to Logs/20240105T223408/Express0008.lzma.bak
2024-01-05T22:54:42.910Z,1704495282.910 [DataOverHttps](INFO): SBD MOMSN=19142417
2024-01-05T22:54:44.353Z,1704495284.353 [Default:CheckIn:Read_Iridium] Stopped
2024-01-05T22:54:44.353Z,1704495284.353 [Default:CheckIn:C.Wait] Running Loop=1
2024-01-05T22:54:44.353Z,1704495284.353 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-01-05T22:55:26.367Z,1704495326.367 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7
2024-01-05T22:55:26.367Z,1704495326.367 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-01-05T22:55:26.378Z,1704495326.378 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-01-05T22:55:26.807Z,1704495326.807 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-01-05T22:55:26.807Z,1704495326.807 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7
2024-01-05T22:55:44.945Z,1704495344.945 [NAL9602](FAULT): GPS failed to acquire within timeout.
2024-01-05T22:55:44.946Z,1704495344.946 [NAL9602] Data Fault, FailCount= 2
2024-01-05T22:55:44.946Z,1704495344.946 [NAL9602](ERROR): Data Fault
2024-01-05T22:55:44.964Z,1704495344.964 [CBIT](ERROR): Data Fault in component: NAL9602
2024-01-05T22:55:45.342Z,1704495345.342 [NAL9602](INFO): Powering down
2024-01-05T22:55:46.171Z,1704495346.171 [CBIT](INFO): Clearing failed state for component NAL9602
2024-01-05T22:55:46.171Z,1704495346.171 [NAL9602] No Fault, FailCount= 2
2024-01-05T22:56:15.647Z,1704495375.647 [NAL9602](INFO): Powering up NAL9602
2024-01-05T22:56:26.550Z,1704495386.550 [NAL9602](INFO): NAL9602 initialized
2024-01-05T22:58:27.360Z,1704495507.360 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8
2024-01-05T22:58:27.360Z,1704495507.360 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-01-05T22:58:27.371Z,1704495507.371 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-01-05T22:58:27.785Z,1704495507.785 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-01-05T22:58:27.785Z,1704495507.785 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8
2024-01-05T22:59:44.942Z,1704495584.942 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-01-05T22:59:44.943Z,1704495584.943 [Default:CheckIn:C.Wait] Stopped
2024-01-05T22:59:44.943Z,1704495584.943 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-01-05T22:59:44.943Z,1704495584.943 [Default:CheckIn:D] Running Loop=1
2024-01-05T22:59:45.363Z,1704495585.363 [Default:CheckIn:D] Stopped
2024-01-05T22:59:45.363Z,1704495585.363 [Default:CheckIn:E] Running Loop=1
2024-01-05T22:59:45.750Z,1704495585.750 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 21.727602 min 
2024-01-05T22:59:45.751Z,1704495585.751 [Default:CheckIn:E] Stopped
2024-01-05T22:59:45.751Z,1704495585.751 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-01-05T22:59:45.751Z,1704495585.751 [Default:CheckIn] Stopped
2024-01-05T22:59:45.751Z,1704495585.751 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-01-05T22:59:45.751Z,1704495585.751 [Default:CheckIn](INFO): Running loop #3
2024-01-05T22:59:45.751Z,1704495585.751 [Default:CheckIn] Running Loop=3
2024-01-05T22:59:45.751Z,1704495585.751 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-01-05T22:59:45.751Z,1704495585.751 [Default:CheckIn:Read_GPS] Running Loop=1
2024-01-05T23:01:28.350Z,1704495688.350 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 9
2024-01-05T23:01:28.350Z,1704495688.350 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-01-05T23:01:28.365Z,1704495688.365 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-01-05T23:01:28.799Z,1704495688.799 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-01-05T23:01:28.799Z,1704495688.799 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 9
2024-01-05T23:04:29.365Z,1704495869.365 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 10
2024-01-05T23:04:29.365Z,1704495869.365 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-01-05T23:04:29.376Z,1704495869.376 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-01-05T23:04:29.768Z,1704495869.768 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-01-05T23:04:29.769Z,1704495869.769 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 10
2024-01-05T23:04:45.922Z,1704495885.922 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-01-05T22:59:45.8Z
2024-01-05T23:04:45.922Z,1704495885.922 [Default:CheckIn:Read_GPS] Stopped
2024-01-05T23:04:45.922Z,1704495885.922 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-01-05T23:04:53.295Z,1704495893.295 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240105T223408/Courier0010.lzma
2024-01-05T23:04:54.298Z,1704495894.298 [DataOverHttps](INFO): Moved sent file to Logs/20240105T223408/Courier0010.lzma.bak
2024-01-05T23:04:54.298Z,1704495894.298 [DataOverHttps](INFO): SBD MOMSN=19142427
2024-01-05T23:05:10.244Z,1704495910.244 [DataOverHttps](INFO): Sending 150 bytes from file Logs/20240105T223408/Express0011.lzma
2024-01-05T23:05:11.246Z,1704495911.246 [DataOverHttps](INFO): Moved sent file to Logs/20240105T223408/Express0011.lzma.bak
2024-01-05T23:05:11.246Z,1704495911.246 [DataOverHttps](INFO): SBD MOMSN=19142429
2024-01-05T23:05:12.994Z,1704495912.994 [Default:CheckIn:Read_Iridium] Stopped
2024-01-05T23:05:12.994Z,1704495912.994 [Default:CheckIn:C.Wait] Running Loop=1
2024-01-05T23:05:12.994Z,1704495912.994 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-01-05T23:06:30.151Z,1704495990.151 [NAL9602](FAULT): GPS failed to acquire within timeout.
2024-01-05T23:06:30.151Z,1704495990.151 [NAL9602] Data Fault, FailCount= 3
2024-01-05T23:06:30.151Z,1704495990.151 [NAL9602](ERROR): Data Fault
2024-01-05T23:06:30.169Z,1704495990.169 [CBIT](ERROR): Data Fault in component: NAL9602
2024-01-05T23:06:30.549Z,1704495990.549 [NAL9602](INFO): Powering down
2024-01-05T23:06:31.379Z,1704495991.379 [CBIT](INFO): Clearing failed state for component NAL9602
2024-01-05T23:06:31.379Z,1704495991.379 [NAL9602] No Fault, FailCount= 3
2024-01-05T23:07:00.854Z,1704496020.854 [NAL9602](INFO): Powering up NAL9602
2024-01-05T23:07:11.763Z,1704496031.763 [NAL9602](INFO): NAL9602 initialized
2024-01-05T23:07:30.353Z,1704496050.353 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 11
2024-01-05T23:07:30.353Z,1704496050.353 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-01-05T23:07:30.364Z,1704496050.364 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-01-05T23:07:30.789Z,1704496050.789 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-01-05T23:07:30.789Z,1704496050.789 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 11
2024-01-05T23:10:13.570Z,1704496213.570 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-01-05T23:10:13.571Z,1704496213.571 [Default:CheckIn:C.Wait] Stopped
2024-01-05T23:10:13.571Z,1704496213.571 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-01-05T23:10:13.571Z,1704496213.571 [Default:CheckIn:D] Running Loop=1
2024-01-05T23:10:13.974Z,1704496213.974 [Default:CheckIn:D] Stopped
2024-01-05T23:10:13.974Z,1704496213.974 [Default:CheckIn:E] Running Loop=1
2024-01-05T23:10:14.379Z,1704496214.379 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 32.204462 min 
2024-01-05T23:10:14.379Z,1704496214.379 [Default:CheckIn:E] Stopped
2024-01-05T23:10:14.379Z,1704496214.379 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-01-05T23:10:14.379Z,1704496214.379 [Default:CheckIn] Stopped
2024-01-05T23:10:14.379Z,1704496214.379 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-01-05T23:10:14.381Z,1704496214.381 [Default:CheckIn](INFO): Running loop #4
2024-01-05T23:10:14.381Z,1704496214.381 [Default:CheckIn] Running Loop=4
2024-01-05T23:10:14.381Z,1704496214.381 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-01-05T23:10:14.381Z,1704496214.381 [Default:CheckIn:Read_GPS] Running Loop=1
2024-01-05T23:10:31.341Z,1704496231.341 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 12
2024-01-05T23:10:31.341Z,1704496231.341 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-01-05T23:10:31.368Z,1704496231.368 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-01-05T23:10:31.759Z,1704496231.759 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-01-05T23:10:31.759Z,1704496231.759 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 12
2024-01-05T23:13:32.358Z,1704496412.358 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 13
2024-01-05T23:13:32.358Z,1704496412.358 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-01-05T23:13:32.407Z,1704496412.407 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-01-05T23:13:32.831Z,1704496412.831 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-01-05T23:13:32.831Z,1704496412.831 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 13
2024-01-05T23:15:14.580Z,1704496514.580 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-01-05T23:10:14.4Z
2024-01-05T23:15:14.580Z,1704496514.580 [Default:CheckIn:Read_GPS] Stopped
2024-01-05T23:15:14.580Z,1704496514.580 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-01-05T23:15:21.379Z,1704496521.379 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240105T223408/Courier0013.lzma
2024-01-05T23:15:22.382Z,1704496522.382 [DataOverHttps](INFO): Moved sent file to Logs/20240105T223408/Courier0013.lzma.bak
2024-01-05T23:15:22.382Z,1704496522.382 [DataOverHttps](INFO): SBD MOMSN=19142439
2024-01-05T23:15:39.108Z,1704496539.108 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20240105T223408/Express0014.lzma
2024-01-05T23:15:40.110Z,1704496540.110 [DataOverHttps](INFO): Moved sent file to Logs/20240105T223408/Express0014.lzma.bak
2024-01-05T23:15:40.110Z,1704496540.110 [DataOverHttps](INFO): SBD MOMSN=19142441
2024-01-05T23:15:41.638Z,1704496541.638 [Default:CheckIn:Read_Iridium] Stopped
2024-01-05T23:15:41.638Z,1704496541.638 [Default:CheckIn:C.Wait] Running Loop=1
2024-01-05T23:15:41.639Z,1704496541.639 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-01-05T23:16:33.354Z,1704496593.354 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 14
2024-01-05T23:16:33.354Z,1704496593.354 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-01-05T23:16:33.365Z,1704496593.365 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-01-05T23:16:33.750Z,1704496593.750 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-01-05T23:16:33.750Z,1704496593.750 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 14
2024-01-05T23:17:14.134Z,1704496634.134 [NAL9602](FAULT): GPS failed to acquire within timeout.
2024-01-05T23:17:14.134Z,1704496634.134 [NAL9602] Data Fault, FailCount= 4
2024-01-05T23:17:14.134Z,1704496634.134 [NAL9602](ERROR): Data Fault
2024-01-05T23:17:14.182Z,1704496634.182 [CBIT](ERROR): Data Fault in component: NAL9602
2024-01-05T23:17:14.537Z,1704496634.537 [NAL9602](INFO): Powering down
2024-01-05T23:17:15.373Z,1704496635.373 [CBIT](INFO): Clearing failed state for component NAL9602
2024-01-05T23:17:15.373Z,1704496635.373 [NAL9602] No Fault, FailCount= 4
2024-01-05T23:17:44.838Z,1704496664.838 [NAL9602](INFO): Powering up NAL9602
2024-01-05T23:17:55.745Z,1704496675.745 [NAL9602](INFO): NAL9602 initialized
2024-01-05T23:19:22.605Z,1704496762.605 [DropWeight](CRITICAL): DROP WEIGHT MISSING.

2024-01-05T23:19:22.605Z,1704496762.605 [DropWeight] Hardware Fault, FailCount= 1
2024-01-05T23:19:22.606Z,1704496762.606 [DropWeight](ERROR): Hardware Fault
2024-01-05T23:19:22.668Z,1704496762.668 [CBIT](INFO): Critical error at 20240105T231922
2024-01-05T23:19:22.671Z,1704496762.671 [CBIT](ERROR): Hardware Fault in component: DropWeight
2024-01-05T23:19:22.671Z,1704496762.671 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2024-01-05T23:19:23.034Z,1704496763.034 [CBIT](INFO): Critical error at 20240105T231922
2024-01-05T23:19:34.333Z,1704496774.333 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 15
2024-01-05T23:19:34.334Z,1704496774.334 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-01-05T23:19:34.345Z,1704496774.345 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-01-05T23:19:34.768Z,1704496774.768 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-01-05T23:19:34.769Z,1704496774.769 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 15
2024-01-05T23:20:42.207Z,1704496842.207 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-01-05T23:20:42.207Z,1704496842.207 [Default:CheckIn:C.Wait] Stopped
2024-01-05T23:20:42.207Z,1704496842.207 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-01-05T23:20:42.207Z,1704496842.207 [Default:CheckIn:D] Running Loop=1
2024-01-05T23:20:42.650Z,1704496842.650 [Default:CheckIn:D] Stopped
2024-01-05T23:20:42.650Z,1704496842.650 [Default:CheckIn:E] Running Loop=1
2024-01-05T23:20:43.022Z,1704496843.022 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 42.682397 min 
2024-01-05T23:20:43.022Z,1704496843.022 [Default:CheckIn:E] Stopped
2024-01-05T23:20:43.023Z,1704496843.023 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-01-05T23:20:43.023Z,1704496843.023 [Default:CheckIn] Stopped
2024-01-05T23:20:43.023Z,1704496843.023 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-01-05T23:20:43.023Z,1704496843.023 [Default:CheckIn](INFO): Running loop #5
2024-01-05T23:20:43.023Z,1704496843.023 [Default:CheckIn] Running Loop=5
2024-01-05T23:20:43.023Z,1704496843.023 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-01-05T23:20:43.023Z,1704496843.023 [Default:CheckIn:Read_GPS] Running Loop=1
2024-01-05T23:22:35.341Z,1704496955.341 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 16
2024-01-05T23:22:35.341Z,1704496955.341 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-01-05T23:22:35.352Z,1704496955.352 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-01-05T23:22:35.739Z,1704496955.739 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-01-05T23:22:35.739Z,1704496955.739 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 16
2024-01-05T23:25:36.381Z,1704497136.381 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 17
2024-01-05T23:25:36.381Z,1704497136.381 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-01-05T23:25:36.392Z,1704497136.392 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-01-05T23:25:36.816Z,1704497136.816 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-01-05T23:25:36.816Z,1704497136.816 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 17
2024-01-05T23:25:43.251Z,1704497143.251 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-01-05T23:20:43.0Z
2024-01-05T23:25:43.251Z,1704497143.251 [Default:CheckIn:Read_GPS] Stopped
2024-01-05T23:25:43.251Z,1704497143.251 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-01-05T23:25:44.880Z,1704497144.880 [RDI_Pathfinder](ERROR): only read 1 of 4 data items for beam range. Device response is::RA,  0.00,.79
2024-01-05T23:25:50.524Z,1704497150.524 [DataOverHttps](INFO): Sending 114 bytes from file Logs/20240105T223408/Courier0016.lzma
2024-01-05T23:25:51.526Z,1704497151.526 [DataOverHttps](INFO): Moved sent file to Logs/20240105T223408/Courier0016.lzma.bak
2024-01-05T23:25:51.526Z,1704497151.526 [DataOverHttps](INFO): SBD MOMSN=19142453
2024-01-05T23:26:07.484Z,1704497167.484 [DataOverHttps](INFO): Sending 150 bytes from file Logs/20240105T223408/Express0017.lzma
2024-01-05T23:26:08.489Z,1704497168.489 [DataOverHttps](INFO): Moved sent file to Logs/20240105T223408/Express0017.lzma.bak
2024-01-05T23:26:08.489Z,1704497168.489 [DataOverHttps](INFO): SBD MOMSN=19142457
2024-01-05T23:26:09.918Z,1704497169.918 [Default:CheckIn:Read_Iridium] Stopped
2024-01-05T23:26:09.918Z,1704497169.918 [Default:CheckIn:C.Wait] Running Loop=1
2024-01-05T23:26:09.918Z,1704497169.918 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-01-05T23:27:58.173Z,1704497278.173 [NAL9602](FAULT): GPS failed to acquire within timeout.
2024-01-05T23:27:58.173Z,1704497278.173 [NAL9602] Data Fault, FailCount= 5
2024-01-05T23:27:58.173Z,1704497278.173 [NAL9602](ERROR): Data Fault
2024-01-05T23:27:58.252Z,1704497278.252 [CBIT](ERROR): Data Fault in component: NAL9602
2024-01-05T23:27:58.253Z,1704497278.253 [CBIT](CRITICAL): Data Fault in component: NAL9602
2024-01-05T23:27:58.581Z,1704497278.581 [NAL9602](INFO): Powering down
2024-01-05T23:27:58.673Z,1704497278.673 [CBIT](INFO): Critical error at 20240105T232758
2024-01-05T23:28:37.372Z,1704497317.372 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 18
2024-01-05T23:28:37.372Z,1704497317.372 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-01-05T23:28:37.383Z,1704497317.383 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-01-05T23:28:37.795Z,1704497317.795 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-01-05T23:28:37.795Z,1704497317.795 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 18
2024-01-05T23:29:58.204Z,1704497398.204 [CBIT](INFO): Clearing failed state for component NAL9602
2024-01-05T23:29:58.205Z,1704497398.205 [NAL9602] No Fault, FailCount= 5
2024-01-05T23:29:58.569Z,1704497398.569 [NAL9602](INFO): Powering up NAL9602
2024-01-05T23:30:09.471Z,1704497409.471 [NAL9602](INFO): NAL9602 initialized
2024-01-05T23:31:10.560Z,1704497470.560 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-01-05T23:31:10.561Z,1704497470.561 [Default:CheckIn:C.Wait] Stopped
2024-01-05T23:31:10.561Z,1704497470.561 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-01-05T23:31:10.561Z,1704497470.561 [Default:CheckIn:D] Running Loop=1
2024-01-05T23:31:10.921Z,1704497470.921 [Default:CheckIn:D] Stopped
2024-01-05T23:31:10.921Z,1704497470.921 [Default:CheckIn:E] Running Loop=1
2024-01-05T23:31:11.298Z,1704497471.298 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 53.153577 min 
2024-01-05T23:31:11.298Z,1704497471.298 [Default:CheckIn:E] Stopped
2024-01-05T23:31:11.298Z,1704497471.298 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-01-05T23:31:11.298Z,1704497471.298 [Default:CheckIn] Stopped
2024-01-05T23:31:11.298Z,1704497471.298 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-01-05T23:31:11.298Z,1704497471.298 [Default:CheckIn](INFO): Running loop #6
2024-01-05T23:31:11.299Z,1704497471.299 [Default:CheckIn] Running Loop=6
2024-01-05T23:31:11.299Z,1704497471.299 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-01-05T23:31:11.299Z,1704497471.299 [Default:CheckIn:Read_GPS] Running Loop=1
2024-01-05T23:31:38.459Z,1704497498.459 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 19
2024-01-05T23:31:38.459Z,1704497498.459 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-01-05T23:31:38.535Z,1704497498.535 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-01-05T23:31:38.945Z,1704497498.945 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-01-05T23:31:38.945Z,1704497498.945 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 19
2024-01-05T23:34:22.921Z,1704497662.921 [CBIT](INFO): Clearing failed state for component DropWeight
2024-01-05T23:34:22.922Z,1704497662.922 [DropWeight] No Fault, FailCount= 1
2024-01-05T23:34:39.414Z,1704497679.414 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 20
2024-01-05T23:34:39.414Z,1704497679.414 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-01-05T23:34:39.424Z,1704497679.424 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-01-05T23:34:39.851Z,1704497679.851 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-01-05T23:34:39.851Z,1704497679.851 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 20
2024-01-05T23:35:02.865Z,1704497702.865 [RDI_Pathfinder](ERROR): only read 0 of 4 data items for beam range. Device response is::RA,  0.00631.72
2024-01-05T23:36:11.540Z,1704497771.540 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-01-05T23:31:11.3Z
2024-01-05T23:36:11.540Z,1704497771.540 [Default:CheckIn:Read_GPS] Stopped
2024-01-05T23:36:11.540Z,1704497771.540 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-01-05T23:36:18.659Z,1704497778.659 [DataOverHttps](INFO): Sending 81 bytes from file Logs/20240105T223408/Courier0019.lzma
2024-01-05T23:36:19.662Z,1704497779.662 [DataOverHttps](INFO): Moved sent file to Logs/20240105T223408/Courier0019.lzma.bak
2024-01-05T23:36:19.662Z,1704497779.662 [DataOverHttps](INFO): SBD MOMSN=19142466
2024-01-05T23:36:35.979Z,1704497795.979 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20240105T223408/Express0020.lzma
2024-01-05T23:36:36.406Z,1704497796.406 [DataOverHttps](INFO): Moved sent file to Logs/20240105T223408/Express0020.lzma.bak
2024-01-05T23:36:36.406Z,1704497796.406 [DataOverHttps](INFO): SBD MOMSN=19142469
2024-01-05T23:36:37.817Z,1704497797.817 [Default:CheckIn:Read_Iridium] Stopped
2024-01-05T23:36:37.817Z,1704497797.817 [Default:CheckIn:C.Wait] Running Loop=1
2024-01-05T23:36:37.817Z,1704497797.817 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-01-05T23:37:40.429Z,1704497860.429 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 21
2024-01-05T23:37:40.429Z,1704497860.429 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-01-05T23:37:40.449Z,1704497860.449 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-01-05T23:37:40.859Z,1704497860.859 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-01-05T23:37:40.859Z,1704497860.859 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 21
2024-01-05T23:40:11.901Z,1704498011.901 [NAL9602](FAULT): GPS failed to acquire within timeout.
2024-01-05T23:40:11.902Z,1704498011.902 [NAL9602] Data Fault, FailCount= 1
2024-01-05T23:40:11.902Z,1704498011.902 [NAL9602](ERROR): Data Fault
2024-01-05T23:40:11.940Z,1704498011.940 [CBIT](ERROR): Data Fault in component: NAL9602
2024-01-05T23:40:12.301Z,1704498012.301 [NAL9602](INFO): Powering down
2024-01-05T23:40:13.179Z,1704498013.179 [CBIT](INFO): Clearing failed state for component NAL9602
2024-01-05T23:40:13.179Z,1704498013.179 [NAL9602] No Fault, FailCount= 1
2024-01-05T23:40:41.411Z,1704498041.411 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 22
2024-01-05T23:40:41.411Z,1704498041.411 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-01-05T23:40:41.421Z,1704498041.421 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-01-05T23:40:41.831Z,1704498041.831 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-01-05T23:40:41.831Z,1704498041.831 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 22
2024-01-05T23:40:42.607Z,1704498042.607 [NAL9602](INFO): Powering up NAL9602
2024-01-05T23:40:53.513Z,1704498053.513 [NAL9602](INFO): NAL9602 initialized
2024-01-05T23:41:38.397Z,1704498098.397 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-01-05T23:41:38.398Z,1704498098.398 [Default:CheckIn:C.Wait] Stopped
2024-01-05T23:41:38.398Z,1704498098.398 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-01-05T23:41:38.398Z,1704498098.398 [Default:CheckIn:D] Running Loop=1
2024-01-05T23:41:38.849Z,1704498098.849 [Default:CheckIn:D] Stopped
2024-01-05T23:41:38.849Z,1704498098.849 [Default:CheckIn:E] Running Loop=1
2024-01-05T23:41:39.211Z,1704498099.211 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 63.619047 min 
2024-01-05T23:41:39.211Z,1704498099.211 [Default:CheckIn:E] Stopped
2024-01-05T23:41:39.211Z,1704498099.211 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-01-05T23:41:39.211Z,1704498099.211 [Default:CheckIn] Stopped
2024-01-05T23:41:39.211Z,1704498099.211 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-01-05T23:41:39.211Z,1704498099.211 [Default:CheckIn](INFO): Running loop #7
2024-01-05T23:41:39.211Z,1704498099.211 [Default:CheckIn] Running Loop=7
2024-01-05T23:41:39.211Z,1704498099.211 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-01-05T23:41:39.216Z,1704498099.216 [Default:CheckIn:Read_GPS] Running Loop=1
2024-01-05T23:43:42.428Z,1704498222.428 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 23
2024-01-05T23:43:42.428Z,1704498222.428 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-01-05T23:43:42.461Z,1704498222.461 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-01-05T23:43:42.912Z,1704498222.912 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-01-05T23:43:42.912Z,1704498222.912 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 23
2024-01-05T23:46:39.355Z,1704498399.355 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-01-05T23:41:39.2Z
2024-01-05T23:46:39.355Z,1704498399.355 [Default:CheckIn:Read_GPS] Stopped
2024-01-05T23:46:39.355Z,1704498399.355 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-01-05T23:46:43.416Z,1704498403.416 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 24
2024-01-05T23:46:43.416Z,1704498403.416 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-01-05T23:46:43.439Z,1704498403.439 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-01-05T23:46:43.846Z,1704498403.846 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-01-05T23:46:43.846Z,1704498403.846 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 24
2024-01-05T23:46:46.446Z,1704498406.446 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240105T223408/Courier0022.lzma
2024-01-05T23:46:47.442Z,1704498407.442 [DataOverHttps](INFO): Moved sent file to Logs/20240105T223408/Courier0022.lzma.bak
2024-01-05T23:46:47.442Z,1704498407.442 [DataOverHttps](INFO): SBD MOMSN=19142479
2024-01-05T23:47:03.557Z,1704498423.557 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20240105T223408/Express0023.lzma
2024-01-05T23:47:04.558Z,1704498424.558 [DataOverHttps](INFO): Moved sent file to Logs/20240105T223408/Express0023.lzma.bak
2024-01-05T23:47:04.558Z,1704498424.558 [DataOverHttps](INFO): SBD MOMSN=19142481
2024-01-05T23:47:06.034Z,1704498426.034 [Default:CheckIn:Read_Iridium] Stopped
2024-01-05T23:47:06.034Z,1704498426.034 [Default:CheckIn:C.Wait] Running Loop=1
2024-01-05T23:47:06.035Z,1704498426.035 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-01-05T23:48:32.528Z,1704498512.528 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for water mass range. Device response is::WD,    .58
2024-01-05T23:49:10.852Z,1704498550.852 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6.
2024-01-05T23:49:10.854Z,1704498550.854 [BPC1](INFO): Received data from all battery sticks.
2024-01-05T23:49:44.393Z,1704498584.393 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 25
2024-01-05T23:49:44.393Z,1704498584.393 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-01-05T23:49:44.432Z,1704498584.432 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-01-05T23:49:44.840Z,1704498584.840 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-01-05T23:49:44.841Z,1704498584.841 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 25
2024-01-05T23:50:57.102Z,1704498657.102 [NAL9602](FAULT): GPS failed to acquire within timeout.
2024-01-05T23:50:57.102Z,1704498657.102 [NAL9602] Data Fault, FailCount= 2
2024-01-05T23:50:57.102Z,1704498657.102 [NAL9602](ERROR): Data Fault
2024-01-05T23:50:57.127Z,1704498657.127 [CBIT](ERROR): Data Fault in component: NAL9602
2024-01-05T23:50:57.510Z,1704498657.510 [NAL9602](INFO): Powering down
2024-01-05T23:50:58.353Z,1704498658.353 [CBIT](INFO): Clearing failed state for component NAL9602
2024-01-05T23:50:58.353Z,1704498658.353 [NAL9602] No Fault, FailCount= 2
2024-01-05T23:51:27.817Z,1704498687.817 [NAL9602](INFO): Powering up NAL9602
2024-01-05T23:51:38.718Z,1704498698.718 [NAL9602](INFO): NAL9602 initialized
2024-01-05T23:52:06.633Z,1704498726.633 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-01-05T23:52:06.634Z,1704498726.634 [Default:CheckIn:C.Wait] Stopped
2024-01-05T23:52:06.634Z,1704498726.634 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-01-05T23:52:06.634Z,1704498726.634 [Default:CheckIn:D] Running Loop=1
2024-01-05T23:52:07.010Z,1704498727.010 [Default:CheckIn:D] Stopped
2024-01-05T23:52:07.010Z,1704498727.010 [Default:CheckIn:E] Running Loop=1
2024-01-05T23:52:07.419Z,1704498727.419 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 74.088395 min 
2024-01-05T23:52:07.419Z,1704498727.419 [Default:CheckIn:E] Stopped
2024-01-05T23:52:07.419Z,1704498727.419 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-01-05T23:52:07.419Z,1704498727.419 [Default:CheckIn] Stopped
2024-01-05T23:52:07.419Z,1704498727.419 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-01-05T23:52:07.419Z,1704498727.419 [Default:CheckIn](INFO): Running loop #8
2024-01-05T23:52:07.420Z,1704498727.420 [Default:CheckIn] Running Loop=8
2024-01-05T23:52:07.420Z,1704498727.420 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-01-05T23:52:07.420Z,1704498727.420 [Default:CheckIn:Read_GPS] Running Loop=1
2024-01-05T23:52:45.413Z,1704498765.413 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 26
2024-01-05T23:52:45.413Z,1704498765.413 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-01-05T23:52:45.424Z,1704498765.424 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-01-05T23:52:45.840Z,1704498765.840 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-01-05T23:52:45.840Z,1704498765.840 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 26
2024-01-05T23:55:46.431Z,1704498946.431 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 27
2024-01-05T23:55:46.431Z,1704498946.431 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-01-05T23:55:46.506Z,1704498946.506 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-01-05T23:55:46.874Z,1704498946.874 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-01-05T23:55:46.874Z,1704498946.874 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 27
2024-01-05T23:57:07.671Z,1704499027.671 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-01-05T23:52:07.4Z
2024-01-05T23:57:07.671Z,1704499027.671 [Default:CheckIn:Read_GPS] Stopped
2024-01-05T23:57:07.671Z,1704499027.671 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-01-05T23:57:15.515Z,1704499035.515 [DataOverHttps](INFO): Sending 50 bytes from file Logs/20240105T223408/Courier0025.lzma
2024-01-05T23:57:16.518Z,1704499036.518 [DataOverHttps](INFO): Moved sent file to Logs/20240105T223408/Courier0025.lzma.bak
2024-01-05T23:57:16.518Z,1704499036.518 [DataOverHttps](INFO): SBD MOMSN=19142491
2024-01-05T23:57:32.356Z,1704499052.356 [DataOverHttps](INFO): Sending 150 bytes from file Logs/20240105T223408/Express0026.lzma
2024-01-05T23:57:33.358Z,1704499053.358 [DataOverHttps](INFO): Moved sent file to Logs/20240105T223408/Express0026.lzma.bak
2024-01-05T23:57:33.358Z,1704499053.358 [DataOverHttps](INFO): SBD MOMSN=19142493
2024-01-05T23:57:35.122Z,1704499055.122 [Default:CheckIn:Read_Iridium] Stopped
2024-01-05T23:57:35.122Z,1704499055.122 [Default:CheckIn:C.Wait] Running Loop=1
2024-01-05T23:57:35.122Z,1704499055.122 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-01-05T23:58:47.422Z,1704499127.422 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 28
2024-01-05T23:58:47.422Z,1704499127.422 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-01-05T23:58:47.432Z,1704499127.432 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-01-05T23:58:47.853Z,1704499127.853 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-01-05T23:58:47.853Z,1704499127.853 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 28
2024-01-06T00:01:40.327Z,1704499300.327 [NAL9602](FAULT): GPS failed to acquire within timeout.
2024-01-06T00:01:40.328Z,1704499300.328 [NAL9602] Data Fault, FailCount= 3
2024-01-06T00:01:40.328Z,1704499300.328 [NAL9602](ERROR): Data Fault
2024-01-06T00:01:40.377Z,1704499300.377 [CBIT](ERROR): Data Fault in component: NAL9602
2024-01-06T00:01:40.727Z,1704499300.727 [NAL9602](INFO): Powering down
2024-01-06T00:01:41.570Z,1704499301.570 [CBIT](INFO): Clearing failed state for component NAL9602
2024-01-06T00:01:41.570Z,1704499301.570 [NAL9602] No Fault, FailCount= 3
2024-01-06T00:01:48.436Z,1704499308.436 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 29
2024-01-06T00:01:48.437Z,1704499308.437 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-01-06T00:01:48.506Z,1704499308.506 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-01-06T00:01:48.874Z,1704499308.874 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-01-06T00:01:48.875Z,1704499308.875 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 29
2024-01-06T00:02:11.025Z,1704499331.025 [NAL9602](INFO): Powering up NAL9602
2024-01-06T00:02:21.937Z,1704499341.937 [NAL9602](INFO): NAL9602 initialized
2024-01-06T00:02:35.695Z,1704499355.695 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-01-06T00:02:35.696Z,1704499355.696 [Default:CheckIn:C.Wait] Stopped
2024-01-06T00:02:35.696Z,1704499355.696 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-01-06T00:02:35.696Z,1704499355.696 [Default:CheckIn:D] Running Loop=1
2024-01-06T00:02:36.087Z,1704499356.087 [Default:CheckIn:D] Stopped
2024-01-06T00:02:36.087Z,1704499356.087 [Default:CheckIn:E] Running Loop=1
2024-01-06T00:02:36.537Z,1704499356.537 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 84.573006 min 
2024-01-06T00:02:36.537Z,1704499356.537 [Default:CheckIn:E] Stopped
2024-01-06T00:02:36.538Z,1704499356.538 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-01-06T00:02:36.538Z,1704499356.538 [Default:CheckIn] Stopped
2024-01-06T00:02:36.538Z,1704499356.538 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-01-06T00:02:36.538Z,1704499356.538 [Default:CheckIn](INFO): Running loop #9
2024-01-06T00:02:36.538Z,1704499356.538 [Default:CheckIn] Running Loop=9
2024-01-06T00:02:36.538Z,1704499356.538 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-01-06T00:02:36.538Z,1704499356.538 [Default:CheckIn:Read_GPS] Running Loop=1
2024-01-06T00:04:24.349Z,1704499464.349 [DropWeight](CRITICAL): DROP WEIGHT MISSING.

2024-01-06T00:04:24.349Z,1704499464.349 [DropWeight] Hardware Fault, FailCount= 1
2024-01-06T00:04:24.349Z,1704499464.349 [DropWeight](ERROR): Hardware Fault
2024-01-06T00:04:24.422Z,1704499464.422 [CBIT](INFO): Critical error at 20240106T000424
2024-01-06T00:04:24.428Z,1704499464.428 [CBIT](ERROR): Hardware Fault in component: DropWeight
2024-01-06T00:04:24.429Z,1704499464.429 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2024-01-06T00:04:24.796Z,1704499464.796 [CBIT](INFO): Critical error at 20240106T000424
2024-01-06T00:04:49.416Z,1704499489.416 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 30
2024-01-06T00:04:49.416Z,1704499489.416 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-01-06T00:04:49.428Z,1704499489.428 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-01-06T00:04:49.835Z,1704499489.835 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-01-06T00:04:49.835Z,1704499489.835 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 30
2024-01-06T00:07:36.694Z,1704499656.694 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-01-06T00:02:36.5Z
2024-01-06T00:07:36.694Z,1704499656.694 [Default:CheckIn:Read_GPS] Stopped
2024-01-06T00:07:36.694Z,1704499656.694 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-01-06T00:07:44.203Z,1704499664.203 [DataOverHttps](INFO): Sending 114 bytes from file Logs/20240105T223408/Courier0028.lzma
2024-01-06T00:07:45.206Z,1704499665.206 [DataOverHttps](INFO): Moved sent file to Logs/20240105T223408/Courier0028.lzma.bak
2024-01-06T00:07:45.206Z,1704499665.206 [DataOverHttps](INFO): SBD MOMSN=19142503
2024-01-06T00:07:50.402Z,1704499670.402 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 31
2024-01-06T00:07:50.402Z,1704499670.402 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-01-06T00:07:50.429Z,1704499670.429 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-01-06T00:07:50.881Z,1704499670.881 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-01-06T00:07:50.882Z,1704499670.882 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 31
2024-01-06T00:08:01.212Z,1704499681.212 [DataOverHttps](INFO): Sending 150 bytes from file Logs/20240105T223408/Express0029.lzma
2024-01-06T00:08:02.214Z,1704499682.214 [DataOverHttps](INFO): Moved sent file to Logs/20240105T223408/Express0029.lzma.bak
2024-01-06T00:08:02.214Z,1704499682.214 [DataOverHttps](INFO): SBD MOMSN=19142507
2024-01-06T00:08:03.750Z,1704499683.750 [Default:CheckIn:Read_Iridium] Stopped
2024-01-06T00:08:03.750Z,1704499683.750 [Default:CheckIn:C.Wait] Running Loop=1
2024-01-06T00:08:03.751Z,1704499683.751 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-01-06T00:10:51.388Z,1704499851.388 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 32
2024-01-06T00:10:51.388Z,1704499851.388 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-01-06T00:10:51.399Z,1704499851.399 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-01-06T00:10:51.806Z,1704499851.806 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-01-06T00:10:51.807Z,1704499851.807 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 32
2024-01-06T00:12:24.297Z,1704499944.297 [NAL9602](FAULT): GPS failed to acquire within timeout.
2024-01-06T00:12:24.297Z,1704499944.297 [NAL9602] Data Fault, FailCount= 4
2024-01-06T00:12:24.297Z,1704499944.297 [NAL9602](ERROR): Data Fault
2024-01-06T00:12:24.365Z,1704499944.365 [CBIT](ERROR): Data Fault in component: NAL9602
2024-01-06T00:12:24.710Z,1704499944.710 [NAL9602](INFO): Powering down
2024-01-06T00:12:25.536Z,1704499945.536 [CBIT](INFO): Clearing failed state for component NAL9602
2024-01-06T00:12:25.537Z,1704499945.537 [NAL9602] No Fault, FailCount= 4
2024-01-06T00:12:55.001Z,1704499975.001 [NAL9602](INFO): Powering up NAL9602
2024-01-06T00:13:04.309Z,1704499984.309 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-01-06T00:13:04.309Z,1704499984.309 [Default:CheckIn:C.Wait] Stopped
2024-01-06T00:13:04.309Z,1704499984.309 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-01-06T00:13:04.310Z,1704499984.310 [Default:CheckIn:D] Running Loop=1
2024-01-06T00:13:04.737Z,1704499984.737 [Default:CheckIn:D] Stopped
2024-01-06T00:13:04.737Z,1704499984.737 [Default:CheckIn:E] Running Loop=1
2024-01-06T00:13:05.118Z,1704499985.118 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 95.050505 min 
2024-01-06T00:13:05.118Z,1704499985.118 [Default:CheckIn:E] Stopped
2024-01-06T00:13:05.119Z,1704499985.119 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-01-06T00:13:05.119Z,1704499985.119 [Default:CheckIn] Stopped
2024-01-06T00:13:05.119Z,1704499985.119 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-01-06T00:13:05.119Z,1704499985.119 [Default:CheckIn](INFO): Running loop #10
2024-01-06T00:13:05.119Z,1704499985.119 [Default:CheckIn] Running Loop=10
2024-01-06T00:13:05.119Z,1704499985.119 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-01-06T00:13:05.119Z,1704499985.119 [Default:CheckIn:Read_GPS] Running Loop=1
2024-01-06T00:13:05.913Z,1704499985.913 [NAL9602](INFO): NAL9602 initialized
2024-01-06T00:13:52.408Z,1704500032.408 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 33
2024-01-06T00:13:52.408Z,1704500032.408 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-01-06T00:13:52.421Z,1704500032.421 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-01-06T00:13:52.830Z,1704500032.830 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-01-06T00:13:52.830Z,1704500032.830 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 33
2024-01-06T00:16:53.383Z,1704500213.383 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 34
2024-01-06T00:16:53.383Z,1704500213.383 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-01-06T00:16:53.394Z,1704500213.394 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-01-06T00:16:53.792Z,1704500213.792 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-01-06T00:16:53.792Z,1704500213.792 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 34
2024-01-06T00:18:05.310Z,1704500285.310 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-01-06T00:13:05.1Z
2024-01-06T00:18:05.310Z,1704500285.310 [Default:CheckIn:Read_GPS] Stopped
2024-01-06T00:18:05.311Z,1704500285.311 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-01-06T00:18:13.095Z,1704500293.095 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240105T223408/Courier0031.lzma
2024-01-06T00:18:14.098Z,1704500294.098 [DataOverHttps](INFO): Moved sent file to Logs/20240105T223408/Courier0031.lzma.bak
2024-01-06T00:18:14.098Z,1704500294.098 [DataOverHttps](INFO): SBD MOMSN=19142517
2024-01-06T00:18:29.177Z,1704500309.177 [DataOverHttps](INFO): Sending 148 bytes from file Logs/20240105T223408/Express0032.lzma
2024-01-06T00:18:30.142Z,1704500310.142 [DataOverHttps](INFO): Moved sent file to Logs/20240105T223408/Express0032.lzma.bak
2024-01-06T00:18:30.142Z,1704500310.142 [DataOverHttps](INFO): SBD MOMSN=19142519
2024-01-06T00:18:31.557Z,1704500311.557 [Default:CheckIn:Read_Iridium] Stopped
2024-01-06T00:18:31.557Z,1704500311.557 [Default:CheckIn:C.Wait] Running Loop=1
2024-01-06T00:18:31.557Z,1704500311.557 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-01-06T00:19:24.555Z,1704500364.555 [CBIT](INFO): Clearing failed state for component DropWeight
2024-01-06T00:19:24.555Z,1704500364.555 [DropWeight] No Fault, FailCount= 1
2024-01-06T00:19:54.392Z,1704500394.392 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 35
2024-01-06T00:19:54.392Z,1704500394.392 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-01-06T00:19:54.403Z,1704500394.403 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-01-06T00:19:54.840Z,1704500394.840 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-01-06T00:19:54.840Z,1704500394.840 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 35
2024-01-06T00:22:55.367Z,1704500575.367 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 36
2024-01-06T00:22:55.367Z,1704500575.367 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-01-06T00:22:55.379Z,1704500575.379 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-01-06T00:22:55.791Z,1704500575.791 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-01-06T00:22:55.791Z,1704500575.791 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 36
2024-01-06T00:23:08.281Z,1704500588.281 [NAL9602](FAULT): GPS failed to acquire within timeout.
2024-01-06T00:23:08.281Z,1704500588.281 [NAL9602] Data Fault, FailCount= 5
2024-01-06T00:23:08.281Z,1704500588.281 [NAL9602](ERROR): Data Fault
2024-01-06T00:23:08.305Z,1704500588.305 [CBIT](ERROR): Data Fault in component: NAL9602
2024-01-06T00:23:08.305Z,1704500588.305 [CBIT](CRITICAL): Data Fault in component: NAL9602
2024-01-06T00:23:08.687Z,1704500588.687 [NAL9602](INFO): Powering down
2024-01-06T00:23:08.746Z,1704500588.746 [CBIT](INFO): Critical error at 20240106T002308
2024-01-06T00:23:32.134Z,1704500612.134 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-01-06T00:23:32.134Z,1704500612.134 [Default:CheckIn:C.Wait] Stopped
2024-01-06T00:23:32.134Z,1704500612.134 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-01-06T00:23:32.134Z,1704500612.134 [Default:CheckIn:D] Running Loop=1
2024-01-06T00:23:32.558Z,1704500612.558 [Default:CheckIn:D] Stopped
2024-01-06T00:23:32.559Z,1704500612.559 [Default:CheckIn:E] Running Loop=1
2024-01-06T00:23:32.934Z,1704500612.934 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 105.514201 min 
2024-01-06T00:23:32.934Z,1704500612.934 [Default:CheckIn:E] Stopped
2024-01-06T00:23:32.935Z,1704500612.935 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-01-06T00:23:32.935Z,1704500612.935 [Default:CheckIn] Stopped
2024-01-06T00:23:32.935Z,1704500612.935 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-01-06T00:23:32.935Z,1704500612.935 [Default:CheckIn](INFO): Running loop #11
2024-01-06T00:23:32.935Z,1704500612.935 [Default:CheckIn] Running Loop=11
2024-01-06T00:23:32.935Z,1704500612.935 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-01-06T00:23:32.935Z,1704500612.935 [Default:CheckIn:Read_GPS] Running Loop=1
2024-01-06T00:24:40.381Z,1704500680.381 [CommandExec](IMPORTANT): got command quit
2024-01-06T00:24:41.384Z,1704500681.384 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread.
2024-01-06T00:24:41.384Z,1704500681.384 [CommandExec](INFO): Uninitializing the command executive.
2024-01-06T00:24:41.384Z,1704500681.384 [CommandExec](INFO): Uninitializing the command scheduler.
2024-01-06T00:24:41.384Z,1704500681.384 [CommandExec ThreadHandler](INFO): Thread cancelled.
2024-01-06T00:24:41.524Z,1704500681.524 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2024-01-06T00:24:41.524Z,1704500681.524 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2024-01-06T00:24:41.524Z,1704500681.524 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2024-01-06T00:24:41.525Z,1704500681.525 [NavChartDb](INFO): Join timeout helper Thread ID is 1035
2024-01-06T00:24:41.760Z,1704500681.760 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2024-01-06T00:24:41.760Z,1704500681.760 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2024-01-06T00:24:41.768Z,1704500681.768 [ComponentRegistry](INFO): Shutting down WetLabsUBAT ThreadHandler
2024-01-06T00:24:41.768Z,1704500681.768 [WetLabsUBAT ThreadHandler](INFO): Thread cancelled.
2024-01-06T00:24:41.769Z,1704500681.769 [WetLabsUBAT](INFO): Join timeout helper Thread ID is 1036
2024-01-06T00:24:42.160Z,1704500682.160 [WetLabsUBAT ThreadHandler](INFO): Uninitializing protected caller thread.
2024-01-06T00:24:42.160Z,1704500682.160 [WetLabsUBAT](INFO): Powering down
2024-01-06T00:24:42.161Z,1704500682.161 [WetLabsUBAT ThreadHandler](INFO): Thread cancelled.
2024-01-06T00:24:42.164Z,1704500682.164 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2024-01-06T00:24:42.164Z,1704500682.164 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2024-01-06T00:24:42.164Z,1704500682.164 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 1037
2024-01-06T00:24:42.652Z,1704500682.652 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2024-01-06T00:24:42.652Z,1704500682.652 [WetLabsBB2FL](INFO): Powering down
2024-01-06T00:24:42.653Z,1704500682.653 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2024-01-06T00:24:42.660Z,1704500682.660 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2024-01-06T00:24:42.660Z,1704500682.660 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2024-01-06T00:24:42.660Z,1704500682.660 [CTD_Seabird](INFO): Join timeout helper Thread ID is 1038
2024-01-06T00:24:42.668Z,1704500682.668 [CTD_Seabird](INFO): Powering down
2024-01-06T00:24:42.680Z,1704500682.680 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2024-01-06T00:24:42.680Z,1704500682.680 [CTD_Seabird](INFO): Powering down
2024-01-06T00:24:42.700Z,1704500682.700 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2024-01-06T00:24:42.720Z,1704500682.720 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2024-01-06T00:24:42.720Z,1704500682.720 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2024-01-06T00:24:42.720Z,1704500682.720 [Radio_Surface](INFO): Join timeout helper Thread ID is 1039
2024-01-06T00:24:42.988Z,1704500682.988 [Radio_Surface](INFO): Powering down
2024-01-06T00:24:42.989Z,1704500682.989 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2024-01-06T00:24:42.989Z,1704500682.989 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2024-01-06T00:24:42.997Z,1704500682.997 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2024-01-06T00:24:42.997Z,1704500682.997 [Onboard ThreadHandler](INFO): Thread cancelled.
2024-01-06T00:24:42.997Z,1704500682.997 [Onboard](INFO): Join timeout helper Thread ID is 1040
2024-01-06T00:24:43.104Z,1704500683.104 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2024-01-06T00:24:45.668Z,1704500685.668 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2024-01-06T00:24:45.668Z,1704500685.668 [Onboard ThreadHandler](INFO): Thread cancelled.
2024-01-06T00:24:45.677Z,1704500685.677 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2024-01-06T00:24:45.677Z,1704500685.677 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2024-01-06T00:24:45.677Z,1704500685.677 [DataOverHttps](INFO): Join timeout helper Thread ID is 1041
2024-01-06T00:24:46.116Z,1704500686.116 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2024-01-06T00:24:46.116Z,1704500686.116 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2024-01-06T00:24:46.129Z,1704500686.129 [ComponentRegistry](INFO): Shutting down DATMMP ThreadHandler
2024-01-06T00:24:46.129Z,1704500686.129 [DATMMP ThreadHandler](INFO): Thread cancelled.
2024-01-06T00:24:46.129Z,1704500686.129 [DATMMP](INFO): Join timeout helper Thread ID is 1042
2024-01-06T00:24:46.284Z,1704500686.284 [DATMMP](INFO): Stop
2024-01-06T00:24:46.284Z,1704500686.284 [DATMMP](INFO): uninitialize
2024-01-06T00:24:46.284Z,1704500686.284 [DATMMP](INFO): Powering down
2024-01-06T00:24:46.357Z,1704500686.357 [DATMMP ThreadHandler](INFO): Uninitializing protected caller thread.
2024-01-06T00:24:46.357Z,1704500686.357 [DATMMP](INFO): uninitialize
2024-01-06T00:24:46.357Z,1704500686.357 [DATMMP](INFO): Powering down
2024-01-06T00:24:46.358Z,1704500686.358 [DATMMP ThreadHandler](INFO): Thread cancelled.
2024-01-06T00:24:46.364Z,1704500686.365 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler
2024-01-06T00:24:46.365Z,1704500686.365 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2024-01-06T00:24:46.365Z,1704500686.365 [BackseatComponent](INFO): Join timeout helper Thread ID is 1043
2024-01-06T00:24:46.444Z,1704500686.444 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread.
2024-01-06T00:24:46.445Z,1704500686.445 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2024-01-06T00:24:46.450Z,1704500686.450 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2024-01-06T00:24:46.450Z,1704500686.450 [logger ThreadHandler](INFO): Thread cancelled.
2024-01-06T00:24:46.451Z,1704500686.451 [logger](INFO): Join timeout helper Thread ID is 1044
2024-01-06T00:24:46.452Z,1704500686.452 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2024-01-06T00:24:46.453Z,1704500686.453 [logger ThreadHandler](INFO): Thread cancelled.
2024-01-06T00:24:46.455Z,1704500686.455 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2024-01-06T00:24:46.455Z,1704500686.455 [CommandLine ThreadHandler](INFO): Thread cancelled.
2024-01-06T00:24:46.457Z,1704500686.457 [CommandLine](INFO): Join timeout helper Thread ID is 1045
2024-01-06T00:24:46.548Z,1704500686.548 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2024-01-06T00:24:46.548Z,1704500686.548 [CommandLine ThreadHandler](INFO): Thread cancelled.
2024-01-06T00:24:46.561Z,1704500686.561 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler
2024-01-06T00:24:46.561Z,1704500686.561 [CommandExec ThreadHandler](INFO): Thread cancelled.
2024-01-06T00:24:46.561Z,1704500686.561 [CommandExec](INFO): Join timeout helper Thread ID is 1046
2024-01-06T00:24:46.562Z,1704500686.562 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2024-01-06T00:24:46.562Z,1704500686.562 [controlThread ThreadHandler](INFO): Thread cancelled.
2024-01-06T00:24:46.563Z,1704500686.563 [controlThread](INFO): Join timeout helper Thread ID is 1047
2024-01-06T00:24:46.840Z,1704500686.840 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2024-01-06T00:24:46.840Z,1704500686.840 [controlThread](DEBUG): Uninitializing ControlThread
2024-01-06T00:24:46.841Z,1704500686.841 [AHRS_M2](INFO): Powering down
2024-01-06T00:24:46.913Z,1704500686.913 [NAL9602](INFO): Powering down
2024-01-06T00:24:46.984Z,1704500686.984 [RDI_Pathfinder](INFO): Powering down
2024-01-06T00:24:46.985Z,1704500686.985 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2024-01-06T00:24:46.986Z,1704500686.986 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2024-01-06T00:24:46.987Z,1704500686.987 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2024-01-06T00:24:46.987Z,1704500686.987 [MissionManager](INFO): Uninitializing Mission Default
2024-01-06T00:24:46.987Z,1704500686.987 [Default] Stopped
2024-01-06T00:24:46.987Z,1704500686.987 [Default](DEBUG): Aggregate::uninitialize Default
2024-01-06T00:24:46.987Z,1704500686.987 [Default:B.GoToSurface] Stopped
2024-01-06T00:24:46.987Z,1704500686.987 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2024-01-06T00:24:46.987Z,1704500686.987 [Default:CheckIn] Stopped
2024-01-06T00:24:46.988Z,1704500686.988 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-01-06T00:24:46.988Z,1704500686.988 [Default:CheckIn:Read_GPS] Stopped
2024-01-06T00:24:46.990Z,1704500686.990 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2024-01-06T00:24:46.991Z,1704500686.991 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2024-01-06T00:24:46.991Z,1704500686.991 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2024-01-06T00:24:46.991Z,1704500686.991 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2024-01-06T00:24:46.992Z,1704500686.992 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2024-01-06T00:24:46.992Z,1704500686.992 [BuoyancyServo](INFO): Powering down
2024-01-06T00:24:47.004Z,1704500687.004 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2024-01-06T00:24:47.004Z,1704500687.004 [ElevatorServo](INFO): Powering down
2024-01-06T00:24:47.005Z,1704500687.005 [MassServo](DEBUG): Uninitialize Mass Servo.
2024-01-06T00:24:47.005Z,1704500687.005 [MassServo](INFO): Powering down
2024-01-06T00:24:47.006Z,1704500687.006 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2024-01-06T00:24:47.006Z,1704500687.006 [RudderServo](INFO): Powering down
2024-01-06T00:24:47.007Z,1704500687.007 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2024-01-06T00:24:47.007Z,1704500687.007 [ThrusterServo](INFO): Powering down
2024-01-06T00:24:47.008Z,1704500687.008 [SBIT](DEBUG): Uninitialize SBIT Component.
2024-01-06T00:24:47.008Z,1704500687.008 [IBIT](DEBUG): Uninitialize IBIT Component.
2024-01-06T00:24:47.008Z,1704500687.008 [CBIT](DEBUG): Uninitialize CBIT Component.
2024-01-06T00:24:47.009Z,1704500687.009 [CBIT](DEBUG): Powering off loads.
2024-01-06T00:24:47.020Z,1704500687.020 [CBIT](DEBUG): Disabling WDT.
2024-01-06T00:24:47.032Z,1704500687.032 [CBIT](DEBUG): Opening all GF detection circuits.
2024-01-06T00:24:47.033Z,1704500687.033 [controlThread ThreadHandler](INFO): Thread cancelled.
2024-01-06T00:24:47.087Z,1704500687.087 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2024-01-06T00:24:47.090Z,1704500687.090 [Onboard ThreadHandler](INFO): Thread cancelled.
2024-01-06T00:24:47.096Z,1704500687.096 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2024-01-06T00:24:47.103Z,1704500687.103 [DATMMP ThreadHandler](INFO): Thread cancelled.
2024-01-06T00:24:47.145Z,1704500687.145 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2024-01-06T00:24:47.204Z,1704500687.204 [WetLabsUBAT ThreadHandler](INFO): Thread cancelled.
2024-01-06T00:24:47.206Z,1704500687.206 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2024-01-06T00:24:47.210Z,1704500687.210 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2024-01-06T00:24:47.218Z,1704500687.218 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2024-01-06T00:24:47.282Z,1704500687.282 [logger ThreadHandler](INFO): Thread cancelled.