2024-03-15T21:00:49.813Z,1710536449.813 [Supervisor](DEBUG): Initializing supervisor. 2024-03-15T21:00:49.818Z,1710536449.818 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2024-03-15T21:00:49.818Z,1710536449.818 [SyncHandler](INFO): Protected caller Thread ID is 6311 2024-03-15T21:00:49.819Z,1710536449.819 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2024-03-15T21:00:49.819Z,1710536449.819 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2024-03-15T21:00:49.820Z,1710536449.820 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 6312 2024-03-15T21:00:49.824Z,1710536449.824 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2024-03-15T21:00:49.841Z,1710536449.841 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2024-03-15T21:00:49.842Z,1710536449.842 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2024-03-15T21:00:49.842Z,1710536449.842 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 6313 2024-03-15T21:00:49.846Z,1710536449.846 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2024-03-15T21:00:49.847Z,1710536449.847 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2024-03-15T21:00:49.848Z,1710536449.848 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 6314 2024-03-15T21:00:49.850Z,1710536449.850 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2024-03-15T21:00:49.851Z,1710536449.851 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2024-03-15T21:00:49.851Z,1710536449.851 [logger ThreadHandler](INFO): Protected caller Thread ID is 6315 2024-03-15T21:00:49.855Z,1710536449.855 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2024-03-15T21:00:49.855Z,1710536449.855 [Supervisor](INFO): Looking for Config files in directory: Config/ 2024-03-15T21:00:49.857Z,1710536449.857 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2024-03-15T21:00:50.117Z,1710536450.117 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2024-03-15T21:00:50.118Z,1710536450.118 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2024-03-15T21:00:50.199Z,1710536450.199 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2024-03-15T21:00:50.688Z,1710536450.688 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2024-03-15T21:00:50.689Z,1710536450.689 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2024-03-15T21:00:51.016Z,1710536451.016 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2024-03-15T21:00:51.017Z,1710536451.017 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2024-03-15T21:00:51.114Z,1710536451.114 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2024-03-15T21:00:51.115Z,1710536451.115 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2024-03-15T21:00:51.514Z,1710536451.514 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2024-03-15T21:00:51.514Z,1710536451.514 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2024-03-15T21:00:51.808Z,1710536451.808 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2024-03-15T21:00:51.808Z,1710536451.808 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2024-03-15T21:00:52.321Z,1710536452.321 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2024-03-15T21:00:52.321Z,1710536452.321 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2024-03-15T21:00:52.459Z,1710536452.459 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2024-03-15T21:00:52.460Z,1710536452.460 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2024-03-15T21:00:52.539Z,1710536452.539 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2024-03-15T21:00:53.330Z,1710536453.330 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2024-03-15T21:00:53.330Z,1710536453.330 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2024-03-15T21:00:53.705Z,1710536453.705 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2024-03-15T21:00:53.705Z,1710536453.705 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2024-03-15T21:00:53.898Z,1710536453.898 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2024-03-15T21:00:53.898Z,1710536453.898 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2024-03-15T21:00:54.010Z,1710536454.010 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2024-03-15T21:00:54.011Z,1710536454.011 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2024-03-15T21:00:54.241Z,1710536454.241 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2024-03-15T21:00:54.241Z,1710536454.241 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2024-03-15T21:00:54.489Z,1710536454.489 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2024-03-15T21:00:54.491Z,1710536454.491 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-daphne/ 2024-03-15T21:00:54.492Z,1710536454.492 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Navigation.cfg 2024-03-15T21:00:54.658Z,1710536454.658 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Simulator.cfg 2024-03-15T21:00:54.825Z,1710536454.825 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Control.cfg 2024-03-15T21:00:55.036Z,1710536455.036 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/secure.cfg 2024-03-15T21:00:55.125Z,1710536455.125 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Servo.cfg 2024-03-15T21:00:55.234Z,1710536455.234 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/BIT.cfg 2024-03-15T21:00:55.337Z,1710536455.337 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/vehicle.cfg 2024-03-15T21:00:55.453Z,1710536455.453 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Sensor.cfg 2024-03-15T21:00:55.605Z,1710536455.605 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Science.cfg 2024-03-15T21:00:55.745Z,1710536455.745 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/logger.cfg 2024-03-15T21:00:55.857Z,1710536455.857 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Battery.cfg 2024-03-15T21:00:56.125Z,1710536456.125 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2024-03-15T21:00:56.126Z,1710536456.126 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-daphne/root/ 2024-03-15T21:00:56.126Z,1710536456.126 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg 2024-03-15T21:00:56.135Z,1710536456.135 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2024-03-15T21:00:56.187Z,1710536456.187 [VerticalControl](DEBUG): Construct VerticalControl. 2024-03-15T21:00:56.247Z,1710536456.247 [VerticalControl] Loaded 2024-03-15T21:00:56.247Z,1710536456.247 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2024-03-15T21:00:56.250Z,1710536456.250 [HorizontalControl](DEBUG): Construct HorizontalControl. 2024-03-15T21:00:56.291Z,1710536456.291 [HorizontalControl] Loaded 2024-03-15T21:00:56.291Z,1710536456.291 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2024-03-15T21:00:56.293Z,1710536456.293 [SpeedControl](DEBUG): Construct SpeedControl. 2024-03-15T21:00:56.296Z,1710536456.296 [SpeedControl] Loaded 2024-03-15T21:00:56.297Z,1710536456.297 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2024-03-15T21:00:56.299Z,1710536456.299 [LoopControl](DEBUG): Construct LoopControl. 2024-03-15T21:00:56.300Z,1710536456.300 [LoopControl] Loaded 2024-03-15T21:00:56.300Z,1710536456.300 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2024-03-15T21:00:56.300Z,1710536456.300 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2024-03-15T21:00:56.301Z,1710536456.301 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2024-03-15T21:00:56.311Z,1710536456.311 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2024-03-15T21:00:56.311Z,1710536456.311 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2024-03-15T21:00:56.458Z,1710536456.458 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2024-03-15T21:00:56.459Z,1710536456.459 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2024-03-15T21:00:56.588Z,1710536456.588 [BuoyancyServo] Loaded 2024-03-15T21:00:56.588Z,1710536456.588 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2024-03-15T21:00:56.608Z,1710536456.608 [ElevatorServo] Loaded 2024-03-15T21:00:56.609Z,1710536456.609 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2024-03-15T21:00:56.627Z,1710536456.627 [MassServo] Loaded 2024-03-15T21:00:56.627Z,1710536456.627 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2024-03-15T21:00:56.646Z,1710536456.646 [RudderServo] Loaded 2024-03-15T21:00:56.646Z,1710536456.646 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2024-03-15T21:00:56.660Z,1710536456.660 [ThrusterHE] Loaded 2024-03-15T21:00:56.661Z,1710536456.661 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread. 2024-03-15T21:00:56.661Z,1710536456.661 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2024-03-15T21:00:56.662Z,1710536456.662 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2024-03-15T21:00:56.774Z,1710536456.774 [DeadReckonUsingMultipleVelocitySources] Loaded 2024-03-15T21:00:56.774Z,1710536456.774 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2024-03-15T21:00:56.788Z,1710536456.788 [NavChart] Loaded 2024-03-15T21:00:56.788Z,1710536456.788 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2024-03-15T21:00:56.794Z,1710536456.794 [UniversalFixResidualReporter] Loaded 2024-03-15T21:00:56.794Z,1710536456.794 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2024-03-15T21:00:56.794Z,1710536456.794 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2024-03-15T21:00:56.795Z,1710536456.795 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2024-03-15T21:00:56.851Z,1710536456.851 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2024-03-15T21:00:56.852Z,1710536456.852 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2024-03-15T21:00:57.273Z,1710536457.273 [AHRS_M2] Loaded 2024-03-15T21:00:57.274Z,1710536457.274 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2024-03-15T21:00:58.102Z,1710536458.102 [BPC1] Loaded 2024-03-15T21:00:58.102Z,1710536458.102 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2024-03-15T21:00:58.179Z,1710536458.179 [DataOverHttps] Loaded 2024-03-15T21:00:58.179Z,1710536458.179 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2024-03-15T21:00:58.180Z,1710536458.180 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 4090F4E0 2024-03-15T21:00:58.180Z,1710536458.180 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 6398 2024-03-15T21:00:58.201Z,1710536458.201 [Depth_Keller] Loaded 2024-03-15T21:00:58.201Z,1710536458.201 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2024-03-15T21:00:58.206Z,1710536458.206 [DropWeight] Loaded 2024-03-15T21:00:58.206Z,1710536458.206 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2024-03-15T21:00:58.268Z,1710536458.268 [NAL9602] Loaded 2024-03-15T21:00:58.269Z,1710536458.269 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2024-03-15T21:00:58.299Z,1710536458.299 [Onboard] Loaded 2024-03-15T21:00:58.299Z,1710536458.299 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2024-03-15T21:00:58.300Z,1710536458.300 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 4093F4E0 2024-03-15T21:00:58.300Z,1710536458.300 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 6399 2024-03-15T21:00:58.314Z,1710536458.314 [Power24vConverter] Loaded 2024-03-15T21:00:58.314Z,1710536458.314 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2024-03-15T21:00:58.327Z,1710536458.327 [Radio_Surface] Loaded 2024-03-15T21:00:58.327Z,1710536458.327 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2024-03-15T21:00:58.328Z,1710536458.328 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 4096F4E0 2024-03-15T21:00:58.329Z,1710536458.329 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 6400 2024-03-15T21:00:58.342Z,1710536458.342 [Sonardyne_Nano] Loaded 2024-03-15T21:00:58.342Z,1710536458.342 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread. 2024-03-15T21:00:58.343Z,1710536458.343 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2024-03-15T21:00:58.344Z,1710536458.344 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2024-03-15T21:00:58.394Z,1710536458.394 [DepthRateCalculator] Loaded 2024-03-15T21:00:58.394Z,1710536458.394 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2024-03-15T21:00:58.399Z,1710536458.399 [PitchRateCalculator] Loaded 2024-03-15T21:00:58.399Z,1710536458.399 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2024-03-15T21:00:58.408Z,1710536458.408 [SpeedCalculator] Loaded 2024-03-15T21:00:58.408Z,1710536458.408 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2024-03-15T21:00:58.413Z,1710536458.413 [YawRateCalculator] Loaded 2024-03-15T21:00:58.413Z,1710536458.413 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2024-03-15T21:00:58.432Z,1710536458.432 [ElevatorOffsetCalculator] Loaded 2024-03-15T21:00:58.432Z,1710536458.432 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2024-03-15T21:00:58.433Z,1710536458.433 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2024-03-15T21:00:58.433Z,1710536458.433 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2024-03-15T21:00:58.565Z,1710536458.565 [CANONSampler] Loaded 2024-03-15T21:00:58.566Z,1710536458.566 [ComponentRegistry](DEBUG): SyncComponent "CANONSampler" handled in the control thread. 2024-03-15T21:00:58.626Z,1710536458.626 [CTD_Seabird] Loaded 2024-03-15T21:00:58.626Z,1710536458.626 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2024-03-15T21:00:58.627Z,1710536458.627 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40A2A4E0 2024-03-15T21:00:58.628Z,1710536458.628 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 6401 2024-03-15T21:00:58.647Z,1710536458.647 [PAR_Licor] Loaded 2024-03-15T21:00:58.648Z,1710536458.648 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2024-03-15T21:00:58.688Z,1710536458.688 [WetLabsBB2FL] Loaded 2024-03-15T21:00:58.688Z,1710536458.688 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2024-03-15T21:00:58.689Z,1710536458.689 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40A5A4E0 2024-03-15T21:00:58.689Z,1710536458.689 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 6402 2024-03-15T21:00:58.690Z,1710536458.690 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2024-03-15T21:00:58.691Z,1710536458.691 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2024-03-15T21:00:58.717Z,1710536458.717 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2024-03-15T21:00:58.718Z,1710536458.718 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2024-03-15T21:00:59.049Z,1710536459.049 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2024-03-15T21:00:59.049Z,1710536459.049 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2024-03-15T21:00:59.187Z,1710536459.187 [SBIT](DEBUG): Construct Startup Built In Test. 2024-03-15T21:00:59.197Z,1710536459.197 [SBIT] Loaded 2024-03-15T21:00:59.197Z,1710536459.197 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2024-03-15T21:00:59.200Z,1710536459.200 [IBIT](DEBUG): Construct Initiated Built In Test. 2024-03-15T21:00:59.213Z,1710536459.213 [IBIT] Loaded 2024-03-15T21:00:59.214Z,1710536459.214 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2024-03-15T21:00:59.219Z,1710536459.219 [CBIT](DEBUG): Construct Continuous Built In Test. 2024-03-15T21:00:59.323Z,1710536459.323 [CBIT] Loaded 2024-03-15T21:00:59.323Z,1710536459.323 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2024-03-15T21:00:59.323Z,1710536459.323 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2024-03-15T21:00:59.324Z,1710536459.324 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2024-03-15T21:00:59.434Z,1710536459.434 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2024-03-15T21:00:59.441Z,1710536459.441 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2024-03-15T21:00:59.443Z,1710536459.443 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2024-03-15T21:00:59.454Z,1710536459.454 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2024-03-15T21:00:59.456Z,1710536459.456 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40BB14E0 2024-03-15T21:00:59.456Z,1710536459.456 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 6403 2024-03-15T21:00:59.460Z,1710536459.460 [Supervisor](INFO): Main Thread ID is 6310 2024-03-15T21:00:59.461Z,1710536459.461 [Supervisor](DEBUG): Running supervisor. 2024-03-15T21:00:59.461Z,1710536459.461 [CommandExec ThreadHandler](INFO): Handler Thread ID is 6404 2024-03-15T21:00:59.462Z,1710536459.462 [CommandExec](INFO): Initializing the command executive. 2024-03-15T21:00:59.463Z,1710536459.463 [CommandLine ThreadHandler](INFO): Handler Thread ID is 6405 2024-03-15T21:00:59.466Z,1710536459.466 [controlThread ThreadHandler](INFO): Handler Thread ID is 6406 2024-03-15T21:00:59.466Z,1710536459.466 [controlThread](DEBUG): Initializing ControlThread 2024-03-15T21:00:59.467Z,1710536459.467 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2024-03-15T21:00:59.469Z,1710536459.469 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2024-03-15T21:00:59.469Z,1710536459.469 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2024-03-15T21:00:59.470Z,1710536459.470 [LoopControl](DEBUG): Initialize LoopControlComponent. 2024-03-15T21:00:59.472Z,1710536459.472 [NavChart](DEBUG): Initialize NavChart Navigation. 2024-03-15T21:00:59.472Z,1710536459.472 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2024-03-15T21:00:59.478Z,1710536459.478 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2024-03-15T21:00:59.478Z,1710536459.478 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2024-03-15T21:00:59.479Z,1710536459.479 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2024-03-15T21:00:59.479Z,1710536459.479 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2024-03-15T21:00:59.479Z,1710536459.479 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2024-03-15T21:00:59.484Z,1710536459.484 [SBIT](INFO): Initialize SBIT Component. 2024-03-15T21:00:59.485Z,1710536459.485 [SBIT](IMPORTANT): git: 2024-02-14 2024-03-15T21:00:59.485Z,1710536459.485 [SBIT](INFO): git hash: 8fc4e848ca047b5de9ae8a7c02f55958c6301ab2 2024-03-15T21:00:59.485Z,1710536459.485 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2024-03-15T21:00:59.486Z,1710536459.486 [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 2024-03-15T21:00:59.487Z,1710536459.487 [SBIT](INFO): Beginning SBIT in 83.000000 seconds. 2024-03-15T21:00:59.488Z,1710536459.488 [IBIT](INFO): Initialize IBIT Component. 2024-03-15T21:00:59.489Z,1710536459.489 [CBIT](DEBUG): Initialize CBIT Component. 2024-03-15T21:00:59.490Z,1710536459.490 [logger ThreadHandler](INFO): Handler Thread ID is 6407 2024-03-15T21:00:59.500Z,1710536459.500 [CBIT](DEBUG): Initialized mux pins. 2024-03-15T21:00:59.500Z,1710536459.500 [CBIT](DEBUG): Initializing the watchdog timer. 2024-03-15T21:00:59.509Z,1710536459.509 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 6408 2024-03-15T21:00:59.510Z,1710536459.510 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2024-03-15T21:00:59.521Z,1710536459.521 [Onboard ThreadHandler](INFO): Handler Thread ID is 6409 2024-03-15T21:00:59.525Z,1710536459.525 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2024-03-15T21:00:59.525Z,1710536459.525 [CBIT](DEBUG): Initializing heartbeat. 2024-03-15T21:00:59.541Z,1710536459.541 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 6410 2024-03-15T21:00:59.557Z,1710536459.557 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 6411 2024-03-15T21:00:59.557Z,1710536459.557 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2024-03-15T21:00:59.562Z,1710536459.562 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 6413 2024-03-15T21:00:59.565Z,1710536459.565 [WetLabsBB2FL](INFO): Powering up 2024-03-15T21:00:59.566Z,1710536459.566 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 6415 2024-03-15T21:00:59.569Z,1710536459.569 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2024-03-15T21:00:59.569Z,1710536459.569 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2024-03-15T21:00:59.570Z,1710536459.570 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2024-03-15T21:00:59.570Z,1710536459.570 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2024-03-15T21:00:59.570Z,1710536459.570 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2024-03-15T21:00:59.570Z,1710536459.570 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2024-03-15T21:00:59.570Z,1710536459.570 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2024-03-15T21:00:59.570Z,1710536459.570 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2024-03-15T21:00:59.596Z,1710536459.596 [CBIT](DEBUG): Deactivating GF circuits. 2024-03-15T21:00:59.596Z,1710536459.596 [CBIT](DEBUG): Deactivating emergency mode. 2024-03-15T21:00:59.636Z,1710536459.636 [CBIT](DEBUG): Backplane powered. 2024-03-15T21:00:59.637Z,1710536459.637 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl 2024-03-15T21:00:59.638Z,1710536459.638 [MissionManager](IMPORTANT): Loading Compiled TethysL script from file Missions/Startup.tx 2024-03-15T21:00:59.649Z,1710536459.649 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2024-03-15T21:00:59.729Z,1710536459.729 [MissionManager](DEBUG): mission Startup { behavior Guidance:GoToSurface { run in progression } aggregate StartupSatComms { run in sequence readDatum { timeout duration=P1M Universal:latitude_fix } readDatum { timeout duration=P1M Universal:platform_communications } } } 2024-03-15T21:00:59.730Z,1710536459.730 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl 2024-03-15T21:00:59.730Z,1710536459.730 [MissionManager](IMPORTANT): Loading Compiled TethysL script from file Missions/Default.tx 2024-03-15T21:00:59.901Z,1710536459.901 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2024-03-15T21:00:59.902Z,1710536459.902 [Default:A.Wait](DEBUG): Construct Wait. 2024-03-15T21:00:59.944Z,1710536459.944 [Radio_Surface](INFO): Powering up 2024-03-15T21:00:59.948Z,1710536459.948 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2024-03-15T21:01:00.028Z,1710536460.028 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2024-03-15T21:01:00.031Z,1710536460.031 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2024-03-15T21:01:00.041Z,1710536460.041 [Default:E.Execute](DEBUG): Construct Execute. 2024-03-15T21:01:00.149Z,1710536460.149 [MissionManager](DEBUG): mission Default { arguments { ElapsedSinceDefaultStarted = 0 minute } behavior Guidance:Wait { """ Wait a moment to see if the scheduler starts a new mission before starting to actually run Default. """ run in sequence set duration = 13 second } behavior Guidance:GoToSurface { run in progression } aggregate CheckIn { run in sequence repeat=288 readDatum id="Read_GPS" { timeout duration=P5M Universal:time_fix } readDatum id="Read_Iridium" { timeout duration=P4H { behavior Guidance:Execute { run in sequence set command = "Burn on" } syslog critical "Dropped weight due to communications timeout." } Universal:platform_communications } behavior Guidance:Wait { run in sequence set duration = 5 minute } assign in sequence ElapsedSinceDefaultStarted = elapsed ( Universal:mission_started ) syslog important "Default mission has been running for " + ElapsedSinceDefaultStarted~minute } syslog important "Restarting logs and Default mission." behavior Guidance:Execute { run in sequence set command = "restart logs" } } 2024-03-15T21:01:00.154Z,1710536460.154 [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, 2024-03-15T21:01:00.172Z,1710536460.172 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2024-03-15T21:01:00.239Z,1710536460.239 [Power24vConverter](INFO): Powering up. 2024-03-15T21:01:00.239Z,1710536460.239 [Sonardyne_Nano](INFO): Initializing. 2024-03-15T21:01:00.256Z,1710536460.256 [CANONSampler](INFO): Powering down 2024-03-15T21:01:00.304Z,1710536460.304 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2024-03-15T21:01:00.316Z,1710536460.316 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2024-03-15T21:01:00.318Z,1710536460.318 [ElevatorServo](DEBUG): Initializing EZServoServo. 2024-03-15T21:01:00.328Z,1710536460.328 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2024-03-15T21:01:00.329Z,1710536460.329 [MassServo](DEBUG): Initializing EZServoServo. 2024-03-15T21:01:00.337Z,1710536460.337 [MassServo](DEBUG): Initializing MassServo. 2024-03-15T21:01:00.338Z,1710536460.338 [RudderServo](DEBUG): Initializing EZServoServo. 2024-03-15T21:01:00.344Z,1710536460.344 [RudderServo](DEBUG): Initializing RudderServo. 2024-03-15T21:01:00.345Z,1710536460.345 [ThrusterHE](DEBUG): Initializing EZServoServo. 2024-03-15T21:01:00.352Z,1710536460.352 [ThrusterHE](DEBUG): Initializing ThrusterHE. 2024-03-15T21:01:01.672Z,1710536461.672 [WetLabsBB2FL](INFO): Powering down 2024-03-15T21:01:06.069Z,1710536466.069 [ThrusterHE](ERROR): Zero Speed Commanded. 2024-03-15T21:01:12.199Z,1710536472.199 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.005212 2024-03-15T21:01:28.451Z,1710536488.451 [NAL9602](INFO): Powering up NAL9602 2024-03-15T21:01:39.370Z,1710536499.370 [NAL9602](INFO): NAL9602 initialized 2024-03-15T21:02:06.433Z,1710536526.433 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-03-15T21:02:16.705Z,1710536536.705 [CommandExec](IMPORTANT): got command failComponent 2024-03-15T21:02:16.705Z,1710536536.705 [CommandExec](IMPORTANT): Failed components: 2024-03-15T21:02:16.705Z,1710536536.705 [CommandExec](IMPORTANT): No failed Components. 2024-03-15T21:02:18.957Z,1710536538.957 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-03-15T21:02:23.019Z,1710536543.019 [SBIT](IMPORTANT): Beginning Startup BIT 2024-03-15T21:02:23.023Z,1710536543.023 [CBIT](IMPORTANT): Beginning ground fault scan 2024-03-15T21:02:32.289Z,1710536552.289 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-03-15T21:02:33.988Z,1710536553.988 [CBIT](ERROR): Ground fault scan returned out of bounds value. Re-running scan. 2024-03-15T21:02:34.383Z,1710536554.383 [CBIT](IMPORTANT): Beginning ground fault scan 2024-03-15T21:02:44.814Z,1710536564.814 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-03-15T21:02:45.319Z,1710536565.319 [CBIT](ERROR): Ground fault scan returned out of bounds value. Re-running scan. 2024-03-15T21:02:45.706Z,1710536565.706 [CBIT](IMPORTANT): Beginning ground fault scan 2024-03-15T21:02:56.592Z,1710536576.592 [CBIT](ERROR): Ground fault scan returned out of bounds value. Re-running scan. 2024-03-15T21:02:56.593Z,1710536576.593 [CBIT](IMPORTANT): Ground fault scan returned out of bounds value in succession 3 times. Will re-run scan on normal schedule. 2024-03-15T21:02:58.150Z,1710536578.150 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-03-15T21:03:11.477Z,1710536591.477 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-03-15T21:03:17.201Z,1710536597.201 [SBIT](IMPORTANT): SBIT PASSED 2024-03-15T21:03:17.201Z,1710536597.201 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2024-03-15T21:03:17.202Z,1710536597.202 [SBIT](IMPORTANT): AMEcho.loadAtStartup=0 bool; 2024-03-15T21:03:17.202Z,1710536597.202 [SBIT](IMPORTANT): BPC1.batteryMissingStickThreshold=20 count; 2024-03-15T21:03:17.202Z,1710536597.202 [SBIT](IMPORTANT): CANONSampler.loadAtStartup=1 bool; 2024-03-15T21:03:17.203Z,1710536597.203 [SBIT](IMPORTANT): DAT.loadAtStartup=0 bool; 2024-03-15T21:03:17.203Z,1710536597.203 [SBIT](IMPORTANT): Sonardyne_Nano.loadAtStartup=1 bool; 2024-03-15T21:03:17.203Z,1710536597.203 [SBIT](IMPORTANT): ThrusterServo.currLimit=50 percent; 2024-03-15T21:03:17.203Z,1710536597.203 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=319.031769 cubic_centimeter; 2024-03-15T21:03:17.203Z,1710536597.203 [SBIT](IMPORTANT): VerticalControl.massDefault=-15.950069 millimeter; 2024-03-15T21:03:17.567Z,1710536597.567 [MissionManager](IMPORTANT): Started mission Startup 2024-03-15T21:03:17.568Z,1710536597.568 [Startup] Running Loop=1 2024-03-15T21:03:17.568Z,1710536597.568 [Startup](DEBUG): Aggregate::initialize Startup 2024-03-15T21:03:17.568Z,1710536597.568 [Startup:A.GoToSurface] Running Loop=1 2024-03-15T21:03:17.568Z,1710536597.568 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2024-03-15T21:03:17.569Z,1710536597.569 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2024-03-15T21:03:17.569Z,1710536597.569 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2024-03-15T21:03:17.569Z,1710536597.569 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2024-03-15T21:03:17.570Z,1710536597.570 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2024-03-15T21:03:17.570Z,1710536597.570 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2024-03-15T21:03:17.572Z,1710536597.572 [Startup:StartupSatComms] Running Loop=1 2024-03-15T21:03:17.572Z,1710536597.572 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2024-03-15T21:03:17.572Z,1710536597.572 [Startup:StartupSatComms:A] Running Loop=1 2024-03-15T21:03:17.975Z,1710536597.975 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2024-03-15T21:03:24.003Z,1710536604.003 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-03-15T21:03:25.629Z,1710536605.629 [CommandExec](IMPORTANT): got command failComponent 2024-03-15T21:03:25.629Z,1710536605.629 [CommandExec](IMPORTANT): Failed components: 2024-03-15T21:03:25.629Z,1710536605.629 [CommandExec](IMPORTANT): No failed Components. 2024-03-15T21:03:50.007Z,1710536630.007 [CommandExec](IMPORTANT): got command strobe off 2024-03-15T21:03:50.007Z,1710536630.007 [CommandExec](IMPORTANT): Deactivating strobe 2024-03-15T21:03:59.582Z,1710536639.582 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2024-03-15T21:03:59.582Z,1710536639.582 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-03-15T21:03:59.592Z,1710536639.592 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-03-15T21:04:00.002Z,1710536640.002 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-03-15T21:04:00.002Z,1710536640.002 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2024-03-15T21:04:17.779Z,1710536657.779 [Startup:StartupSatComms:A](INFO): Timed out from 2024-03-15T21:03:17.6Z 2024-03-15T21:04:17.779Z,1710536657.779 [Startup:StartupSatComms:A] Stopped 2024-03-15T21:04:17.779Z,1710536657.779 [Startup:StartupSatComms:B] Running Loop=1 2024-03-15T21:04:18.176Z,1710536658.176 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2024-03-15T21:04:24.532Z,1710536664.532 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240314T222040/Courier0007.lzma 2024-03-15T21:04:25.534Z,1710536665.534 [DataOverHttps](INFO): Moved sent file to Logs/20240314T222040/Courier0007.lzma.bak 2024-03-15T21:04:25.534Z,1710536665.534 [DataOverHttps](INFO): SBD MOMSN=19322205 2024-03-15T21:04:41.412Z,1710536681.412 [DataOverHttps](INFO): Sending 150 bytes from file Logs/20240315T210049/Courier0000.lzma 2024-03-15T21:04:42.414Z,1710536682.414 [DataOverHttps](INFO): Moved sent file to Logs/20240315T210049/Courier0000.lzma.bak 2024-03-15T21:04:42.414Z,1710536682.414 [DataOverHttps](INFO): SBD MOMSN=19322207 2024-03-15T21:04:58.028Z,1710536698.028 [DataOverHttps](INFO): Sending 202 bytes from file Logs/20240314T222040/Express0008.lzma 2024-03-15T21:04:59.030Z,1710536699.030 [DataOverHttps](INFO): Moved sent file to Logs/20240314T222040/Express0008.lzma.bak 2024-03-15T21:04:59.030Z,1710536699.030 [DataOverHttps](INFO): SBD MOMSN=19322210 2024-03-15T21:05:14.882Z,1710536714.882 [DataOverHttps](INFO): Sending 878 bytes from file Logs/20240315T210049/Express0001.lzma 2024-03-15T21:05:15.882Z,1710536715.882 [DataOverHttps](INFO): Moved sent file to Logs/20240315T210049/Express0001.lzma.bak 2024-03-15T21:05:15.882Z,1710536715.882 [DataOverHttps](INFO): SBD MOMSN=19322216 2024-03-15T21:05:17.149Z,1710536717.149 [Startup:StartupSatComms:B] Stopped 2024-03-15T21:05:17.149Z,1710536717.149 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2024-03-15T21:05:17.149Z,1710536717.149 [Startup:StartupSatComms] Stopped 2024-03-15T21:05:17.150Z,1710536717.150 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2024-03-15T21:05:17.150Z,1710536717.150 [Startup](INFO): Completed Startup 2024-03-15T21:05:17.150Z,1710536717.150 [MissionManager](INFO): Startup is completed. 2024-03-15T21:05:17.151Z,1710536717.151 [MissionManager](INFO): Uninitializing Mission Startup 2024-03-15T21:05:17.151Z,1710536717.151 [Startup] Stopped 2024-03-15T21:05:17.151Z,1710536717.151 [Startup](DEBUG): Aggregate::uninitialize Startup 2024-03-15T21:05:17.151Z,1710536717.151 [Startup:A.GoToSurface] Stopped 2024-03-15T21:05:17.151Z,1710536717.151 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2024-03-15T21:05:17.545Z,1710536717.545 [MissionManager](IMPORTANT): Started mission Default 2024-03-15T21:05:17.545Z,1710536717.545 [Default] Running Loop=1 2024-03-15T21:05:17.545Z,1710536717.545 [Default](DEBUG): Aggregate::initialize Default 2024-03-15T21:05:17.545Z,1710536717.545 [Default:B.GoToSurface] Running Loop=1 2024-03-15T21:05:17.545Z,1710536717.545 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2024-03-15T21:05:17.546Z,1710536717.546 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2024-03-15T21:05:17.546Z,1710536717.546 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2024-03-15T21:05:17.546Z,1710536717.546 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2024-03-15T21:05:17.546Z,1710536717.546 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2024-03-15T21:05:17.547Z,1710536717.547 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2024-03-15T21:05:17.547Z,1710536717.547 [Default:A.Wait] Running Loop=1 2024-03-15T21:05:17.547Z,1710536717.547 [Default:A.Wait](DEBUG): Initialize Wait Component. 2024-03-15T21:05:30.877Z,1710536730.877 [Default:A.Wait](INFO): Done Waiting. 2024-03-15T21:05:30.878Z,1710536730.878 [Default:A.Wait] Stopped 2024-03-15T21:05:30.878Z,1710536730.878 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2024-03-15T21:05:31.282Z,1710536731.282 [Default:CheckIn] Running Loop=1 2024-03-15T21:05:31.282Z,1710536731.282 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-03-15T21:05:31.282Z,1710536731.282 [Default:CheckIn:Read_GPS] Running Loop=1 2024-03-15T21:05:31.690Z,1710536731.690 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2024-03-15T21:05:57.117Z,1710536757.117 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-03-15T21:06:04.800Z,1710536764.800 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-03-15T21:06:06.814Z,1710536766.814 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-03-15T21:06:06.821Z,1710536766.821 [BPC1](INFO): Calculating totals. Valid battery stick count: 37. Valid reserve battery stick count: 5. 2024-03-15T21:06:06.825Z,1710536766.825 [BPC1](INFO): Received data from all battery sticks. 2024-03-15T21:06:42.778Z,1710536802.778 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2024-03-15T21:07:00.585Z,1710536820.585 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2024-03-15T21:07:00.585Z,1710536820.585 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-03-15T21:07:00.595Z,1710536820.595 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-03-15T21:07:01.013Z,1710536821.013 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-03-15T21:07:01.013Z,1710536821.013 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2024-03-15T21:10:01.584Z,1710537001.584 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3 2024-03-15T21:10:01.588Z,1710537001.588 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-03-15T21:10:01.631Z,1710537001.631 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-03-15T21:10:01.995Z,1710537001.995 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-03-15T21:10:01.995Z,1710537001.995 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3 2024-03-15T21:10:31.575Z,1710537031.575 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-03-15T21:05:31.3Z 2024-03-15T21:10:31.575Z,1710537031.575 [Default:CheckIn:Read_GPS] Stopped 2024-03-15T21:10:31.575Z,1710537031.575 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-03-15T21:10:31.858Z,1710537031.858 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications 2024-03-15T21:10:38.000Z,1710537039.000 [DataOverHttps](INFO): Sending 169 bytes from file Logs/20240315T210049/Courier0004.lzma 2024-03-15T21:10:40.003Z,1710537040.003 [DataOverHttps](INFO): Moved sent file to Logs/20240315T210049/Courier0004.lzma.bak 2024-03-15T21:10:40.003Z,1710537040.003 [DataOverHttps](INFO): SBD MOMSN=19322254 2024-03-15T21:10:55.452Z,1710537055.452 [DataOverHttps](INFO): Sending 187 bytes from file Logs/20240315T210049/Express0005.lzma 2024-03-15T21:10:56.454Z,1710537056.454 [DataOverHttps](INFO): Moved sent file to Logs/20240315T210049/Express0005.lzma.bak 2024-03-15T21:10:56.454Z,1710537056.454 [DataOverHttps](INFO): SBD MOMSN=19322262 2024-03-15T21:10:57.726Z,1710537057.726 [Default:CheckIn:Read_Iridium] Stopped 2024-03-15T21:10:57.726Z,1710537057.726 [Default:CheckIn:C.Wait] Running Loop=1 2024-03-15T21:10:57.726Z,1710537057.726 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-03-15T21:11:01.349Z,1710537061.349 [Power24vConverter](INFO): Powering down. 2024-03-15T21:11:40.526Z,1710537100.526 [NAL9602](FAULT): GPS failed to acquire within timeout. 2024-03-15T21:11:40.526Z,1710537100.526 [NAL9602] Data Fault, FailCount= 1 2024-03-15T21:11:40.526Z,1710537100.526 [NAL9602](ERROR): Data Fault 2024-03-15T21:11:40.571Z,1710537100.571 [CBIT](ERROR): Data Fault in component: NAL9602 2024-03-15T21:11:40.930Z,1710537100.930 [NAL9602](INFO): Powering down 2024-03-15T21:11:41.759Z,1710537101.759 [CBIT](INFO): Clearing failed state for component NAL9602 2024-03-15T21:11:41.759Z,1710537101.759 [NAL9602] No Fault, FailCount= 1 2024-03-15T21:12:11.229Z,1710537131.229 [NAL9602](INFO): Powering up NAL9602 2024-03-15T21:12:22.138Z,1710537142.138 [NAL9602](INFO): NAL9602 initialized 2024-03-15T21:13:02.549Z,1710537182.549 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4 2024-03-15T21:13:02.549Z,1710537182.549 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-03-15T21:13:02.596Z,1710537182.596 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-03-15T21:13:03.012Z,1710537183.012 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-03-15T21:13:03.013Z,1710537183.013 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4 2024-03-15T21:15:58.309Z,1710537358.309 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-03-15T21:15:58.309Z,1710537358.309 [Default:CheckIn:C.Wait] Stopped 2024-03-15T21:15:58.310Z,1710537358.310 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-03-15T21:15:58.310Z,1710537358.310 [Default:CheckIn:D] Running Loop=1 2024-03-15T21:15:58.707Z,1710537358.707 [Default:CheckIn:D] Stopped 2024-03-15T21:15:58.707Z,1710537358.707 [Default:CheckIn:E] Running Loop=1 2024-03-15T21:15:59.098Z,1710537359.098 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 10.686030 min 2024-03-15T21:15:59.098Z,1710537359.098 [Default:CheckIn:E] Stopped 2024-03-15T21:15:59.098Z,1710537359.098 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-03-15T21:15:59.098Z,1710537359.098 [Default:CheckIn] Stopped 2024-03-15T21:15:59.098Z,1710537359.098 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-03-15T21:15:59.098Z,1710537359.098 [Default:CheckIn](INFO): Running loop #2 2024-03-15T21:15:59.098Z,1710537359.098 [Default:CheckIn] Running Loop=2 2024-03-15T21:15:59.098Z,1710537359.098 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-03-15T21:15:59.098Z,1710537359.098 [Default:CheckIn:Read_GPS] Running Loop=1 2024-03-15T21:16:03.549Z,1710537363.549 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5 2024-03-15T21:16:03.549Z,1710537363.549 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-03-15T21:16:03.570Z,1710537363.570 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-03-15T21:16:03.990Z,1710537363.990 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-03-15T21:16:03.990Z,1710537363.990 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5 2024-03-15T21:19:04.526Z,1710537544.526 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6 2024-03-15T21:19:04.526Z,1710537544.526 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-03-15T21:19:04.536Z,1710537544.536 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-03-15T21:19:04.956Z,1710537544.956 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-03-15T21:19:04.956Z,1710537544.956 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6 2024-03-15T21:20:59.323Z,1710537659.323 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-03-15T21:15:59.1Z 2024-03-15T21:20:59.323Z,1710537659.323 [Default:CheckIn:Read_GPS] Stopped 2024-03-15T21:20:59.323Z,1710537659.323 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-03-15T21:21:06.119Z,1710537666.119 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240315T210049/Courier0007.lzma 2024-03-15T21:21:07.122Z,1710537667.122 [DataOverHttps](INFO): Moved sent file to Logs/20240315T210049/Courier0007.lzma.bak 2024-03-15T21:21:07.122Z,1710537667.122 [DataOverHttps](INFO): SBD MOMSN=19322272 2024-03-15T21:21:22.580Z,1710537682.580 [DataOverHttps](INFO): Sending 181 bytes from file Logs/20240315T210049/Express0008.lzma 2024-03-15T21:21:23.582Z,1710537683.582 [DataOverHttps](INFO): Moved sent file to Logs/20240315T210049/Express0008.lzma.bak 2024-03-15T21:21:23.582Z,1710537683.582 [DataOverHttps](INFO): SBD MOMSN=19322275 2024-03-15T21:21:24.790Z,1710537684.790 [Default:CheckIn:Read_Iridium] Stopped 2024-03-15T21:21:24.790Z,1710537684.790 [Default:CheckIn:C.Wait] Running Loop=1 2024-03-15T21:21:24.790Z,1710537684.790 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-03-15T21:22:05.612Z,1710537725.612 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7 2024-03-15T21:22:05.612Z,1710537725.612 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-03-15T21:22:05.653Z,1710537725.653 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-03-15T21:22:05.987Z,1710537725.987 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-03-15T21:22:05.987Z,1710537725.987 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7 2024-03-15T21:22:15.965Z,1710537735.965 [CommandExec](IMPORTANT): got command configSet PowerOnly.loadAtStartup 1 bool persist 2024-03-15T21:22:15.966Z,1710537735.966 [CommandExec](IMPORTANT): configSet PowerOnly.loadAtStartup requires a restart to take effect. 2024-03-15T21:22:24.554Z,1710537744.554 [NAL9602](FAULT): GPS failed to acquire within timeout. 2024-03-15T21:22:24.554Z,1710537744.554 [NAL9602] Data Fault, FailCount= 2 2024-03-15T21:22:24.554Z,1710537744.554 [NAL9602](ERROR): Data Fault 2024-03-15T21:22:24.575Z,1710537744.575 [CBIT](ERROR): Data Fault in component: NAL9602 2024-03-15T21:22:24.959Z,1710537744.959 [NAL9602](INFO): Powering down 2024-03-15T21:22:25.782Z,1710537745.782 [CBIT](INFO): Clearing failed state for component NAL9602 2024-03-15T21:22:25.782Z,1710537745.782 [NAL9602] No Fault, FailCount= 2 2024-03-15T21:22:55.250Z,1710537775.250 [NAL9602](INFO): Powering up NAL9602 2024-03-15T21:23:06.166Z,1710537786.166 [NAL9602](INFO): NAL9602 initialized 2024-03-15T21:25:06.568Z,1710537906.568 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8 2024-03-15T21:25:06.568Z,1710537906.568 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-03-15T21:25:06.594Z,1710537906.594 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-03-15T21:25:07.018Z,1710537907.018 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-03-15T21:25:07.018Z,1710537907.018 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8 2024-03-15T21:25:15.598Z,1710537915.598 [CommandExec](IMPORTANT): got command configSet PowerOnly.simulateHardware 0 bool persist 2024-03-15T21:26:06.605Z,1710537966.605 [CommandExec](IMPORTANT): got command configSet PowerOnly.sampleTime1 0 second persist 2024-03-15T21:26:25.344Z,1710537985.344 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-03-15T21:26:25.344Z,1710537985.344 [Default:CheckIn:C.Wait] Stopped 2024-03-15T21:26:25.344Z,1710537985.344 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-03-15T21:26:25.344Z,1710537985.344 [Default:CheckIn:D] Running Loop=1 2024-03-15T21:26:25.759Z,1710537985.759 [Default:CheckIn:D] Stopped 2024-03-15T21:26:25.759Z,1710537985.759 [Default:CheckIn:E] Running Loop=1 2024-03-15T21:26:26.175Z,1710537986.175 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 21.136898 min 2024-03-15T21:26:26.175Z,1710537986.175 [Default:CheckIn:E] Stopped 2024-03-15T21:26:26.175Z,1710537986.175 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-03-15T21:26:26.175Z,1710537986.175 [Default:CheckIn] Stopped 2024-03-15T21:26:26.176Z,1710537986.176 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-03-15T21:26:26.176Z,1710537986.176 [Default:CheckIn](INFO): Running loop #3 2024-03-15T21:26:26.176Z,1710537986.176 [Default:CheckIn] Running Loop=3 2024-03-15T21:26:26.176Z,1710537986.176 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-03-15T21:26:26.176Z,1710537986.176 [Default:CheckIn:Read_GPS] Running Loop=1 2024-03-15T21:26:27.006Z,1710537987.006 [CommandExec](IMPORTANT): got command restart application 2024-03-15T21:26:28.008Z,1710537988.008 [Supervisor](INFO): Stop Mission called by Supervisor::terminate 2024-03-15T21:26:28.009Z,1710537988.009 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2024-03-15T21:26:28.009Z,1710537988.009 [CommandExec](INFO): Uninitializing the command executive. 2024-03-15T21:26:28.009Z,1710537988.009 [CommandExec](INFO): Uninitializing the command scheduler. 2024-03-15T21:26:28.009Z,1710537988.009 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-03-15T21:26:28.132Z,1710537988.132 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2024-03-15T21:26:28.132Z,1710537988.132 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2024-03-15T21:26:28.132Z,1710537988.132 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-03-15T21:26:28.133Z,1710537988.133 [NavChartDb](INFO): Join timeout helper Thread ID is 6442 2024-03-15T21:26:28.368Z,1710537988.368 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2024-03-15T21:26:28.369Z,1710537988.369 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-03-15T21:26:28.392Z,1710537988.392 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2024-03-15T21:26:28.392Z,1710537988.392 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-03-15T21:26:28.393Z,1710537988.393 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 6443 2024-03-15T21:26:28.800Z,1710537988.800 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2024-03-15T21:26:28.801Z,1710537988.801 [WetLabsBB2FL](INFO): Powering down 2024-03-15T21:26:28.801Z,1710537988.801 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-03-15T21:26:28.810Z,1710537988.810 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2024-03-15T21:26:28.810Z,1710537988.810 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-03-15T21:26:28.810Z,1710537988.810 [CTD_Seabird](INFO): Join timeout helper Thread ID is 6444 2024-03-15T21:26:28.857Z,1710537988.857 [CTD_Seabird](INFO): Powering down 2024-03-15T21:26:28.868Z,1710537988.868 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2024-03-15T21:26:28.868Z,1710537988.868 [CTD_Seabird](INFO): Powering down 2024-03-15T21:26:28.880Z,1710537988.880 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-03-15T21:26:28.884Z,1710537988.884 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2024-03-15T21:26:28.884Z,1710537988.884 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-03-15T21:26:28.885Z,1710537988.885 [Radio_Surface](INFO): Join timeout helper Thread ID is 6445 2024-03-15T21:26:29.216Z,1710537989.216 [Radio_Surface](INFO): Powering down 2024-03-15T21:26:29.217Z,1710537989.217 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2024-03-15T21:26:29.217Z,1710537989.217 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-03-15T21:26:29.228Z,1710537989.228 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2024-03-15T21:26:29.228Z,1710537989.228 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-03-15T21:26:29.229Z,1710537989.229 [Onboard](INFO): Join timeout helper Thread ID is 6446 2024-03-15T21:26:30.804Z,1710537990.804 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2024-03-15T21:26:30.804Z,1710537990.804 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-03-15T21:26:30.813Z,1710537990.813 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2024-03-15T21:26:30.813Z,1710537990.813 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-03-15T21:26:30.813Z,1710537990.813 [DataOverHttps](INFO): Join timeout helper Thread ID is 6447 2024-03-15T21:26:31.776Z,1710537991.776 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2024-03-15T21:26:31.777Z,1710537991.777 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-03-15T21:26:31.785Z,1710537991.785 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2024-03-15T21:26:31.785Z,1710537991.785 [logger ThreadHandler](INFO): Thread cancelled. 2024-03-15T21:26:31.785Z,1710537991.785 [logger](INFO): Join timeout helper Thread ID is 6448 2024-03-15T21:26:31.820Z,1710537991.820 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2024-03-15T21:26:31.821Z,1710537991.821 [logger ThreadHandler](INFO): Thread cancelled. 2024-03-15T21:26:31.837Z,1710537991.837 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2024-03-15T21:26:31.837Z,1710537991.837 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-03-15T21:26:31.837Z,1710537991.837 [CommandLine](INFO): Join timeout helper Thread ID is 6449 2024-03-15T21:26:31.916Z,1710537991.916 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2024-03-15T21:26:31.917Z,1710537991.917 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-03-15T21:26:31.937Z,1710537991.937 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2024-03-15T21:26:31.937Z,1710537991.937 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-03-15T21:26:31.937Z,1710537991.937 [CommandExec](INFO): Join timeout helper Thread ID is 6450 2024-03-15T21:26:31.939Z,1710537991.939 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2024-03-15T21:26:31.939Z,1710537991.939 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-03-15T21:26:31.939Z,1710537991.939 [controlThread](INFO): Join timeout helper Thread ID is 6451 2024-03-15T21:26:32.188Z,1710537992.188 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2024-03-15T21:26:32.189Z,1710537992.189 [controlThread](DEBUG): Uninitializing ControlThread 2024-03-15T21:26:32.189Z,1710537992.189 [AHRS_M2](INFO): Powering down 2024-03-15T21:26:32.261Z,1710537992.261 [NAL9602](INFO): Powering down 2024-03-15T21:26:32.262Z,1710537992.262 [Sonardyne_Nano](INFO): Powering down 2024-03-15T21:26:32.382Z,1710537992.382 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2024-03-15T21:26:32.383Z,1710537992.383 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2024-03-15T21:26:32.383Z,1710537992.383 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2024-03-15T21:26:32.384Z,1710537992.384 [MissionManager](INFO): Uninitializing Mission Default 2024-03-15T21:26:32.384Z,1710537992.384 [Default] Stopped 2024-03-15T21:26:32.384Z,1710537992.384 [Default](DEBUG): Aggregate::uninitialize Default 2024-03-15T21:26:32.384Z,1710537992.384 [Default:B.GoToSurface] Stopped 2024-03-15T21:26:32.384Z,1710537992.384 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2024-03-15T21:26:32.384Z,1710537992.384 [Default:CheckIn] Stopped 2024-03-15T21:26:32.384Z,1710537992.384 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-03-15T21:26:32.384Z,1710537992.384 [Default:CheckIn:Read_GPS] Stopped 2024-03-15T21:26:32.387Z,1710537992.387 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2024-03-15T21:26:32.388Z,1710537992.388 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2024-03-15T21:26:32.388Z,1710537992.388 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2024-03-15T21:26:32.389Z,1710537992.389 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2024-03-15T21:26:32.389Z,1710537992.389 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2024-03-15T21:26:32.389Z,1710537992.389 [BuoyancyServo](INFO): Powering down 2024-03-15T21:26:32.404Z,1710537992.404 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2024-03-15T21:26:32.404Z,1710537992.404 [ElevatorServo](INFO): Powering down 2024-03-15T21:26:32.405Z,1710537992.405 [MassServo](DEBUG): Uninitialize Mass Servo. 2024-03-15T21:26:32.405Z,1710537992.405 [MassServo](INFO): Powering down 2024-03-15T21:26:32.406Z,1710537992.406 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2024-03-15T21:26:32.406Z,1710537992.406 [RudderServo](INFO): Powering down 2024-03-15T21:26:32.407Z,1710537992.407 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2024-03-15T21:26:32.407Z,1710537992.407 [ThrusterHE](INFO): Powering down 2024-03-15T21:26:32.408Z,1710537992.408 [SBIT](DEBUG): Uninitialize SBIT Component. 2024-03-15T21:26:32.408Z,1710537992.408 [IBIT](DEBUG): Uninitialize IBIT Component. 2024-03-15T21:26:32.409Z,1710537992.409 [CBIT](DEBUG): Uninitialize CBIT Component. 2024-03-15T21:26:32.409Z,1710537992.409 [CBIT](DEBUG): Powering off loads. 2024-03-15T21:26:32.420Z,1710537992.420 [CBIT](DEBUG): Disabling WDT. 2024-03-15T21:26:32.432Z,1710537992.432 [CBIT](DEBUG): Opening all GF detection circuits. 2024-03-15T21:26:32.433Z,1710537992.433 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-03-15T21:26:32.482Z,1710537992.482 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-03-15T21:26:32.484Z,1710537992.484 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-03-15T21:26:32.490Z,1710537992.490 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-03-15T21:26:32.562Z,1710537992.562 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-03-15T21:26:32.566Z,1710537992.566 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-03-15T21:26:32.607Z,1710537992.607 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-03-15T21:26:32.673Z,1710537992.673 [logger ThreadHandler](INFO): Thread cancelled.