2023-12-08T21:03:52.570Z,1702069432.570 [Supervisor](DEBUG): Initializing supervisor.
2023-12-08T21:03:52.574Z,1702069432.574 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2023-12-08T21:03:52.575Z,1702069432.575 [SyncHandler](INFO): Protected caller Thread ID is 4801
2023-12-08T21:03:52.575Z,1702069432.575 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2023-12-08T21:03:52.576Z,1702069432.576 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2023-12-08T21:03:52.576Z,1702069432.576 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 4802
2023-12-08T21:03:52.580Z,1702069432.580 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2023-12-08T21:03:52.597Z,1702069432.597 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2023-12-08T21:03:52.598Z,1702069432.598 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2023-12-08T21:03:52.599Z,1702069432.599 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 4803
2023-12-08T21:03:52.603Z,1702069432.603 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2023-12-08T21:03:52.604Z,1702069432.604 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2023-12-08T21:03:52.604Z,1702069432.604 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 4804
2023-12-08T21:03:52.606Z,1702069432.606 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2023-12-08T21:03:52.607Z,1702069432.607 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2023-12-08T21:03:52.607Z,1702069432.607 [logger ThreadHandler](INFO): Protected caller Thread ID is 4805
2023-12-08T21:03:52.611Z,1702069432.611 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2023-12-08T21:03:52.611Z,1702069432.611 [Supervisor](INFO): Looking for Config files in directory: Config/
2023-12-08T21:03:52.613Z,1702069432.613 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2023-12-08T21:03:52.862Z,1702069432.862 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2023-12-08T21:03:52.862Z,1702069432.862 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2023-12-08T21:03:52.942Z,1702069432.942 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2023-12-08T21:03:53.397Z,1702069433.397 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2023-12-08T21:03:53.397Z,1702069433.397 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2023-12-08T21:03:53.708Z,1702069433.708 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2023-12-08T21:03:53.708Z,1702069433.708 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2023-12-08T21:03:53.803Z,1702069433.803 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2023-12-08T21:03:53.804Z,1702069433.804 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2023-12-08T21:03:54.183Z,1702069434.183 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2023-12-08T21:03:54.184Z,1702069434.184 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2023-12-08T21:03:54.394Z,1702069434.394 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2023-12-08T21:03:54.394Z,1702069434.394 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2023-12-08T21:03:54.905Z,1702069434.905 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2023-12-08T21:03:54.906Z,1702069434.906 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2023-12-08T21:03:55.042Z,1702069435.042 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2023-12-08T21:03:55.042Z,1702069435.042 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2023-12-08T21:03:55.121Z,1702069435.121 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2023-12-08T21:03:55.880Z,1702069435.880 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2023-12-08T21:03:55.881Z,1702069435.881 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2023-12-08T21:03:56.244Z,1702069436.244 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2023-12-08T21:03:56.244Z,1702069436.244 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2023-12-08T21:03:56.423Z,1702069436.423 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2023-12-08T21:03:56.424Z,1702069436.424 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2023-12-08T21:03:56.534Z,1702069436.534 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2023-12-08T21:03:56.535Z,1702069436.535 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2023-12-08T21:03:56.757Z,1702069436.757 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2023-12-08T21:03:56.757Z,1702069436.757 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2023-12-08T21:03:56.993Z,1702069436.993 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2023-12-08T21:03:56.995Z,1702069436.995 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-daphne/
2023-12-08T21:03:56.995Z,1702069436.995 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Navigation.cfg
2023-12-08T21:03:57.086Z,1702069437.086 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Simulator.cfg
2023-12-08T21:03:57.173Z,1702069437.173 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Control.cfg
2023-12-08T21:03:57.326Z,1702069437.326 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/secure.cfg
2023-12-08T21:03:57.471Z,1702069437.471 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Servo.cfg
2023-12-08T21:03:57.648Z,1702069437.648 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/BIT.cfg
2023-12-08T21:03:58.001Z,1702069438.001 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/vehicle.cfg
2023-12-08T21:03:58.185Z,1702069438.185 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/workSite.cfg
2023-12-08T21:03:58.443Z,1702069438.443 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Sensor.cfg
2023-12-08T21:03:58.589Z,1702069438.589 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Science.cfg
2023-12-08T21:03:58.725Z,1702069438.725 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/logger.cfg
2023-12-08T21:03:58.834Z,1702069438.834 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Battery.cfg
2023-12-08T21:03:59.103Z,1702069439.103 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2023-12-08T21:03:59.104Z,1702069439.104 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2023-12-08T21:03:59.113Z,1702069439.113 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2023-12-08T21:03:59.167Z,1702069439.167 [VerticalControl](DEBUG): Construct VerticalControl.
2023-12-08T21:03:59.226Z,1702069439.226 [VerticalControl] Loaded
2023-12-08T21:03:59.226Z,1702069439.226 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2023-12-08T21:03:59.229Z,1702069439.229 [HorizontalControl](DEBUG): Construct HorizontalControl.
2023-12-08T21:03:59.269Z,1702069439.269 [HorizontalControl] Loaded
2023-12-08T21:03:59.269Z,1702069439.269 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2023-12-08T21:03:59.271Z,1702069439.271 [SpeedControl](DEBUG): Construct SpeedControl.
2023-12-08T21:03:59.275Z,1702069439.275 [SpeedControl] Loaded
2023-12-08T21:03:59.275Z,1702069439.275 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2023-12-08T21:03:59.277Z,1702069439.277 [LoopControl](DEBUG): Construct LoopControl.
2023-12-08T21:03:59.278Z,1702069439.278 [LoopControl] Loaded
2023-12-08T21:03:59.278Z,1702069439.278 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2023-12-08T21:03:59.279Z,1702069439.279 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2023-12-08T21:03:59.279Z,1702069439.279 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2023-12-08T21:03:59.289Z,1702069439.289 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2023-12-08T21:03:59.290Z,1702069439.290 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2023-12-08T21:03:59.447Z,1702069439.447 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2023-12-08T21:03:59.448Z,1702069439.448 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2023-12-08T21:03:59.585Z,1702069439.585 [BuoyancyServo] Loaded
2023-12-08T21:03:59.586Z,1702069439.586 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2023-12-08T21:03:59.606Z,1702069439.606 [ElevatorServo] Loaded
2023-12-08T21:03:59.606Z,1702069439.606 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2023-12-08T21:03:59.625Z,1702069439.625 [MassServo] Loaded
2023-12-08T21:03:59.625Z,1702069439.625 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2023-12-08T21:03:59.643Z,1702069439.643 [RudderServo] Loaded
2023-12-08T21:03:59.643Z,1702069439.643 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2023-12-08T21:03:59.658Z,1702069439.658 [ThrusterHE] Loaded
2023-12-08T21:03:59.658Z,1702069439.658 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread.
2023-12-08T21:03:59.658Z,1702069439.658 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2023-12-08T21:03:59.659Z,1702069439.659 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2023-12-08T21:03:59.777Z,1702069439.777 [DeadReckonUsingMultipleVelocitySources] Loaded
2023-12-08T21:03:59.777Z,1702069439.777 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2023-12-08T21:03:59.790Z,1702069439.790 [NavChart] Loaded
2023-12-08T21:03:59.791Z,1702069439.791 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2023-12-08T21:03:59.796Z,1702069439.796 [UniversalFixResidualReporter] Loaded
2023-12-08T21:03:59.796Z,1702069439.796 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2023-12-08T21:03:59.797Z,1702069439.797 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2023-12-08T21:03:59.797Z,1702069439.797 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2023-12-08T21:03:59.856Z,1702069439.856 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2023-12-08T21:03:59.857Z,1702069439.857 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2023-12-08T21:04:00.306Z,1702069440.306 [AHRS_M2] Loaded
2023-12-08T21:04:00.306Z,1702069440.306 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2023-12-08T21:04:01.148Z,1702069441.148 [BPC1] Loaded
2023-12-08T21:04:01.148Z,1702069441.148 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2023-12-08T21:04:01.220Z,1702069441.220 [DataOverHttps] Loaded
2023-12-08T21:04:01.220Z,1702069441.220 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2023-12-08T21:04:01.222Z,1702069441.222 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 4090E4E0
2023-12-08T21:04:01.222Z,1702069441.222 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 4891
2023-12-08T21:04:01.243Z,1702069441.243 [Depth_Keller] Loaded
2023-12-08T21:04:01.243Z,1702069441.243 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2023-12-08T21:04:01.248Z,1702069441.248 [DropWeight] Loaded
2023-12-08T21:04:01.248Z,1702069441.248 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2023-12-08T21:04:01.311Z,1702069441.311 [NAL9602] Loaded
2023-12-08T21:04:01.311Z,1702069441.311 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2023-12-08T21:04:01.342Z,1702069441.342 [Onboard] Loaded
2023-12-08T21:04:01.342Z,1702069441.342 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2023-12-08T21:04:01.343Z,1702069441.343 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 4093E4E0
2023-12-08T21:04:01.343Z,1702069441.343 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 4892
2023-12-08T21:04:01.357Z,1702069441.357 [Power24vConverter] Loaded
2023-12-08T21:04:01.358Z,1702069441.358 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2023-12-08T21:04:01.371Z,1702069441.371 [Radio_Surface] Loaded
2023-12-08T21:04:01.371Z,1702069441.371 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2023-12-08T21:04:01.372Z,1702069441.372 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 4096E4E0
2023-12-08T21:04:01.373Z,1702069441.373 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 4893
2023-12-08T21:04:01.386Z,1702069441.386 [Sonardyne_Nano] Loaded
2023-12-08T21:04:01.387Z,1702069441.387 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread.
2023-12-08T21:04:01.387Z,1702069441.387 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2023-12-08T21:04:01.388Z,1702069441.388 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2023-12-08T21:04:01.440Z,1702069441.440 [DepthRateCalculator] Loaded
2023-12-08T21:04:01.440Z,1702069441.440 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2023-12-08T21:04:01.445Z,1702069441.445 [PitchRateCalculator] Loaded
2023-12-08T21:04:01.446Z,1702069441.446 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2023-12-08T21:04:01.454Z,1702069441.454 [SpeedCalculator] Loaded
2023-12-08T21:04:01.454Z,1702069441.454 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2023-12-08T21:04:01.459Z,1702069441.459 [YawRateCalculator] Loaded
2023-12-08T21:04:01.459Z,1702069441.459 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2023-12-08T21:04:01.477Z,1702069441.477 [ElevatorOffsetCalculator] Loaded
2023-12-08T21:04:01.478Z,1702069441.478 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2023-12-08T21:04:01.478Z,1702069441.478 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2023-12-08T21:04:01.479Z,1702069441.479 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2023-12-08T21:04:01.617Z,1702069441.617 [CANONSampler] Loaded
2023-12-08T21:04:01.617Z,1702069441.617 [ComponentRegistry](DEBUG): SyncComponent "CANONSampler" handled in the control thread.
2023-12-08T21:04:01.679Z,1702069441.679 [CTD_Seabird] Loaded
2023-12-08T21:04:01.679Z,1702069441.679 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2023-12-08T21:04:01.680Z,1702069441.680 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40A294E0
2023-12-08T21:04:01.681Z,1702069441.681 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 4894
2023-12-08T21:04:01.701Z,1702069441.701 [PAR_Licor] Loaded
2023-12-08T21:04:01.701Z,1702069441.701 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2023-12-08T21:04:01.741Z,1702069441.741 [WetLabsBB2FL] Loaded
2023-12-08T21:04:01.741Z,1702069441.741 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2023-12-08T21:04:01.742Z,1702069441.742 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40A594E0
2023-12-08T21:04:01.742Z,1702069441.742 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 4895
2023-12-08T21:04:01.743Z,1702069441.743 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2023-12-08T21:04:01.743Z,1702069441.743 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2023-12-08T21:04:01.772Z,1702069441.772 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2023-12-08T21:04:01.772Z,1702069441.772 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2023-12-08T21:04:02.101Z,1702069442.101 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2023-12-08T21:04:02.101Z,1702069442.101 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2023-12-08T21:04:02.253Z,1702069442.253 [SBIT](DEBUG): Construct Startup Built In Test.
2023-12-08T21:04:02.262Z,1702069442.262 [SBIT] Loaded
2023-12-08T21:04:02.262Z,1702069442.262 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2023-12-08T21:04:02.265Z,1702069442.265 [IBIT](DEBUG): Construct Initiated Built In Test.
2023-12-08T21:04:02.278Z,1702069442.278 [IBIT] Loaded
2023-12-08T21:04:02.279Z,1702069442.279 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2023-12-08T21:04:02.284Z,1702069442.284 [CBIT](DEBUG): Construct Continuous Built In Test.
2023-12-08T21:04:02.387Z,1702069442.387 [CBIT] Loaded
2023-12-08T21:04:02.387Z,1702069442.387 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2023-12-08T21:04:02.388Z,1702069442.388 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2023-12-08T21:04:02.388Z,1702069442.388 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2023-12-08T21:04:02.657Z,1702069442.657 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2023-12-08T21:04:02.668Z,1702069442.668 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2023-12-08T21:04:02.672Z,1702069442.672 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2023-12-08T21:04:02.683Z,1702069442.683 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2023-12-08T21:04:02.684Z,1702069442.684 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40B944E0
2023-12-08T21:04:02.685Z,1702069442.685 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 4896
2023-12-08T21:04:02.689Z,1702069442.689 [Supervisor](INFO): Main Thread ID is 4800
2023-12-08T21:04:02.689Z,1702069442.689 [Supervisor](DEBUG): Running supervisor.
2023-12-08T21:04:02.690Z,1702069442.690 [CommandExec ThreadHandler](INFO): Handler Thread ID is 4897
2023-12-08T21:04:02.690Z,1702069442.690 [CommandExec](INFO): Initializing the command executive.
2023-12-08T21:04:02.692Z,1702069442.692 [CommandLine ThreadHandler](INFO): Handler Thread ID is 4898
2023-12-08T21:04:02.694Z,1702069442.694 [controlThread ThreadHandler](INFO): Handler Thread ID is 4899
2023-12-08T21:04:02.695Z,1702069442.695 [controlThread](DEBUG): Initializing ControlThread
2023-12-08T21:04:02.695Z,1702069442.695 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2023-12-08T21:04:02.698Z,1702069442.698 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2023-12-08T21:04:02.698Z,1702069442.698 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2023-12-08T21:04:02.699Z,1702069442.699 [LoopControl](DEBUG): Initialize LoopControlComponent.
2023-12-08T21:04:02.701Z,1702069442.701 [NavChart](DEBUG): Initialize NavChart Navigation.
2023-12-08T21:04:02.701Z,1702069442.701 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2023-12-08T21:04:02.707Z,1702069442.707 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2023-12-08T21:04:02.707Z,1702069442.707 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2023-12-08T21:04:02.707Z,1702069442.707 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2023-12-08T21:04:02.708Z,1702069442.708 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2023-12-08T21:04:02.708Z,1702069442.708 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2023-12-08T21:04:02.713Z,1702069442.713 [SBIT](INFO): Initialize SBIT Component.
2023-12-08T21:04:02.714Z,1702069442.714 [SBIT](IMPORTANT): git: 2023-10-12
2023-12-08T21:04:02.714Z,1702069442.714 [SBIT](INFO): git hash: f38038725fad7dfee583a1d6cb07fccd712c5d54
2023-12-08T21:04:02.714Z,1702069442.714 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2023-12-08T21:04:02.715Z,1702069442.715 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018
Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021
2023-12-08T21:04:02.716Z,1702069442.716 [SBIT](INFO): Beginning SBIT in 67.000000 seconds.
2023-12-08T21:04:02.717Z,1702069442.717 [IBIT](INFO): Initialize IBIT Component.
2023-12-08T21:04:02.718Z,1702069442.718 [CBIT](DEBUG): Initialize CBIT Component.
2023-12-08T21:04:02.719Z,1702069442.719 [logger ThreadHandler](INFO): Handler Thread ID is 4900
2023-12-08T21:04:02.729Z,1702069442.729 [CBIT](DEBUG): Initialized mux pins.
2023-12-08T21:04:02.729Z,1702069442.729 [CBIT](DEBUG): Initializing the watchdog timer.
2023-12-08T21:04:02.737Z,1702069442.737 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 4901
2023-12-08T21:04:02.738Z,1702069442.738 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2023-12-08T21:04:02.749Z,1702069442.749 [Onboard ThreadHandler](INFO): Handler Thread ID is 4902
2023-12-08T21:04:02.753Z,1702069442.753 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2023-12-08T21:04:02.754Z,1702069442.754 [CBIT](DEBUG): Initializing heartbeat.
2023-12-08T21:04:02.770Z,1702069442.770 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 4903
2023-12-08T21:04:02.785Z,1702069442.785 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 4904
2023-12-08T21:04:02.786Z,1702069442.786 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2023-12-08T21:04:02.790Z,1702069442.790 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 4906
2023-12-08T21:04:02.794Z,1702069442.794 [WetLabsBB2FL](INFO): Powering up
2023-12-08T21:04:02.795Z,1702069442.795 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 4908
2023-12-08T21:04:02.798Z,1702069442.798 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2023-12-08T21:04:02.798Z,1702069442.798 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2023-12-08T21:04:02.798Z,1702069442.798 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2023-12-08T21:04:02.798Z,1702069442.798 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2023-12-08T21:04:02.798Z,1702069442.798 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2023-12-08T21:04:02.799Z,1702069442.799 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2023-12-08T21:04:02.799Z,1702069442.799 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2023-12-08T21:04:02.799Z,1702069442.799 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2023-12-08T21:04:02.825Z,1702069442.825 [CBIT](DEBUG): Deactivating GF circuits.
2023-12-08T21:04:02.825Z,1702069442.825 [CBIT](DEBUG): Deactivating emergency mode.
2023-12-08T21:04:02.865Z,1702069442.865 [CBIT](DEBUG): Backplane powered.
2023-12-08T21:04:02.866Z,1702069442.866 [MissionManager](INFO): Loading Mission from file: Missions/Startup.xml
2023-12-08T21:04:02.878Z,1702069442.878 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2023-12-08T21:04:02.913Z,1702069442.913 [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>


2023-12-08T21:04:02.914Z,1702069442.914 [MissionManager](INFO): Loading Mission from file: Missions/Default.xml
2023-12-08T21:04:02.987Z,1702069442.987 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2023-12-08T21:04:02.988Z,1702069442.988 [Default:A.Wait](DEBUG): Construct Wait.
2023-12-08T21:04:02.991Z,1702069442.991 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2023-12-08T21:04:03.035Z,1702069443.035 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2023-12-08T21:04:03.037Z,1702069443.037 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2023-12-08T21:04:03.061Z,1702069443.061 [Default:E.Execute](DEBUG): Construct Execute.
2023-12-08T21:04:03.065Z,1702069443.065 [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>


2023-12-08T21:04:03.086Z,1702069443.086 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,NAL9602,Power24vConverter,Sonardyne_Nano,CANONSampler,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2023-12-08T21:04:03.101Z,1702069443.101 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2023-12-08T21:04:03.162Z,1702069443.162 [Depth_Keller](ERROR): Pressure or depth reading out of range: 1831.023193 decibar, 0.000000 m
2023-12-08T21:04:03.163Z,1702069443.163 [Power24vConverter](INFO): Powering up.
2023-12-08T21:04:03.164Z,1702069443.164 [Sonardyne_Nano](INFO): Initializing.
2023-12-08T21:04:03.173Z,1702069443.173 [Radio_Surface](INFO): Powering up
2023-12-08T21:04:03.181Z,1702069443.181 [CANONSampler](INFO): Powering down
2023-12-08T21:04:03.194Z,1702069443.194 [DepthRateCalculator](ERROR): Depth measurement is not active
2023-12-08T21:04:03.227Z,1702069443.227 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2023-12-08T21:04:03.237Z,1702069443.237 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2023-12-08T21:04:03.238Z,1702069443.238 [ElevatorServo](DEBUG): Initializing EZServoServo.
2023-12-08T21:04:03.245Z,1702069443.245 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2023-12-08T21:04:03.246Z,1702069443.246 [MassServo](DEBUG): Initializing EZServoServo.
2023-12-08T21:04:03.253Z,1702069443.253 [MassServo](DEBUG): Initializing MassServo.
2023-12-08T21:04:03.254Z,1702069443.254 [RudderServo](DEBUG): Initializing EZServoServo.
2023-12-08T21:04:03.265Z,1702069443.265 [RudderServo](DEBUG): Initializing RudderServo.
2023-12-08T21:04:03.266Z,1702069443.266 [ThrusterHE](DEBUG): Initializing EZServoServo.
2023-12-08T21:04:03.273Z,1702069443.273 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2023-12-08T21:04:05.115Z,1702069445.115 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART
2023-12-08T21:04:05.405Z,1702069445.405 [WetLabsBB2FL](INFO): Powering down
2023-12-08T21:04:06.401Z,1702069446.401 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2109
2023-12-08T21:04:06.757Z,1702069446.757 [Sonardyne_Nano](INFO): Battery at maximum, disabling charging
2023-12-08T21:04:08.986Z,1702069448.986 [ThrusterHE](ERROR): Zero Speed Commanded.
2023-12-08T21:04:15.403Z,1702069455.403 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004743
2023-12-08T21:04:31.378Z,1702069471.378 [NAL9602](INFO): Powering up NAL9602
2023-12-08T21:04:42.287Z,1702069482.287 [NAL9602](INFO): NAL9602 initialized
2023-12-08T21:05:10.227Z,1702069510.227 [SBIT](IMPORTANT): Beginning Startup BIT
2023-12-08T21:05:10.236Z,1702069510.236 [CBIT](IMPORTANT): Beginning ground fault scan
2023-12-08T21:05:21.092Z,1702069521.092 [CBIT](ERROR): Ground fault scan returned out of bounds value. Re-running scan.
2023-12-08T21:05:21.496Z,1702069521.496 [CBIT](IMPORTANT): Beginning ground fault scan
2023-12-08T21:05:32.461Z,1702069532.461 [CBIT](ERROR): Ground fault scan returned out of bounds value. Re-running scan.
2023-12-08T21:05:32.890Z,1702069532.890 [CBIT](IMPORTANT): Beginning ground fault scan
2023-12-08T21:05:43.736Z,1702069543.736 [CBIT](ERROR): Ground fault scan returned out of bounds value. Re-running scan.
2023-12-08T21:05:43.737Z,1702069543.737 [CBIT](IMPORTANT): Ground fault scan returned out of bounds value in succession 3 times. Will re-run scan on normal schedule.
2023-12-08T21:06:03.942Z,1702069563.942 [SBIT](IMPORTANT): SBIT PASSED
2023-12-08T21:06:03.942Z,1702069563.942 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2023-12-08T21:06:03.943Z,1702069563.943 [SBIT](IMPORTANT): AMEcho.loadAtStartup=0 bool;

2023-12-08T21:06:03.943Z,1702069563.943 [SBIT](IMPORTANT): BPC1.batteryMissingStickThreshold=20 count;

2023-12-08T21:06:03.943Z,1702069563.943 [SBIT](IMPORTANT): CANONSampler.loadAtStartup=1 bool;

2023-12-08T21:06:03.943Z,1702069563.943 [SBIT](IMPORTANT): CBIT.runElevOffsetCalc=1 bool;

2023-12-08T21:06:03.943Z,1702069563.943 [SBIT](IMPORTANT): DAT.loadAtStartup=0 bool;

2023-12-08T21:06:03.943Z,1702069563.943 [SBIT](IMPORTANT): Sonardyne_Nano.loadAtStartup=1 bool;

2023-12-08T21:06:03.944Z,1702069563.944 [SBIT](IMPORTANT): ThrusterServo.currLimit=50 percent;

2023-12-08T21:06:03.944Z,1702069563.944 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=255.186074 cubic_centimeter;

2023-12-08T21:06:03.944Z,1702069563.944 [SBIT](IMPORTANT): VerticalControl.massDefault=-11.847765 millimeter;

2023-12-08T21:06:04.359Z,1702069564.359 [MissionManager](IMPORTANT): Started mission Startup
2023-12-08T21:06:04.359Z,1702069564.359 [Startup] Running Loop=1
2023-12-08T21:06:04.359Z,1702069564.359 [Startup](DEBUG): Aggregate::initialize Startup
2023-12-08T21:06:04.360Z,1702069564.360 [Startup:A.GoToSurface] Running Loop=1
2023-12-08T21:06:04.360Z,1702069564.360 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2023-12-08T21:06:04.360Z,1702069564.360 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2023-12-08T21:06:04.361Z,1702069564.361 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2023-12-08T21:06:04.361Z,1702069564.361 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2023-12-08T21:06:04.362Z,1702069564.362 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2023-12-08T21:06:04.362Z,1702069564.362 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2023-12-08T21:06:04.363Z,1702069564.363 [Startup:StartupSatComms] Running Loop=1
2023-12-08T21:06:04.363Z,1702069564.363 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2023-12-08T21:06:04.363Z,1702069564.363 [Startup:StartupSatComms:A] Running Loop=1
2023-12-08T21:06:04.727Z,1702069564.727 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2023-12-08T21:07:02.889Z,1702069622.889 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2023-12-08T21:07:02.889Z,1702069622.889 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-12-08T21:07:02.953Z,1702069622.953 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-12-08T21:07:03.309Z,1702069623.309 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-12-08T21:07:03.309Z,1702069623.309 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2023-12-08T21:07:04.503Z,1702069624.503 [Startup:StartupSatComms:A](INFO): Timed out from 2023-12-08T21:06:04.4Z
2023-12-08T21:07:04.503Z,1702069624.503 [Startup:StartupSatComms:A] Stopped
2023-12-08T21:07:04.503Z,1702069624.503 [Startup:StartupSatComms:B] Running Loop=1
2023-12-08T21:07:04.917Z,1702069624.917 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2023-12-08T21:07:12.189Z,1702069632.189 [DataOverHttps](INFO): Sending 167 bytes from file Logs/20231207T003355/Courier0004.lzma
2023-12-08T21:07:13.191Z,1702069633.191 [DataOverHttps](INFO): Moved sent file to Logs/20231207T003355/Courier0004.lzma.bak
2023-12-08T21:07:13.191Z,1702069633.191 [DataOverHttps](INFO): SBD MOMSN=19096451
2023-12-08T21:07:28.636Z,1702069648.636 [DataOverHttps](INFO): Sending 150 bytes from file Logs/20231208T210352/Courier0000.lzma
2023-12-08T21:07:29.638Z,1702069649.638 [DataOverHttps](INFO): Moved sent file to Logs/20231208T210352/Courier0000.lzma.bak
2023-12-08T21:07:29.639Z,1702069649.639 [DataOverHttps](INFO): SBD MOMSN=19096453
2023-12-08T21:07:45.072Z,1702069665.072 [DataOverHttps](INFO): Sending 152 bytes from file Logs/20231207T003355/Express0005.lzma
2023-12-08T21:07:46.074Z,1702069666.074 [DataOverHttps](INFO): Moved sent file to Logs/20231207T003355/Express0005.lzma.bak
2023-12-08T21:07:46.075Z,1702069666.075 [DataOverHttps](INFO): SBD MOMSN=19096456
2023-12-08T21:08:01.670Z,1702069681.670 [DataOverHttps](INFO): Sending 781 bytes from file Logs/20231208T210352/Express0001.lzma
2023-12-08T21:08:02.670Z,1702069682.670 [DataOverHttps](INFO): Moved sent file to Logs/20231208T210352/Express0001.lzma.bak
2023-12-08T21:08:02.671Z,1702069682.671 [DataOverHttps](INFO): SBD MOMSN=19096462
2023-12-08T21:08:03.931Z,1702069683.931 [Startup:StartupSatComms:B] Stopped
2023-12-08T21:08:03.932Z,1702069683.932 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2023-12-08T21:08:03.932Z,1702069683.932 [Startup:StartupSatComms] Stopped
2023-12-08T21:08:03.932Z,1702069683.932 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2023-12-08T21:08:03.933Z,1702069683.933 [Startup](INFO): Completed Startup
2023-12-08T21:08:03.933Z,1702069683.933 [MissionManager](INFO): Startup is completed.
2023-12-08T21:08:03.933Z,1702069683.933 [MissionManager](INFO): Uninitializing Mission Startup
2023-12-08T21:08:03.933Z,1702069683.933 [Startup] Stopped
2023-12-08T21:08:03.933Z,1702069683.933 [Startup](DEBUG): Aggregate::uninitialize Startup
2023-12-08T21:08:03.933Z,1702069683.933 [Startup:A.GoToSurface] Stopped
2023-12-08T21:08:03.933Z,1702069683.933 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2023-12-08T21:08:04.352Z,1702069684.352 [MissionManager](IMPORTANT): Started mission Default
2023-12-08T21:08:04.352Z,1702069684.352 [Default] Running Loop=1
2023-12-08T21:08:04.352Z,1702069684.352 [Default](DEBUG): Aggregate::initialize Default
2023-12-08T21:08:04.352Z,1702069684.352 [Default:B.GoToSurface] Running Loop=1
2023-12-08T21:08:04.352Z,1702069684.352 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2023-12-08T21:08:04.353Z,1702069684.353 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2023-12-08T21:08:04.353Z,1702069684.353 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2023-12-08T21:08:04.353Z,1702069684.353 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2023-12-08T21:08:04.354Z,1702069684.354 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2023-12-08T21:08:04.354Z,1702069684.354 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2023-12-08T21:08:04.354Z,1702069684.354 [Default:A.Wait] Running Loop=1
2023-12-08T21:08:04.354Z,1702069684.354 [Default:A.Wait](DEBUG): Initialize Wait Component.
2023-12-08T21:08:17.651Z,1702069697.651 [Default:A.Wait](INFO): Done Waiting.
2023-12-08T21:08:17.651Z,1702069697.651 [Default:A.Wait] Stopped
2023-12-08T21:08:17.651Z,1702069697.651 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2023-12-08T21:08:18.054Z,1702069698.054 [Default:CheckIn] Running Loop=1
2023-12-08T21:08:18.055Z,1702069698.055 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-12-08T21:08:18.055Z,1702069698.055 [Default:CheckIn:Read_GPS] Running Loop=1
2023-12-08T21:08:18.439Z,1702069698.439 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2023-12-08T21:08:58.830Z,1702069738.830 [BPC1](INFO): Calculating totals. Valid battery stick count: 37. Valid reserve battery stick count: 6.
2023-12-08T21:08:58.833Z,1702069738.833 [BPC1](INFO): Received data from all battery sticks.
2023-12-08T21:09:45.694Z,1702069785.694 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2023-12-08T21:10:03.904Z,1702069803.904 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2023-12-08T21:10:03.904Z,1702069803.904 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-12-08T21:10:03.915Z,1702069803.915 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-12-08T21:10:04.295Z,1702069804.295 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-12-08T21:10:04.296Z,1702069804.296 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2023-12-08T21:12:43.082Z,1702069963.082 [CommandExec](IMPORTANT): got command show variable sonardyne
2023-12-08T21:12:43.232Z,1702069963.232 [CommandExec](IMPORTANT): Sonardyne_Nano.loadControl (none)
2023-12-08T21:12:43.233Z,1702069963.233 [CommandExec](IMPORTANT): Sonardyne_Nano.uart (none)
2023-12-08T21:12:43.233Z,1702069963.233 [CommandExec](IMPORTANT): Sonardyne_Nano.baud (bit_per_second)
2023-12-08T21:12:43.251Z,1702069963.251 [CommandExec](IMPORTANT): Sonardyne_Nano.loadAtStartup (bool)
2023-12-08T21:12:43.252Z,1702069963.252 [CommandExec](IMPORTANT): Sonardyne_Nano.simulateHardware (bool)
2023-12-08T21:12:43.252Z,1702069963.252 [CommandExec](IMPORTANT): Sonardyne_Nano.chargeMin (percent)
2023-12-08T21:12:43.252Z,1702069963.252 [CommandExec](IMPORTANT): Sonardyne_Nano.chargeMax (percent)
2023-12-08T21:12:43.358Z,1702069963.358 [CommandExec](IMPORTANT): Sonardyne_Nano.enableBroadcast (bool)
2023-12-08T21:12:43.358Z,1702069963.358 [CommandExec](IMPORTANT): Sonardyne_Nano.component_voltage (volt)
2023-12-08T21:12:43.359Z,1702069963.359 [CommandExec](IMPORTANT): Sonardyne_Nano.component_avgVoltage (volt)
2023-12-08T21:12:43.359Z,1702069963.359 [CommandExec](IMPORTANT): Sonardyne_Nano.component_current (milliampere)
2023-12-08T21:12:43.359Z,1702069963.359 [CommandExec](IMPORTANT): Sonardyne_Nano.component_avgCurrent (milliampere)
2023-12-08T21:12:43.360Z,1702069963.360 [CommandExec](IMPORTANT): Sonardyne_Nano.chargePercent (percent)
2023-12-08T21:12:53.734Z,1702069973.734 [CommandExec](IMPORTANT): got command get Sonardyne_Nano.chargePercent
2023-12-08T21:12:53.735Z,1702069973.735 [CommandExec](IMPORTANT): Sonardyne_Nano.chargePercent 100.000000 %
2023-12-08T21:13:04.957Z,1702069984.957 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2023-12-08T21:13:04.957Z,1702069984.957 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-12-08T21:13:04.968Z,1702069984.968 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-12-08T21:13:05.356Z,1702069985.356 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-12-08T21:13:05.356Z,1702069985.356 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2023-12-08T21:13:18.291Z,1702069998.291 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-12-08T21:08:18.1Z
2023-12-08T21:13:18.291Z,1702069998.291 [Default:CheckIn:Read_GPS] Stopped
2023-12-08T21:13:18.291Z,1702069998.291 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-12-08T21:13:18.668Z,1702069998.668 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2023-12-08T21:13:25.112Z,1702070005.112 [DataOverHttps](INFO): Sending 168 bytes from file Logs/20231208T210352/Courier0004.lzma
2023-12-08T21:13:26.114Z,1702070006.114 [DataOverHttps](INFO): Moved sent file to Logs/20231208T210352/Courier0004.lzma.bak
2023-12-08T21:13:26.115Z,1702070006.115 [DataOverHttps](INFO): SBD MOMSN=19096485
2023-12-08T21:13:41.569Z,1702070021.569 [DataOverHttps](INFO): Sending 466 bytes from file Logs/20231208T210352/Express0005.lzma
2023-12-08T21:13:42.570Z,1702070022.570 [DataOverHttps](INFO): Moved sent file to Logs/20231208T210352/Express0005.lzma.bak
2023-12-08T21:13:42.571Z,1702070022.571 [DataOverHttps](INFO): SBD MOMSN=19096487
2023-12-08T21:13:43.735Z,1702070023.735 [Default:CheckIn:Read_Iridium] Stopped
2023-12-08T21:13:43.735Z,1702070023.735 [Default:CheckIn:C.Wait] Running Loop=1
2023-12-08T21:13:43.735Z,1702070023.735 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-12-08T21:14:04.311Z,1702070044.311 [Power24vConverter](INFO): Powering down.
2023-12-08T21:14:45.524Z,1702070085.524 [NAL9602](FAULT): GPS failed to acquire within timeout.
2023-12-08T21:14:45.524Z,1702070085.524 [NAL9602] Data Fault, FailCount= 1
2023-12-08T21:14:45.524Z,1702070085.524 [NAL9602](ERROR): Data Fault
2023-12-08T21:14:45.541Z,1702070085.541 [CBIT](ERROR): Data Fault in component: NAL9602
2023-12-08T21:14:45.918Z,1702070085.918 [NAL9602](INFO): Powering down
2023-12-08T21:14:46.757Z,1702070086.757 [CBIT](INFO): Clearing failed state for component NAL9602
2023-12-08T21:14:46.757Z,1702070086.757 [NAL9602] No Fault, FailCount= 1
2023-12-08T21:15:16.222Z,1702070116.222 [NAL9602](INFO): Powering up NAL9602
2023-12-08T21:15:27.130Z,1702070127.130 [NAL9602](INFO): NAL9602 initialized
2023-12-08T21:15:32.800Z,1702070132.800 [CommandExec](IMPORTANT): got command strobe off
2023-12-08T21:15:32.801Z,1702070132.801 [CommandExec](IMPORTANT): Deactivating strobe
2023-12-08T21:16:05.943Z,1702070165.943 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2023-12-08T21:16:05.944Z,1702070165.944 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-12-08T21:16:05.970Z,1702070165.970 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-12-08T21:16:06.353Z,1702070166.353 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-12-08T21:16:06.353Z,1702070166.353 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2023-12-08T21:18:44.302Z,1702070324.302 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2023-12-08T21:18:44.302Z,1702070324.302 [Default:CheckIn:C.Wait] Stopped
2023-12-08T21:18:44.302Z,1702070324.302 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-12-08T21:18:44.302Z,1702070324.302 [Default:CheckIn:D] Running Loop=1
2023-12-08T21:18:44.710Z,1702070324.710 [Default:CheckIn:D] Stopped
2023-12-08T21:18:44.710Z,1702070324.710 [Default:CheckIn:E] Running Loop=1
2023-12-08T21:18:45.108Z,1702070325.108 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 10.672633 min 
2023-12-08T21:18:45.108Z,1702070325.108 [Default:CheckIn:E] Stopped
2023-12-08T21:18:45.108Z,1702070325.108 [Default:CheckIn](INFO): Completed Default:CheckIn
2023-12-08T21:18:45.108Z,1702070325.108 [Default:CheckIn] Stopped
2023-12-08T21:18:45.108Z,1702070325.108 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-12-08T21:18:45.108Z,1702070325.108 [Default:CheckIn](INFO): Running loop #2
2023-12-08T21:18:45.109Z,1702070325.109 [Default:CheckIn] Running Loop=2
2023-12-08T21:18:45.109Z,1702070325.109 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-12-08T21:18:45.109Z,1702070325.109 [Default:CheckIn:Read_GPS] Running Loop=1
2023-12-08T21:19:06.935Z,1702070346.935 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5
2023-12-08T21:19:06.935Z,1702070346.935 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-12-08T21:19:06.947Z,1702070346.947 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-12-08T21:19:07.355Z,1702070347.355 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-12-08T21:19:07.355Z,1702070347.355 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5
2023-12-08T21:22:07.930Z,1702070527.930 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6
2023-12-08T21:22:07.930Z,1702070527.930 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-12-08T21:22:07.957Z,1702070527.957 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-12-08T21:22:08.341Z,1702070528.341 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-12-08T21:22:08.341Z,1702070528.341 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6
2023-12-08T21:23:45.293Z,1702070625.293 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-12-08T21:18:45.1Z
2023-12-08T21:23:45.293Z,1702070625.293 [Default:CheckIn:Read_GPS] Stopped
2023-12-08T21:23:45.293Z,1702070625.293 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-12-08T21:23:52.888Z,1702070632.888 [DataOverHttps](INFO): Sending 38 bytes from file Logs/20231208T210352/Courier0007.lzma
2023-12-08T21:23:53.892Z,1702070633.892 [DataOverHttps](INFO): Moved sent file to Logs/20231208T210352/Courier0007.lzma.bak
2023-12-08T21:23:53.892Z,1702070633.892 [DataOverHttps](INFO): SBD MOMSN=19096537
2023-12-08T21:24:09.284Z,1702070649.284 [DataOverHttps](INFO): Sending 221 bytes from file Logs/20231208T210352/Express0008.lzma
2023-12-08T21:24:10.286Z,1702070650.286 [DataOverHttps](INFO): Moved sent file to Logs/20231208T210352/Express0008.lzma.bak
2023-12-08T21:24:10.287Z,1702070650.287 [DataOverHttps](INFO): SBD MOMSN=19096539
2023-12-08T21:24:11.555Z,1702070651.555 [Default:CheckIn:Read_Iridium] Stopped
2023-12-08T21:24:11.555Z,1702070651.555 [Default:CheckIn:C.Wait] Running Loop=1
2023-12-08T21:24:11.555Z,1702070651.555 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-12-08T21:25:08.926Z,1702070708.926 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7
2023-12-08T21:25:08.926Z,1702070708.926 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-12-08T21:25:08.936Z,1702070708.936 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-12-08T21:25:09.312Z,1702070709.312 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-12-08T21:25:09.312Z,1702070709.312 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7
2023-12-08T21:25:29.099Z,1702070729.099 [NAL9602](FAULT): GPS failed to acquire within timeout.
2023-12-08T21:25:29.099Z,1702070729.099 [NAL9602] Data Fault, FailCount= 2
2023-12-08T21:25:29.099Z,1702070729.099 [NAL9602](ERROR): Data Fault
2023-12-08T21:25:29.116Z,1702070729.116 [CBIT](ERROR): Data Fault in component: NAL9602
2023-12-08T21:25:29.498Z,1702070729.498 [NAL9602](INFO): Powering down
2023-12-08T21:25:30.339Z,1702070730.339 [CBIT](INFO): Clearing failed state for component NAL9602
2023-12-08T21:25:30.339Z,1702070730.339 [NAL9602] No Fault, FailCount= 2
2023-12-08T21:25:59.798Z,1702070759.798 [NAL9602](INFO): Powering up NAL9602
2023-12-08T21:26:10.706Z,1702070770.706 [NAL9602](INFO): NAL9602 initialized
2023-12-08T21:27:01.170Z,1702070821.170 [CommandExec](IMPORTANT): got command quit
2023-12-08T21:27:02.173Z,1702070822.173 [Supervisor](INFO): Stop Mission called by Supervisor::terminate
2023-12-08T21:27:02.173Z,1702070822.173 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread.
2023-12-08T21:27:02.173Z,1702070822.173 [CommandExec](INFO): Uninitializing the command executive.
2023-12-08T21:27:02.173Z,1702070822.173 [CommandExec](INFO): Uninitializing the command scheduler.
2023-12-08T21:27:02.174Z,1702070822.174 [CommandExec ThreadHandler](INFO): Thread cancelled.
2023-12-08T21:27:02.217Z,1702070822.217 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2023-12-08T21:27:02.217Z,1702070822.217 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2023-12-08T21:27:02.217Z,1702070822.217 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2023-12-08T21:27:02.218Z,1702070822.218 [NavChartDb](INFO): Join timeout helper Thread ID is 4934
2023-12-08T21:27:02.233Z,1702070822.233 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2023-12-08T21:27:02.233Z,1702070822.233 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2023-12-08T21:27:02.241Z,1702070822.241 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2023-12-08T21:27:02.241Z,1702070822.241 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2023-12-08T21:27:02.241Z,1702070822.241 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 4935
2023-12-08T21:27:02.741Z,1702070822.741 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2023-12-08T21:27:02.741Z,1702070822.741 [WetLabsBB2FL](INFO): Powering down
2023-12-08T21:27:02.742Z,1702070822.742 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2023-12-08T21:27:02.745Z,1702070822.745 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2023-12-08T21:27:02.745Z,1702070822.745 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2023-12-08T21:27:02.745Z,1702070822.745 [CTD_Seabird](INFO): Join timeout helper Thread ID is 4936
2023-12-08T21:27:03.465Z,1702070823.465 [CTD_Seabird](INFO): Powering down
2023-12-08T21:27:03.477Z,1702070823.477 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2023-12-08T21:27:03.477Z,1702070823.477 [CTD_Seabird](INFO): Powering down
2023-12-08T21:27:03.489Z,1702070823.489 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2023-12-08T21:27:03.493Z,1702070823.493 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2023-12-08T21:27:03.493Z,1702070823.493 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2023-12-08T21:27:03.493Z,1702070823.493 [Radio_Surface](INFO): Join timeout helper Thread ID is 4937
2023-12-08T21:27:03.745Z,1702070823.745 [Radio_Surface](INFO): Powering down
2023-12-08T21:27:03.746Z,1702070823.746 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2023-12-08T21:27:03.746Z,1702070823.746 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2023-12-08T21:27:03.753Z,1702070823.753 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2023-12-08T21:27:03.753Z,1702070823.753 [Onboard ThreadHandler](INFO): Thread cancelled.
2023-12-08T21:27:03.753Z,1702070823.753 [Onboard](INFO): Join timeout helper Thread ID is 4938
2023-12-08T21:27:03.893Z,1702070823.893 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2023-12-08T21:27:03.893Z,1702070823.893 [Onboard ThreadHandler](INFO): Thread cancelled.
2023-12-08T21:27:03.914Z,1702070823.914 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2023-12-08T21:27:03.914Z,1702070823.914 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2023-12-08T21:27:03.914Z,1702070823.914 [DataOverHttps](INFO): Join timeout helper Thread ID is 4939
2023-12-08T21:27:04.181Z,1702070824.181 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2023-12-08T21:27:04.181Z,1702070824.181 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2023-12-08T21:27:04.193Z,1702070824.193 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2023-12-08T21:27:04.194Z,1702070824.194 [logger ThreadHandler](INFO): Thread cancelled.
2023-12-08T21:27:04.194Z,1702070824.194 [logger](INFO): Join timeout helper Thread ID is 4940
2023-12-08T21:27:04.233Z,1702070824.233 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2023-12-08T21:27:04.233Z,1702070824.233 [logger ThreadHandler](INFO): Thread cancelled.
2023-12-08T21:27:04.253Z,1702070824.253 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2023-12-08T21:27:04.253Z,1702070824.253 [CommandLine ThreadHandler](INFO): Thread cancelled.
2023-12-08T21:27:04.254Z,1702070824.254 [CommandLine](INFO): Join timeout helper Thread ID is 4941
2023-12-08T21:27:04.297Z,1702070824.297 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2023-12-08T21:27:04.297Z,1702070824.297 [CommandLine ThreadHandler](INFO): Thread cancelled.
2023-12-08T21:27:04.313Z,1702070824.313 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler
2023-12-08T21:27:04.313Z,1702070824.313 [CommandExec ThreadHandler](INFO): Thread cancelled.
2023-12-08T21:27:04.314Z,1702070824.314 [CommandExec](INFO): Join timeout helper Thread ID is 4942
2023-12-08T21:27:04.315Z,1702070824.315 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2023-12-08T21:27:04.315Z,1702070824.315 [controlThread ThreadHandler](INFO): Thread cancelled.
2023-12-08T21:27:04.316Z,1702070824.316 [controlThread](INFO): Join timeout helper Thread ID is 4943
2023-12-08T21:27:04.425Z,1702070824.425 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2023-12-08T21:27:04.425Z,1702070824.425 [controlThread](DEBUG): Uninitializing ControlThread
2023-12-08T21:27:04.426Z,1702070824.426 [AHRS_M2](INFO): Powering down
2023-12-08T21:27:04.498Z,1702070824.498 [NAL9602](INFO): Powering down
2023-12-08T21:27:04.499Z,1702070824.499 [Sonardyne_Nano](INFO): Powering down
2023-12-08T21:27:04.618Z,1702070824.618 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2023-12-08T21:27:04.619Z,1702070824.619 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2023-12-08T21:27:04.620Z,1702070824.620 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2023-12-08T21:27:04.620Z,1702070824.620 [MissionManager](INFO): Uninitializing Mission Default
2023-12-08T21:27:04.620Z,1702070824.620 [Default] Stopped
2023-12-08T21:27:04.620Z,1702070824.620 [Default](DEBUG): Aggregate::uninitialize Default
2023-12-08T21:27:04.620Z,1702070824.620 [Default:B.GoToSurface] Stopped
2023-12-08T21:27:04.620Z,1702070824.620 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2023-12-08T21:27:04.621Z,1702070824.621 [Default:CheckIn] Stopped
2023-12-08T21:27:04.621Z,1702070824.621 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-12-08T21:27:04.621Z,1702070824.621 [Default:CheckIn:C.Wait] Stopped
2023-12-08T21:27:04.621Z,1702070824.621 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-12-08T21:27:04.624Z,1702070824.624 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2023-12-08T21:27:04.624Z,1702070824.624 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2023-12-08T21:27:04.624Z,1702070824.624 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2023-12-08T21:27:04.625Z,1702070824.625 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2023-12-08T21:27:04.625Z,1702070824.625 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2023-12-08T21:27:04.625Z,1702070824.625 [BuoyancyServo](INFO): Powering down
2023-12-08T21:27:04.637Z,1702070824.637 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2023-12-08T21:27:04.637Z,1702070824.637 [ElevatorServo](INFO): Powering down
2023-12-08T21:27:04.638Z,1702070824.638 [MassServo](DEBUG): Uninitialize Mass Servo.
2023-12-08T21:27:04.638Z,1702070824.638 [MassServo](INFO): Powering down
2023-12-08T21:27:04.639Z,1702070824.639 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2023-12-08T21:27:04.639Z,1702070824.639 [RudderServo](INFO): Powering down
2023-12-08T21:27:04.640Z,1702070824.640 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2023-12-08T21:27:04.640Z,1702070824.640 [ThrusterHE](INFO): Powering down
2023-12-08T21:27:04.641Z,1702070824.641 [SBIT](DEBUG): Uninitialize SBIT Component.
2023-12-08T21:27:04.641Z,1702070824.641 [IBIT](DEBUG): Uninitialize IBIT Component.
2023-12-08T21:27:04.641Z,1702070824.641 [CBIT](DEBUG): Uninitialize CBIT Component.
2023-12-08T21:27:04.641Z,1702070824.641 [CBIT](DEBUG): Powering off loads.
2023-12-08T21:27:04.653Z,1702070824.653 [CBIT](DEBUG): Disabling WDT.
2023-12-08T21:27:04.665Z,1702070824.665 [CBIT](DEBUG): Opening all GF detection circuits.
2023-12-08T21:27:04.665Z,1702070824.665 [controlThread ThreadHandler](INFO): Thread cancelled.
2023-12-08T21:27:04.711Z,1702070824.711 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2023-12-08T21:27:04.714Z,1702070824.714 [Onboard ThreadHandler](INFO): Thread cancelled.
2023-12-08T21:27:04.720Z,1702070824.720 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2023-12-08T21:27:04.792Z,1702070824.792 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2023-12-08T21:27:04.796Z,1702070824.796 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2023-12-08T21:27:04.836Z,1702070824.836 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2023-12-08T21:27:04.898Z,1702070824.898 [logger ThreadHandler](INFO): Thread cancelled.