2024-05-20T21:27:42.640Z,1716240462.640 [Supervisor](DEBUG): Initializing supervisor.
2024-05-20T21:27:42.645Z,1716240462.645 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2024-05-20T21:27:42.645Z,1716240462.645 [SyncHandler](INFO): Protected caller Thread ID is 1346
2024-05-20T21:27:42.646Z,1716240462.646 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2024-05-20T21:27:42.647Z,1716240462.647 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2024-05-20T21:27:42.647Z,1716240462.647 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 1347
2024-05-20T21:27:42.651Z,1716240462.651 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2024-05-20T21:27:42.670Z,1716240462.670 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2024-05-20T21:27:42.671Z,1716240462.671 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2024-05-20T21:27:42.671Z,1716240462.671 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 1348
2024-05-20T21:27:42.675Z,1716240462.675 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2024-05-20T21:27:42.676Z,1716240462.676 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2024-05-20T21:27:42.677Z,1716240462.677 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 1349
2024-05-20T21:27:42.679Z,1716240462.679 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2024-05-20T21:27:42.680Z,1716240462.680 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2024-05-20T21:27:42.680Z,1716240462.680 [logger ThreadHandler](INFO): Protected caller Thread ID is 1350
2024-05-20T21:27:42.684Z,1716240462.684 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2024-05-20T21:27:42.684Z,1716240462.684 [Supervisor](INFO): Looking for Config files in directory: Config/
2024-05-20T21:27:42.686Z,1716240462.686 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2024-05-20T21:27:42.800Z,1716240462.800 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2024-05-20T21:27:42.801Z,1716240462.801 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2024-05-20T21:27:43.670Z,1716240463.670 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2024-05-20T21:27:43.671Z,1716240463.671 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2024-05-20T21:27:43.942Z,1716240463.942 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2024-05-20T21:27:43.943Z,1716240463.943 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2024-05-20T21:27:44.037Z,1716240464.037 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2024-05-20T21:27:44.191Z,1716240464.191 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2024-05-20T21:27:44.191Z,1716240464.191 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2024-05-20T21:27:44.288Z,1716240464.288 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2024-05-20T21:27:44.425Z,1716240464.425 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2024-05-20T21:27:44.426Z,1716240464.426 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2024-05-20T21:27:44.886Z,1716240464.886 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2024-05-20T21:27:44.886Z,1716240464.886 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2024-05-20T21:27:45.507Z,1716240465.507 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2024-05-20T21:27:45.508Z,1716240465.508 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2024-05-20T21:27:45.765Z,1716240465.765 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2024-05-20T21:27:45.765Z,1716240465.765 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2024-05-20T21:27:45.987Z,1716240465.987 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2024-05-20T21:27:45.987Z,1716240465.987 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2024-05-20T21:27:46.607Z,1716240466.607 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2024-05-20T21:27:46.607Z,1716240466.607 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2024-05-20T21:27:46.954Z,1716240466.954 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2024-05-20T21:27:46.955Z,1716240466.955 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2024-05-20T21:27:47.597Z,1716240467.597 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2024-05-20T21:27:47.598Z,1716240467.598 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2024-05-20T21:27:48.269Z,1716240468.269 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2024-05-20T21:27:48.270Z,1716240468.270 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2024-05-20T21:27:48.677Z,1716240468.677 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2024-05-20T21:27:48.679Z,1716240468.679 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-pontus/
2024-05-20T21:27:48.680Z,1716240468.680 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/secure.cfg
2024-05-20T21:27:48.780Z,1716240468.780 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Sensor.cfg
2024-05-20T21:27:48.972Z,1716240468.972 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/workSite.cfg
2024-05-20T21:27:49.084Z,1716240469.084 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Servo.cfg
2024-05-20T21:27:49.212Z,1716240469.212 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Simulator.cfg
2024-05-20T21:27:49.314Z,1716240469.314 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/logger.cfg
2024-05-20T21:27:49.427Z,1716240469.427 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/vehicle.cfg
2024-05-20T21:27:49.560Z,1716240469.560 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Battery.cfg
2024-05-20T21:27:49.857Z,1716240469.857 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2024-05-20T21:27:49.858Z,1716240469.858 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Navigation.cfg
2024-05-20T21:27:49.969Z,1716240469.969 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/BIT.cfg
2024-05-20T21:27:50.080Z,1716240470.080 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Science.cfg
2024-05-20T21:27:50.246Z,1716240470.246 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Control.cfg
2024-05-20T21:27:50.365Z,1716240470.365 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-pontus/root/
2024-05-20T21:27:50.365Z,1716240470.365 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg
2024-05-20T21:27:50.381Z,1716240470.381 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2024-05-20T21:27:50.517Z,1716240470.517 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2024-05-20T21:27:50.518Z,1716240470.518 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2024-05-20T21:27:50.578Z,1716240470.578 [VerticalControl](DEBUG): Construct VerticalControl.
2024-05-20T21:27:50.641Z,1716240470.641 [VerticalControl] Loaded
2024-05-20T21:27:50.642Z,1716240470.642 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2024-05-20T21:27:50.645Z,1716240470.645 [HorizontalControl](DEBUG): Construct HorizontalControl.
2024-05-20T21:27:50.694Z,1716240470.694 [HorizontalControl] Loaded
2024-05-20T21:27:50.695Z,1716240470.695 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2024-05-20T21:27:50.697Z,1716240470.697 [SpeedControl](DEBUG): Construct SpeedControl.
2024-05-20T21:27:50.701Z,1716240470.701 [SpeedControl] Loaded
2024-05-20T21:27:50.701Z,1716240470.701 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2024-05-20T21:27:50.704Z,1716240470.704 [LoopControl](DEBUG): Construct LoopControl.
2024-05-20T21:27:50.704Z,1716240470.704 [LoopControl] Loaded
2024-05-20T21:27:50.704Z,1716240470.704 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2024-05-20T21:27:50.705Z,1716240470.705 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2024-05-20T21:27:50.705Z,1716240470.705 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2024-05-20T21:27:50.761Z,1716240470.761 [DepthRateCalculator] Loaded
2024-05-20T21:27:50.762Z,1716240470.762 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2024-05-20T21:27:50.767Z,1716240470.767 [PitchRateCalculator] Loaded
2024-05-20T21:27:50.767Z,1716240470.767 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2024-05-20T21:27:50.778Z,1716240470.778 [SpeedCalculator] Loaded
2024-05-20T21:27:50.778Z,1716240470.778 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2024-05-20T21:27:50.783Z,1716240470.783 [YawRateCalculator] Loaded
2024-05-20T21:27:50.783Z,1716240470.783 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2024-05-20T21:27:50.802Z,1716240470.802 [ElevatorOffsetCalculator] Loaded
2024-05-20T21:27:50.802Z,1716240470.802 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2024-05-20T21:27:50.803Z,1716240470.803 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2024-05-20T21:27:50.803Z,1716240470.803 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2024-05-20T21:27:50.833Z,1716240470.833 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2024-05-20T21:27:50.834Z,1716240470.834 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2024-05-20T21:27:50.899Z,1716240470.899 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2024-05-20T21:27:50.899Z,1716240470.899 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2024-05-20T21:27:51.291Z,1716240471.291 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2024-05-20T21:27:51.291Z,1716240471.291 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2024-05-20T21:27:51.492Z,1716240471.492 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2024-05-20T21:27:51.493Z,1716240471.493 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2024-05-20T21:27:52.012Z,1716240472.012 [AHRS_M2] Loaded
2024-05-20T21:27:52.012Z,1716240472.012 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2024-05-20T21:27:52.049Z,1716240472.049 [BackseatComponent] Loaded
2024-05-20T21:27:52.049Z,1716240472.049 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread.
2024-05-20T21:27:52.051Z,1716240472.051 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 409C34E0
2024-05-20T21:27:52.051Z,1716240472.051 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 1435
2024-05-20T21:27:52.054Z,1716240472.054 [LcmUniversalReporter] Loaded
2024-05-20T21:27:52.054Z,1716240472.054 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread.
2024-05-20T21:27:53.458Z,1716240473.458 [BPC1] Loaded
2024-05-20T21:27:53.458Z,1716240473.458 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2024-05-20T21:27:53.536Z,1716240473.536 [DataOverHttps] Loaded
2024-05-20T21:27:53.536Z,1716240473.536 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2024-05-20T21:27:53.537Z,1716240473.537 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 409F34E0
2024-05-20T21:27:53.538Z,1716240473.538 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 1436
2024-05-20T21:27:53.560Z,1716240473.560 [Depth_Keller] Loaded
2024-05-20T21:27:53.560Z,1716240473.560 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2024-05-20T21:27:53.627Z,1716240473.627 [NAL9602] Loaded
2024-05-20T21:27:53.627Z,1716240473.627 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2024-05-20T21:27:53.658Z,1716240473.658 [Onboard] Loaded
2024-05-20T21:27:53.659Z,1716240473.659 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2024-05-20T21:27:53.660Z,1716240473.660 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 40A234E0
2024-05-20T21:27:53.660Z,1716240473.660 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 1437
2024-05-20T21:27:53.673Z,1716240473.673 [Power24vConverter] Loaded
2024-05-20T21:27:53.674Z,1716240473.674 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2024-05-20T21:27:53.687Z,1716240473.687 [Radio_Surface] Loaded
2024-05-20T21:27:53.688Z,1716240473.688 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2024-05-20T21:27:53.689Z,1716240473.689 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 40A534E0
2024-05-20T21:27:53.689Z,1716240473.689 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 1438
2024-05-20T21:27:53.737Z,1716240473.737 [RDI_Pathfinder] Loaded
2024-05-20T21:27:53.737Z,1716240473.737 [ComponentRegistry](DEBUG): SyncComponent "RDI_Pathfinder" handled in the control thread.
2024-05-20T21:27:53.834Z,1716240473.834 [DAT] Loaded
2024-05-20T21:27:53.834Z,1716240473.834 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread.
2024-05-20T21:27:53.836Z,1716240473.836 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 40A834E0
2024-05-20T21:27:53.836Z,1716240473.836 [DAT ThreadHandler](INFO): Protected caller Thread ID is 1439
2024-05-20T21:27:53.837Z,1716240473.837 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2024-05-20T21:27:53.837Z,1716240473.837 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2024-05-20T21:27:53.960Z,1716240473.960 [DeadReckonUsingMultipleVelocitySources] Loaded
2024-05-20T21:27:53.961Z,1716240473.961 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2024-05-20T21:27:53.975Z,1716240473.975 [NavChart] Loaded
2024-05-20T21:27:53.975Z,1716240473.975 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2024-05-20T21:27:53.981Z,1716240473.981 [UniversalFixResidualReporter] Loaded
2024-05-20T21:27:53.982Z,1716240473.982 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2024-05-20T21:27:53.982Z,1716240473.982 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2024-05-20T21:27:53.983Z,1716240473.983 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2024-05-20T21:27:54.146Z,1716240474.146 [SBIT](DEBUG): Construct Startup Built In Test.
2024-05-20T21:27:54.155Z,1716240474.155 [SBIT] Loaded
2024-05-20T21:27:54.156Z,1716240474.156 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2024-05-20T21:27:54.159Z,1716240474.159 [IBIT](DEBUG): Construct Initiated Built In Test.
2024-05-20T21:27:54.172Z,1716240474.172 [IBIT] Loaded
2024-05-20T21:27:54.173Z,1716240474.173 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2024-05-20T21:27:54.179Z,1716240474.179 [CBIT](DEBUG): Construct Continuous Built In Test.
2024-05-20T21:27:54.291Z,1716240474.291 [CBIT] Loaded
2024-05-20T21:27:54.292Z,1716240474.292 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2024-05-20T21:27:54.292Z,1716240474.292 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2024-05-20T21:27:54.293Z,1716240474.293 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2024-05-20T21:27:54.441Z,1716240474.441 [BuoyancyServo] Loaded
2024-05-20T21:27:54.441Z,1716240474.441 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2024-05-20T21:27:54.463Z,1716240474.463 [ElevatorServo] Loaded
2024-05-20T21:27:54.463Z,1716240474.463 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2024-05-20T21:27:54.493Z,1716240474.493 [DockingStepper] Loaded
2024-05-20T21:27:54.493Z,1716240474.493 [ComponentRegistry](DEBUG): SyncComponent "DockingStepper" handled in the control thread.
2024-05-20T21:27:54.514Z,1716240474.514 [MassServo] Loaded
2024-05-20T21:27:54.514Z,1716240474.514 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2024-05-20T21:27:54.534Z,1716240474.534 [RudderServo] Loaded
2024-05-20T21:27:54.534Z,1716240474.534 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2024-05-20T21:27:54.552Z,1716240474.552 [ThrusterServo] Loaded
2024-05-20T21:27:54.553Z,1716240474.553 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2024-05-20T21:27:54.553Z,1716240474.553 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2024-05-20T21:27:54.554Z,1716240474.554 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2024-05-20T21:27:54.565Z,1716240474.565 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2024-05-20T21:27:54.566Z,1716240474.566 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2024-05-20T21:27:54.761Z,1716240474.761 [CTD_Seabird] Loaded
2024-05-20T21:27:54.761Z,1716240474.761 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2024-05-20T21:27:54.762Z,1716240474.762 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40BD74E0
2024-05-20T21:27:54.762Z,1716240474.762 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 1440
2024-05-20T21:27:54.798Z,1716240474.798 [ESPComponent] Loaded
2024-05-20T21:27:54.798Z,1716240474.798 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread.
2024-05-20T21:27:54.819Z,1716240474.819 [PAR_Licor] Loaded
2024-05-20T21:27:54.820Z,1716240474.820 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2024-05-20T21:27:54.866Z,1716240474.866 [WetLabsBB2FL] Loaded
2024-05-20T21:27:54.866Z,1716240474.866 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2024-05-20T21:27:54.867Z,1716240474.867 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40C074E0
2024-05-20T21:27:54.868Z,1716240474.868 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 1441
2024-05-20T21:27:54.888Z,1716240474.888 [WetLabsUBAT] Loaded
2024-05-20T21:27:54.889Z,1716240474.889 [ComponentRegistry](DEBUG): Component "WetLabsUBAT" handled in its own thread.
2024-05-20T21:27:54.890Z,1716240474.890 [WetLabsUBAT ThreadHandler](DEBUG): Created PCaller Thread at 40C374E0
2024-05-20T21:27:54.890Z,1716240474.890 [WetLabsUBAT ThreadHandler](INFO): Protected caller Thread ID is 1442
2024-05-20T21:27:54.891Z,1716240474.891 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2024-05-20T21:27:54.897Z,1716240474.897 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2024-05-20T21:27:54.900Z,1716240474.900 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2024-05-20T21:27:54.912Z,1716240474.912 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2024-05-20T21:27:54.913Z,1716240474.913 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C674E0
2024-05-20T21:27:54.913Z,1716240474.913 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 1443
2024-05-20T21:27:54.918Z,1716240474.918 [Supervisor](INFO): Main Thread ID is 831
2024-05-20T21:27:54.918Z,1716240474.918 [Supervisor](DEBUG): Running supervisor.
2024-05-20T21:27:54.919Z,1716240474.919 [CommandExec ThreadHandler](INFO): Handler Thread ID is 1444
2024-05-20T21:27:54.920Z,1716240474.920 [CommandExec](INFO): Initializing the command executive.
2024-05-20T21:27:54.921Z,1716240474.921 [CommandLine ThreadHandler](INFO): Handler Thread ID is 1445
2024-05-20T21:27:54.925Z,1716240474.925 [controlThread ThreadHandler](INFO): Handler Thread ID is 1446
2024-05-20T21:27:54.925Z,1716240474.925 [controlThread](DEBUG): Initializing ControlThread
2024-05-20T21:27:54.926Z,1716240474.926 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2024-05-20T21:27:54.927Z,1716240474.927 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2024-05-20T21:27:54.928Z,1716240474.928 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2024-05-20T21:27:54.929Z,1716240474.929 [LoopControl](DEBUG): Initialize LoopControlComponent.
2024-05-20T21:27:54.929Z,1716240474.929 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2024-05-20T21:27:54.929Z,1716240474.929 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2024-05-20T21:27:54.930Z,1716240474.930 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2024-05-20T21:27:54.930Z,1716240474.930 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2024-05-20T21:27:54.930Z,1716240474.930 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2024-05-20T21:27:54.937Z,1716240474.937 [NavChart](DEBUG): Initialize NavChart Navigation.
2024-05-20T21:27:54.937Z,1716240474.937 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2024-05-20T21:27:54.938Z,1716240474.938 [SBIT](INFO): Initialize SBIT Component.
2024-05-20T21:27:54.938Z,1716240474.938 [SBIT](IMPORTANT): git: 2024-05-10
2024-05-20T21:27:54.938Z,1716240474.938 [SBIT](INFO): git hash: a134c88d686ec779525c21b16fbeda2a3b596732
2024-05-20T21:27:54.939Z,1716240474.939 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2024-05-20T21:27:54.940Z,1716240474.940 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #1 PREEMPT Thu Feb 21 11:17:40 PST 2019
Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021
2024-05-20T21:27:54.941Z,1716240474.941 [SBIT](INFO): Beginning SBIT in 94.000000 seconds.
2024-05-20T21:27:54.942Z,1716240474.942 [IBIT](INFO): Initialize IBIT Component.
2024-05-20T21:27:54.942Z,1716240474.942 [CBIT](DEBUG): Initialize CBIT Component.
2024-05-20T21:27:54.943Z,1716240474.943 [logger ThreadHandler](INFO): Handler Thread ID is 1447
2024-05-20T21:27:54.956Z,1716240474.956 [CBIT](DEBUG): Initialized mux pins.
2024-05-20T21:27:54.956Z,1716240474.956 [CBIT](DEBUG): Initializing the watchdog timer.
2024-05-20T21:27:54.960Z,1716240474.960 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 1448
2024-05-20T21:27:54.968Z,1716240474.968 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 1449
2024-05-20T21:27:54.970Z,1716240474.970 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2024-05-20T21:27:54.976Z,1716240474.976 [Onboard ThreadHandler](INFO): Handler Thread ID is 1450
2024-05-20T21:27:54.980Z,1716240474.980 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2024-05-20T21:27:54.981Z,1716240474.981 [CBIT](DEBUG): Initializing heartbeat.
2024-05-20T21:27:54.997Z,1716240474.997 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 1451
2024-05-20T21:27:55.016Z,1716240475.016 [DAT ThreadHandler](INFO): Handler Thread ID is 1452
2024-05-20T21:27:55.017Z,1716240475.017 [DAT](INFO): Powering up
2024-05-20T21:27:55.017Z,1716240475.017 [DAT](DEBUG): Initializing DAT.
2024-05-20T21:27:55.025Z,1716240475.025 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 1453
2024-05-20T21:27:55.025Z,1716240475.025 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2024-05-20T21:27:55.029Z,1716240475.029 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 1455
2024-05-20T21:27:55.033Z,1716240475.033 [WetLabsBB2FL](INFO): Powering up
2024-05-20T21:27:55.034Z,1716240475.034 [WetLabsUBAT ThreadHandler](INFO): Handler Thread ID is 1457
2024-05-20T21:27:55.036Z,1716240475.036 [WetLabsUBAT](INFO): Powering up
2024-05-20T21:27:55.037Z,1716240475.037 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 1459
2024-05-20T21:27:55.041Z,1716240475.041 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2024-05-20T21:27:55.041Z,1716240475.041 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2024-05-20T21:27:55.041Z,1716240475.041 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2024-05-20T21:27:55.042Z,1716240475.042 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2024-05-20T21:27:55.042Z,1716240475.042 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2024-05-20T21:27:55.042Z,1716240475.042 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2024-05-20T21:27:55.042Z,1716240475.042 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2024-05-20T21:27:55.042Z,1716240475.042 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2024-05-20T21:27:55.052Z,1716240475.052 [CBIT](DEBUG): Deactivating GF circuits.
2024-05-20T21:27:55.052Z,1716240475.052 [CBIT](DEBUG): Deactivating emergency mode.
2024-05-20T21:27:55.092Z,1716240475.092 [CBIT](DEBUG): Backplane powered.
2024-05-20T21:27:55.096Z,1716240475.096 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser
2024-05-20T21:27:55.097Z,1716240475.097 [MissionManager](INFO): Loading Mission from file: Missions/underIce/StartupUnder.tl
2024-05-20T21:27:55.098Z,1716240475.098 [MissionManager](DEBUG): TethyslAPI: loading: Missions/underIce/StartupUnder.tl
2024-05-20T21:27:55.099Z,1716240475.099 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/underIce/StartupUnder.tl
2024-05-20T21:27:55.114Z,1716240475.114 [MissionManager](DEBUG): TethyslAPI: Missions/underIce/StartupUnder.tl translated into:
2024-05-20T21:27:55.114Z,1716240475.114 [MissionManager](ERROR): Top node has no child nodes: Mission
2024-05-20T21:27:55.114Z,1716240475.114 [MissionManager](ERROR): Could not load startup mission.
2024-05-20T21:27:55.114Z,1716240475.114 [MissionManager](INFO): Loading Mission from file: Missions/Engineering/DefaultTankUndock.tl
2024-05-20T21:27:55.115Z,1716240475.115 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Engineering/DefaultTankUndock.tl
2024-05-20T21:27:55.118Z,1716240475.118 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Engineering/DefaultTankUndock.tl
2024-05-20T21:27:55.400Z,1716240475.400 [Radio_Surface](INFO): Powering up
2024-05-20T21:27:55.420Z,1716240475.420 [MissionManager](DEBUG): TethyslAPI: Missions/Engineering/DefaultTankUndock.tl translated into:
0
13
dock arm
5
Default mission has been running for
Restarting logs and Default mission.
restart logs
2024-05-20T21:27:55.443Z,1716240475.443 [MissionManager](INFO): DefineArg DefaultTankUndock.ElapsedSinceDefaultStarted = 0.000000 min
2024-05-20T21:27:55.444Z,1716240475.444 [DefaultTankUndock:A.Wait](DEBUG): Construct Wait.
2024-05-20T21:27:55.468Z,1716240475.468 [DefaultTankUndock:B.GoToSurface](DEBUG): Construct GoToSurface.
2024-05-20T21:27:55.509Z,1716240475.509 [DefaultTankUndock:C.Execute](DEBUG): Construct Execute.
2024-05-20T21:27:55.514Z,1716240475.514 [DefaultTankUndock:CheckIn:C.Wait](DEBUG): Construct Wait.
2024-05-20T21:27:55.538Z,1716240475.538 [DefaultTankUndock:F.Execute](DEBUG): Construct Execute.
2024-05-20T21:27:55.541Z,1716240475.541 [MissionManager](DEBUG):
# Copyright (c) 2024 MBARI
# MBARI Proprietary Information. Confidential. All Rights Reserved
# Unauthorized copying or distribution of this file via any medium is strictly
# prohibited.
#
# WARNING - This file contains information whose export is restricted by the
# Export Administration Act of 1979 (Title 50, U.S.C., App. 2401 et seq.), as
# amended. Violations of these export laws are subject to severe civil and/or
# criminal penalties.
mission DefaultTankUndock {
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
}
behavior Guidance:Execute {
run in sequence
set command = "dock arm"
}
aggregate CheckIn {
run in sequence repeat=288
readDatum id="Read_GPS" {
timeout duration=P5M
Universal:time_fix
}
readDatum id="Read_Iridium" {
timeout duration=P4H
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-05-20T21:27:55.556Z,1716240475.556 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,NAL9602,Power24vConverter,RDI_Pathfinder,ESPComponent,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,DockingStepper,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter,
2024-05-20T21:27:55.580Z,1716240475.580 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2024-05-20T21:27:55.649Z,1716240475.649 [Depth_Keller](ERROR): Pressure or depth reading out of range: 1650.297119 decibar, 0.000000 m
2024-05-20T21:27:55.650Z,1716240475.650 [Power24vConverter](INFO): Powering up.
2024-05-20T21:27:55.651Z,1716240475.651 [RDI_Pathfinder](IMPORTANT): Expecting PD13 message format
2024-05-20T21:27:55.724Z,1716240475.724 [DepthRateCalculator](ERROR): Depth measurement is not active
2024-05-20T21:27:55.750Z,1716240475.750 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2024-05-20T21:27:55.750Z,1716240475.750 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2024-05-20T21:27:55.751Z,1716240475.751 [ElevatorServo](DEBUG): Initializing EZServoServo.
2024-05-20T21:27:55.756Z,1716240475.756 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2024-05-20T21:27:55.757Z,1716240475.757 [DockingStepper](INFO): Start
2024-05-20T21:27:55.757Z,1716240475.757 [DockingStepper](DEBUG): Initializing EZServoServo.
2024-05-20T21:27:55.758Z,1716240475.758 [DockingStepper](DEBUG): Initializing DockingStepper.
2024-05-20T21:27:55.758Z,1716240475.758 [MassServo](DEBUG): Initializing EZServoServo.
2024-05-20T21:27:55.764Z,1716240475.764 [MassServo](DEBUG): Initializing MassServo.
2024-05-20T21:27:55.765Z,1716240475.765 [RudderServo](DEBUG): Initializing EZServoServo.
2024-05-20T21:27:55.773Z,1716240475.773 [RudderServo](DEBUG): Initializing RudderServo.
2024-05-20T21:27:55.774Z,1716240475.774 [ThrusterServo](DEBUG): Initializing EZServoServo.
2024-05-20T21:27:55.780Z,1716240475.780 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2024-05-20T21:27:56.044Z,1716240476.044 [DockingStepper](INFO): Starting
2024-05-20T21:27:56.413Z,1716240476.413 [DockingStepper](INFO): Starting
2024-05-20T21:27:56.908Z,1716240476.908 [DockingStepper](INFO): Starting
2024-05-20T21:27:56.957Z,1716240476.957 [DockingStepper](INFO): Init string: /1z15088aE13561N3m50
2024-05-20T21:27:57.195Z,1716240477.195 [DockingStepper](INFO): Starting
2024-05-20T21:27:57.603Z,1716240477.603 [DockingStepper](INFO): Starting
2024-05-20T21:27:57.644Z,1716240477.644 [WetLabsBB2FL](INFO): Powering down
2024-05-20T21:27:58.030Z,1716240478.030 [DockingStepper](INFO): Starting
2024-05-20T21:27:58.460Z,1716240478.460 [DockingStepper](INFO): Starting
2024-05-20T21:27:58.485Z,1716240478.485 [DockingStepper](INFO): Sent speed cmd:/1V10000 Response:ÿ/0@
2024-05-20T21:27:58.922Z,1716240478.922 [DockingStepper](INFO): Starting
2024-05-20T21:27:59.703Z,1716240479.703 [DockingStepper](INFO): Pause
2024-05-20T21:28:04.288Z,1716240484.288 [WetLabsUBAT](INFO): Powering down
2024-05-20T21:28:07.636Z,1716240487.636 [DAT](INFO): DAT read:
2024-05-20T21:28:07.638Z,1716240487.638 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series
2024-05-20T21:28:09.401Z,1716240489.401 [DAT](INFO): DAT read: MF Frequency Band
2024-05-20T21:28:09.402Z,1716240489.402 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.17.2
2024-05-20T21:28:09.402Z,1716240489.402 [DAT](INFO): DAT read: May 20 2024 21:28:03
2024-05-20T21:28:10.409Z,1716240490.409 [DAT](INFO): DAT read: Features enabled [Bearing]
2024-05-20T21:28:10.410Z,1716240490.410 [DAT](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP
2024-05-20T21:28:10.411Z,1716240490.411 [DAT](INFO): commRate: 800
2024-05-20T21:28:12.476Z,1716240492.476 [DAT](INFO): entering command mode
2024-05-20T21:28:12.676Z,1716240492.676 [DAT](INFO): DAT read:
2024-05-20T21:28:12.677Z,1716240492.677 [DAT](INFO): DAT read: user:1>
2024-05-20T21:28:12.677Z,1716240492.677 [DAT](INFO): setting verbose to 3
2024-05-20T21:28:12.929Z,1716240492.929 [DAT](INFO): DAT read: user:1>
2024-05-20T21:28:12.930Z,1716240492.930 [DAT](INFO): DAT read: Verbose | 3
2024-05-20T21:28:12.930Z,1716240492.930 [DAT](INFO): set verbose to 3
2024-05-20T21:28:12.930Z,1716240492.930 [DAT](INFO): setting DatVerbose to 27440
2024-05-20T21:28:13.181Z,1716240493.181 [DAT](INFO): DAT read: user:2>
2024-05-20T21:28:13.182Z,1716240493.182 [DAT](INFO): DAT read: DatVerbose | 27440
2024-05-20T21:28:13.183Z,1716240493.183 [DAT](INFO): set DatVerbose to 27440
2024-05-20T21:28:13.183Z,1716240493.183 [DAT](INFO): setting transmit power to 8
2024-05-20T21:28:13.433Z,1716240493.433 [DAT](INFO): DAT read: user:3>
2024-05-20T21:28:13.434Z,1716240493.434 [DAT](INFO): DAT read: TxPower | 8 (Max)
2024-05-20T21:28:13.434Z,1716240493.434 [DAT](INFO): set transmit power to 8
2024-05-20T21:28:13.434Z,1716240493.434 [DAT](INFO): setting local address to 10
2024-05-20T21:28:13.685Z,1716240493.685 [DAT](INFO): DAT read: user:4>
2024-05-20T21:28:13.685Z,1716240493.685 [DAT](INFO): DAT read: LocalAddr | 10
2024-05-20T21:28:13.686Z,1716240493.686 [DAT](INFO): set local address to 10
2024-05-20T21:28:13.687Z,1716240493.687 [DAT](INFO): Setting time to: 21:28:13 And date to:5/20/2024
2024-05-20T21:28:13.937Z,1716240493.937 [DAT](INFO): DAT read: user:5>
2024-05-20T21:28:13.937Z,1716240493.937 [DAT](INFO): DAT read: Mon May 20, 2024 21:28:13
2024-05-20T21:28:13.938Z,1716240493.938 [DAT](INFO): Local DAT time set to Mon May 20, 2024 21:28:13
2024-05-20T21:28:23.861Z,1716240503.861 [NAL9602](INFO): Powering up NAL9602
2024-05-20T21:28:34.769Z,1716240514.769 [NAL9602](INFO): NAL9602 initialized
2024-05-20T21:29:03.046Z,1716240543.046 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2024-05-20T21:29:19.206Z,1716240559.206 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2024-05-20T21:29:29.734Z,1716240569.734 [SBIT](IMPORTANT): Beginning Startup BIT
2024-05-20T21:29:29.739Z,1716240569.739 [CBIT](IMPORTANT): Beginning ground fault scan
2024-05-20T21:29:34.962Z,1716240574.962 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2024-05-20T21:29:40.700Z,1716240580.700 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.004106
CHAN A1 (24V): 0.008149
CHAN A2 (12V): -0.008472
CHAN A3 (5V): -0.000648
CHAN B0 (3.3V): 0.000411
CHAN B1 (3.15aV): 0.000549
CHAN B2 (3.15bV): 0.000907
CHAN B3 (GND): 0.001418
OPEN: 0.005146
Full Scale: +/- 1 mA
2024-05-20T21:29:51.121Z,1716240591.121 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2024-05-20T21:30:06.479Z,1716240606.479 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2024-05-20T21:30:21.826Z,1716240621.826 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2024-05-20T21:30:23.498Z,1716240623.498 [SBIT](IMPORTANT): SBIT PASSED
2024-05-20T21:30:23.498Z,1716240623.498 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2024-05-20T21:30:23.499Z,1716240623.499 [SBIT](IMPORTANT): BPC1.batteryMissingStickThreshold=2 count;
2024-05-20T21:30:23.499Z,1716240623.499 [SBIT](IMPORTANT): DockingStepper.closedValue=16500 count;
2024-05-20T21:30:23.499Z,1716240623.499 [SBIT](IMPORTANT): DockingStepper.loadAtStartup=1 bool;
2024-05-20T21:30:23.499Z,1716240623.499 [SBIT](IMPORTANT): DockingStepper.openValue=7500 count;
2024-05-20T21:30:23.499Z,1716240623.499 [SBIT](IMPORTANT): DockingStepper.simulateHardware=0 bool;
2024-05-20T21:30:23.499Z,1716240623.499 [SBIT](IMPORTANT): DropWeight.loadAtStartup=0 bool;
2024-05-20T21:30:23.499Z,1716240623.499 [SBIT](IMPORTANT): ESPComponent.loadAtStartup=1 bool;
2024-05-20T21:30:23.499Z,1716240623.499 [SBIT](IMPORTANT): ESPComponent.sampleTimeout=2 minute;
2024-05-20T21:30:23.500Z,1716240623.500 [SBIT](IMPORTANT): ESPComponent.simulateHardware=1 bool;
2024-05-20T21:30:23.500Z,1716240623.500 [SBIT](IMPORTANT): Express linearApproximation WetLabsUBAT.flow_rate 0.300000 liter_per_second;
2024-05-20T21:30:23.500Z,1716240623.500 [SBIT](IMPORTANT): Express linearApproximation downwelling_photosynthetic_photon_flux_in_sea_water 100.000000 micromole_per_second_per_square_meter;
2024-05-20T21:30:23.500Z,1716240623.500 [SBIT](IMPORTANT): PowerOnly.loadAtStartup=0 bool;
2024-05-20T21:30:23.500Z,1716240623.500 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=486.306689 cubic_centimeter;
2024-05-20T21:30:23.500Z,1716240623.500 [SBIT](IMPORTANT): VerticalControl.kpDepth=0.09 radian_per_meter;
2024-05-20T21:30:23.501Z,1716240623.501 [SBIT](IMPORTANT): VerticalControl.kpPitchElevator=0.5 none;
2024-05-20T21:30:23.501Z,1716240623.501 [SBIT](IMPORTANT): VerticalControl.massDefault=18.506968 millimeter;
2024-05-20T21:30:23.501Z,1716240623.501 [SBIT](IMPORTANT): VerticalControl.stopDepthExcursion=20 meter;
2024-05-20T21:30:23.877Z,1716240623.877 [MissionManager](IMPORTANT): Started mission DefaultTankUndock
2024-05-20T21:30:23.878Z,1716240623.878 [DefaultTankUndock] Running Loop=1
2024-05-20T21:30:23.878Z,1716240623.878 [DefaultTankUndock](DEBUG): Aggregate::initialize DefaultTankUndock
2024-05-20T21:30:23.878Z,1716240623.878 [DefaultTankUndock:B.GoToSurface] Running Loop=1
2024-05-20T21:30:23.878Z,1716240623.878 [DefaultTankUndock:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2024-05-20T21:30:23.879Z,1716240623.879 [DefaultTankUndock:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2024-05-20T21:30:23.879Z,1716240623.879 [DefaultTankUndock:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2024-05-20T21:30:23.879Z,1716240623.879 [DefaultTankUndock:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2024-05-20T21:30:23.880Z,1716240623.880 [DefaultTankUndock:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2024-05-20T21:30:23.880Z,1716240623.880 [DefaultTankUndock:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2024-05-20T21:30:23.881Z,1716240623.881 [DefaultTankUndock:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2024-05-20T21:30:23.881Z,1716240623.881 [DefaultTankUndock:A.Wait] Running Loop=1
2024-05-20T21:30:23.881Z,1716240623.881 [DefaultTankUndock:A.Wait](DEBUG): Initialize Wait Component.
2024-05-20T21:30:37.201Z,1716240637.201 [DefaultTankUndock:A.Wait](INFO): Done Waiting.
2024-05-20T21:30:37.201Z,1716240637.201 [DefaultTankUndock:A.Wait] Stopped
2024-05-20T21:30:37.201Z,1716240637.201 [DefaultTankUndock:A.Wait](DEBUG): Uninitialize Wait Component.
2024-05-20T21:30:37.622Z,1716240637.622 [DefaultTankUndock:C.Execute] Running Loop=1
2024-05-20T21:30:38.034Z,1716240638.034 [DefaultTankUndock:C.Execute](INFO): Executing command dock arm
2024-05-20T21:30:38.035Z,1716240638.035 [DefaultTankUndock:C.Execute] Stopped
2024-05-20T21:30:38.035Z,1716240638.035 [DefaultTankUndock:CheckIn] Running Loop=1
2024-05-20T21:30:38.035Z,1716240638.035 [DefaultTankUndock:CheckIn](DEBUG): Aggregate::initialize DefaultTankUndock:CheckIn
2024-05-20T21:30:38.035Z,1716240638.035 [DefaultTankUndock:CheckIn:Read_GPS] Running Loop=1
2024-05-20T21:30:38.089Z,1716240638.089 [CommandExec](IMPORTANT): got command docking arm
2024-05-20T21:30:38.089Z,1716240638.089 [CommandExec](IMPORTANT): Switching docking moudle to ARM.
2024-05-20T21:30:38.436Z,1716240638.436 [DefaultTankUndock:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2024-05-20T21:30:38.826Z,1716240638.826 [DockingStepper](INFO): Resume
2024-05-20T21:30:39.219Z,1716240639.219 [DockingStepper](INFO): Resuming
2024-05-20T21:30:39.659Z,1716240639.659 [DockingStepper](INFO): Start
2024-05-20T21:30:39.659Z,1716240639.659 [DockingStepper](DEBUG): Initializing EZServoServo.
2024-05-20T21:30:39.659Z,1716240639.659 [DockingStepper](DEBUG): Initializing DockingStepper.
2024-05-20T21:30:40.028Z,1716240640.028 [DockingStepper](INFO): Starting
2024-05-20T21:30:40.460Z,1716240640.460 [DockingStepper](INFO): Starting
2024-05-20T21:30:40.835Z,1716240640.835 [DockingStepper](INFO): Starting
2024-05-20T21:30:40.912Z,1716240640.912 [DockingStepper](INFO): Init string: /1z15106aE13561N3m50
2024-05-20T21:30:41.242Z,1716240641.242 [DockingStepper](INFO): Starting
2024-05-20T21:30:41.666Z,1716240641.666 [DockingStepper](INFO): Starting
2024-05-20T21:30:42.106Z,1716240642.106 [DockingStepper](INFO): Starting
2024-05-20T21:30:42.520Z,1716240642.520 [DockingStepper](INFO): Starting
2024-05-20T21:30:42.548Z,1716240642.548 [DockingStepper](INFO): Sent speed cmd:/1V10000 Response:ÿ/0@
2024-05-20T21:30:42.895Z,1716240642.895 [DockingStepper](INFO): Starting
2024-05-20T21:30:43.370Z,1716240643.370 [DockingStepper](INFO): Changing to mode: 2
2024-05-20T21:30:43.370Z,1716240643.370 [DockingStepper](INFO): Armed mode.
2024-05-20T21:30:43.413Z,1716240643.413 [DockingStepper](INFO): Commanding negative:46816
2024-05-20T21:30:43.428Z,1716240643.428 [DockingStepper](FAULT): Invalid EZ Servo response:"\r\n"
2024-05-20T21:30:43.428Z,1716240643.428 [DockingStepper] Communications Fault, FailCount= 1
2024-05-20T21:30:43.428Z,1716240643.428 [DockingStepper](ERROR): Communications Fault
2024-05-20T21:30:43.448Z,1716240643.448 [DockingStepper](FAULT): Could not parse cable state. Received:ÿ/0@
2024-05-20T21:30:43.453Z,1716240643.453 [CBIT](ERROR): Communications Fault in component: DockingStepper
2024-05-20T21:30:43.705Z,1716240643.705 [DockingStepper](INFO): Stop
2024-05-20T21:30:43.705Z,1716240643.705 [DockingStepper](DEBUG): Uninitialize Docking Stepper.
2024-05-20T21:30:43.706Z,1716240643.706 [DockingStepper](INFO): Powering down
2024-05-20T21:30:44.079Z,1716240644.079 [DockingStepper](INFO): Stopping
2024-05-20T21:30:44.519Z,1716240644.519 [DockingStepper](INFO): Stopped
2024-05-20T21:30:44.527Z,1716240644.527 [CBIT](INFO): Clearing failed state for component DockingStepper
2024-05-20T21:30:44.527Z,1716240644.527 [DockingStepper] No Fault, FailCount= 1
2024-05-20T21:30:44.882Z,1716240644.882 [DockingStepper](INFO): Start
2024-05-20T21:30:44.882Z,1716240644.882 [DockingStepper](DEBUG): Initializing EZServoServo.
2024-05-20T21:30:44.882Z,1716240644.882 [DockingStepper](DEBUG): Initializing DockingStepper.
2024-05-20T21:30:45.279Z,1716240645.279 [DockingStepper](INFO): Starting
2024-05-20T21:30:45.718Z,1716240645.718 [DockingStepper](INFO): Starting
2024-05-20T21:30:46.146Z,1716240646.146 [DockingStepper](INFO): Starting
2024-05-20T21:30:46.189Z,1716240646.189 [DockingStepper](INFO): Init string: /1z14655aE13561N3m50
2024-05-20T21:30:46.519Z,1716240646.519 [DockingStepper](INFO): Starting
2024-05-20T21:30:46.923Z,1716240646.923 [DockingStepper](INFO): Starting
2024-05-20T21:30:47.332Z,1716240647.332 [DockingStepper](INFO): Starting
2024-05-20T21:30:47.757Z,1716240647.757 [DockingStepper](INFO): Starting
2024-05-20T21:30:47.760Z,1716240647.760 [DockingStepper](INFO): Sent speed cmd:/1V10000 Response:ÿ/0@
2024-05-20T21:30:48.119Z,1716240648.119 [DockingStepper](INFO): Starting
2024-05-20T21:30:48.542Z,1716240648.542 [DockingStepper](ERROR): only read 0 of 4 ADC values. Response is: ÿ/0@
2024-05-20T21:30:48.542Z,1716240648.542 [DockingStepper](FAULT): Docking arm not reporting position
2024-05-20T21:30:48.542Z,1716240648.542 [DockingStepper] Communications Fault, FailCount= 2
2024-05-20T21:30:48.542Z,1716240648.542 [DockingStepper](ERROR): Communications Fault
2024-05-20T21:30:48.547Z,1716240648.547 [CBIT](ERROR): Communications Fault in component: DockingStepper
2024-05-20T21:30:48.916Z,1716240648.916 [DockingStepper](INFO): Stop
2024-05-20T21:30:48.916Z,1716240648.916 [DockingStepper](DEBUG): Uninitialize Docking Stepper.
2024-05-20T21:30:48.916Z,1716240648.916 [DockingStepper](INFO): Powering down
2024-05-20T21:30:49.323Z,1716240649.323 [DockingStepper](INFO): Stopping
2024-05-20T21:30:49.748Z,1716240649.748 [DockingStepper](INFO): Stopped
2024-05-20T21:30:49.752Z,1716240649.752 [CBIT](INFO): Clearing failed state for component DockingStepper
2024-05-20T21:30:49.752Z,1716240649.752 [DockingStepper] No Fault, FailCount= 2
2024-05-20T21:30:50.176Z,1716240650.176 [DockingStepper](INFO): Start
2024-05-20T21:30:50.176Z,1716240650.176 [DockingStepper](DEBUG): Initializing EZServoServo.
2024-05-20T21:30:50.177Z,1716240650.177 [DockingStepper](DEBUG): Initializing DockingStepper.
2024-05-20T21:30:50.566Z,1716240650.566 [DockingStepper](INFO): Starting
2024-05-20T21:30:50.934Z,1716240650.934 [DockingStepper](INFO): Starting
2024-05-20T21:30:51.347Z,1716240651.347 [DockingStepper](INFO): Starting
2024-05-20T21:30:51.393Z,1716240651.393 [DockingStepper](INFO): Init string: /1z14655aE13561N3m50
2024-05-20T21:30:51.777Z,1716240651.777 [DockingStepper](INFO): Starting
2024-05-20T21:30:52.163Z,1716240652.163 [DockingStepper](INFO): Starting
2024-05-20T21:30:52.574Z,1716240652.574 [DockingStepper](INFO): Starting
2024-05-20T21:30:52.961Z,1716240652.961 [DockingStepper](INFO): Starting
2024-05-20T21:30:52.988Z,1716240652.988 [DockingStepper](INFO): Sent speed cmd:/1V10000 Response:ÿ/0@
2024-05-20T21:30:53.355Z,1716240653.355 [DockingStepper](INFO): Starting
2024-05-20T21:30:53.848Z,1716240653.848 [DockingStepper](INFO): Commanding negative:44157
2024-05-20T21:30:54.969Z,1716240654.969 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2024-05-20T21:30:54.969Z,1716240654.969 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-05-20T21:30:55.155Z,1716240655.155 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-05-20T21:30:55.608Z,1716240655.608 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-05-20T21:30:55.608Z,1716240655.608 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2024-05-20T21:30:58.655Z,1716240658.655 [DockingStepper](ERROR): only read 0 of 4 ADC values. Response is: ÿ/0@
2024-05-20T21:30:58.656Z,1716240658.656 [DockingStepper](FAULT): Docking arm not reporting position
2024-05-20T21:30:58.657Z,1716240658.657 [DockingStepper] Communications Fault, FailCount= 3
2024-05-20T21:30:58.657Z,1716240658.657 [DockingStepper](ERROR): Communications Fault
2024-05-20T21:30:58.661Z,1716240658.661 [CBIT](ERROR): Communications Fault in component: DockingStepper
2024-05-20T21:30:59.011Z,1716240659.011 [DockingStepper](INFO): Stop
2024-05-20T21:30:59.012Z,1716240659.012 [DockingStepper](DEBUG): Uninitialize Docking Stepper.
2024-05-20T21:30:59.012Z,1716240659.012 [DockingStepper](INFO): Powering down
2024-05-20T21:30:59.425Z,1716240659.425 [DockingStepper](INFO): Stopping
2024-05-20T21:30:59.847Z,1716240659.847 [DockingStepper](INFO): Stopped
2024-05-20T21:30:59.852Z,1716240659.852 [CBIT](INFO): Clearing failed state for component DockingStepper
2024-05-20T21:30:59.852Z,1716240659.852 [DockingStepper] No Fault, FailCount= 3
2024-05-20T21:31:00.258Z,1716240660.258 [DockingStepper](INFO): Start
2024-05-20T21:31:00.258Z,1716240660.258 [DockingStepper](DEBUG): Initializing EZServoServo.
2024-05-20T21:31:00.258Z,1716240660.258 [DockingStepper](DEBUG): Initializing DockingStepper.
2024-05-20T21:31:00.689Z,1716240660.689 [DockingStepper](INFO): Starting
2024-05-20T21:31:01.056Z,1716240661.056 [DockingStepper](INFO): Starting
2024-05-20T21:31:01.463Z,1716240661.463 [DockingStepper](INFO): Starting
2024-05-20T21:31:01.514Z,1716240661.514 [DockingStepper](INFO): Init string: /1z7567aE13561N3m50
2024-05-20T21:31:01.879Z,1716240661.879 [DockingStepper](INFO): Starting
2024-05-20T21:31:02.243Z,1716240662.243 [DockingStepper](INFO): Starting
2024-05-20T21:31:02.713Z,1716240662.713 [DockingStepper](INFO): Starting
2024-05-20T21:31:03.054Z,1716240663.054 [DockingStepper](INFO): Starting
2024-05-20T21:31:03.076Z,1716240663.076 [DockingStepper](INFO): Sent speed cmd:/1V10000 Response:ÿ/0@
2024-05-20T21:31:03.459Z,1716240663.459 [DockingStepper](INFO): Starting
2024-05-20T21:31:03.886Z,1716240663.886 [DockingStepper](ERROR): only read 0 of 4 ADC values. Response is: ÿ/0@
2024-05-20T21:31:03.886Z,1716240663.886 [DockingStepper](FAULT): Docking arm not reporting position
2024-05-20T21:31:03.886Z,1716240663.886 [DockingStepper] Communications Fault, FailCount= 4
2024-05-20T21:31:03.886Z,1716240663.886 [DockingStepper](ERROR): Communications Fault
2024-05-20T21:31:03.891Z,1716240663.891 [CBIT](ERROR): Communications Fault in component: DockingStepper
2024-05-20T21:31:04.277Z,1716240664.277 [DockingStepper](INFO): Stop
2024-05-20T21:31:04.277Z,1716240664.277 [DockingStepper](DEBUG): Uninitialize Docking Stepper.
2024-05-20T21:31:04.277Z,1716240664.277 [DockingStepper](INFO): Powering down
2024-05-20T21:31:04.742Z,1716240664.742 [DockingStepper](INFO): Stopping
2024-05-20T21:31:05.075Z,1716240665.075 [DockingStepper](INFO): Stopped
2024-05-20T21:31:05.079Z,1716240665.079 [CBIT](INFO): Clearing failed state for component DockingStepper
2024-05-20T21:31:05.079Z,1716240665.079 [DockingStepper] No Fault, FailCount= 4
2024-05-20T21:31:05.504Z,1716240665.504 [DockingStepper](INFO): Start
2024-05-20T21:31:05.504Z,1716240665.504 [DockingStepper](DEBUG): Initializing EZServoServo.
2024-05-20T21:31:05.505Z,1716240665.505 [DockingStepper](DEBUG): Initializing DockingStepper.
2024-05-20T21:31:05.911Z,1716240665.911 [DockingStepper](INFO): Starting
2024-05-20T21:31:06.312Z,1716240666.312 [DockingStepper](INFO): Starting
2024-05-20T21:31:06.745Z,1716240666.745 [DockingStepper](INFO): Starting
2024-05-20T21:31:06.800Z,1716240666.800 [DockingStepper](INFO): Init string: /1z7567aE13561N3m50
2024-05-20T21:31:07.114Z,1716240667.114 [DockingStepper](INFO): Starting
2024-05-20T21:31:07.505Z,1716240667.505 [DockingStepper](INFO): Starting
2024-05-20T21:31:07.927Z,1716240667.927 [DockingStepper](INFO): Starting
2024-05-20T21:31:08.307Z,1716240668.307 [DockingStepper](INFO): Starting
2024-05-20T21:31:08.336Z,1716240668.336 [DockingStepper](INFO): Sent speed cmd:/1V10000 Response:ÿ/0@
2024-05-20T21:31:08.764Z,1716240668.764 [DockingStepper](INFO): Starting
2024-05-20T21:31:42.875Z,1716240702.875 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.005378
2024-05-20T21:32:23.950Z,1716240743.950 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-05-20T21:32:36.878Z,1716240756.878 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-05-20T21:32:49.478Z,1716240769.478 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-05-20T21:33:02.423Z,1716240782.423 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-05-20T21:33:15.335Z,1716240795.335 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-05-20T21:33:28.262Z,1716240808.262 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-05-20T21:33:38.369Z,1716240818.369 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2024-05-20T21:33:39.583Z,1716240819.583 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,213343.00,A,3648.16861,N,12147.28961,W,0.156,134.24,200524,,,D*7A
2024-05-20T21:33:39.586Z,1716240819.586 [NAL9602](INFO): GPS fix at 20240520T213343: (36.802810, -121.788160)
2024-05-20T21:33:39.614Z,1716240819.614 [DefaultTankUndock:CheckIn:Read_GPS] Stopped
2024-05-20T21:33:39.614Z,1716240819.614 [DefaultTankUndock:CheckIn:Read_Iridium] Running Loop=1
2024-05-20T21:33:40.057Z,1716240820.057 [DefaultTankUndock:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2024-05-20T21:33:41.311Z,1716240821.311 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-05-20T21:33:51.744Z,1716240831.744 [DataOverHttps](INFO): Sending 168 bytes from file Logs/20240520T204906/Courier0006.lzma
2024-05-20T21:33:52.746Z,1716240832.746 [DataOverHttps](INFO): Moved sent file to Logs/20240520T204906/Courier0006.lzma.bak
2024-05-20T21:33:52.747Z,1716240832.747 [DataOverHttps](INFO): SBD MOMSN=21045802
2024-05-20T21:33:54.240Z,1716240834.240 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-05-20T21:34:04.696Z,1716240844.696 [DockingStepper](ERROR): only read 0 of 4 ADC values. Response is: ÿ/0@
2024-05-20T21:34:04.696Z,1716240844.696 [DockingStepper](FAULT): Docking arm not reporting position
2024-05-20T21:34:04.697Z,1716240844.697 [DockingStepper] Communications Fault, FailCount= 1
2024-05-20T21:34:04.697Z,1716240844.697 [DockingStepper](ERROR): Communications Fault
2024-05-20T21:34:04.721Z,1716240844.721 [CBIT](ERROR): Communications Fault in component: DockingStepper
2024-05-20T21:34:05.022Z,1716240845.022 [DockingStepper](INFO): Stop
2024-05-20T21:34:05.022Z,1716240845.022 [DockingStepper](DEBUG): Uninitialize Docking Stepper.
2024-05-20T21:34:05.022Z,1716240845.022 [DockingStepper](INFO): Powering down
2024-05-20T21:34:05.483Z,1716240845.483 [DockingStepper](INFO): Stopping
2024-05-20T21:34:05.783Z,1716240845.783 [DockingStepper](INFO): Stopped
2024-05-20T21:34:05.795Z,1716240845.795 [CBIT](INFO): Clearing failed state for component DockingStepper
2024-05-20T21:34:05.795Z,1716240845.795 [DockingStepper] No Fault, FailCount= 1
2024-05-20T21:34:06.225Z,1716240846.225 [DockingStepper](INFO): Start
2024-05-20T21:34:06.226Z,1716240846.226 [DockingStepper](DEBUG): Initializing EZServoServo.
2024-05-20T21:34:06.226Z,1716240846.226 [DockingStepper](DEBUG): Initializing DockingStepper.
2024-05-20T21:34:06.799Z,1716240846.799 [DockingStepper](INFO): Starting
2024-05-20T21:34:07.172Z,1716240847.172 [DockingStepper](INFO): Starting
2024-05-20T21:34:07.378Z,1716240847.378 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-05-20T21:34:07.586Z,1716240847.586 [DockingStepper](INFO): Starting
2024-05-20T21:34:07.636Z,1716240847.636 [DockingStepper](INFO): Init string: /1z7570aE13561N3m50
2024-05-20T21:34:07.886Z,1716240847.886 [DockingStepper](INFO): Starting
2024-05-20T21:34:08.281Z,1716240848.281 [DockingStepper](INFO): Starting
2024-05-20T21:34:08.715Z,1716240848.715 [DockingStepper](INFO): Starting
2024-05-20T21:34:09.034Z,1716240849.034 [DockingStepper](INFO): Starting
2024-05-20T21:34:09.065Z,1716240849.065 [DockingStepper](INFO): Sent speed cmd:/1V10000 Response:ÿ/0@
2024-05-20T21:34:09.520Z,1716240849.520 [DockingStepper](INFO): Starting
2024-05-20T21:34:11.418Z,1716240851.418 [NAL9602](INFO): Not Powering down - fast GPS
2024-05-20T21:34:20.173Z,1716240860.173 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-05-20T21:34:23.356Z,1716240863.356 [DataOverHttps](INFO): Sending 269 bytes from file Logs/20240520T212742/Courier0000.lzma
2024-05-20T21:34:24.358Z,1716240864.358 [DataOverHttps](INFO): Moved sent file to Logs/20240520T212742/Courier0000.lzma.bak
2024-05-20T21:34:24.358Z,1716240864.358 [DataOverHttps](INFO): SBD MOMSN=21045818
2024-05-20T21:34:33.473Z,1716240873.473 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-05-20T21:34:44.973Z,1716240884.973 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20240520T204906/Express0004.lzma
2024-05-20T21:34:45.974Z,1716240885.974 [DataOverHttps](INFO): Moved sent file to Logs/20240520T204906/Express0004.lzma.bak
2024-05-20T21:34:45.974Z,1716240885.974 [DataOverHttps](INFO): SBD MOMSN=21045825
2024-05-20T21:35:07.561Z,1716240907.561 [DataOverHttps](INFO): Sending 905 bytes from file Logs/20240520T204906/Express0007.lzma
2024-05-20T21:35:08.562Z,1716240908.562 [DataOverHttps](INFO): Moved sent file to Logs/20240520T204906/Express0007.lzma.bak
2024-05-20T21:35:08.563Z,1716240908.563 [DataOverHttps](INFO): SBD MOMSN=21045827
2024-05-20T21:35:30.662Z,1716240930.662 [DataOverHttps](INFO): Sending 1463 bytes from file Logs/20240520T212742/Express0001.lzma
2024-05-20T21:35:31.662Z,1716240931.662 [DataOverHttps](INFO): Moved sent file to Logs/20240520T212742/Express0001.lzma.bak
2024-05-20T21:35:31.662Z,1716240931.662 [DataOverHttps](INFO): SBD MOMSN=21045921
2024-05-20T21:35:35.581Z,1716240935.581 [DefaultTankUndock:CheckIn:Read_Iridium] Stopped
2024-05-20T21:35:35.581Z,1716240935.581 [DefaultTankUndock:CheckIn:C.Wait] Running Loop=1
2024-05-20T21:35:35.582Z,1716240935.582 [DefaultTankUndock:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-05-20T21:35:54.555Z,1716240954.555 [DockingStepper](ERROR): only read 0 of 4 ADC values. Response is: ÿ/0@
2024-05-20T21:35:54.555Z,1716240954.555 [DockingStepper](FAULT): Docking arm not reporting position
2024-05-20T21:35:54.556Z,1716240954.556 [DockingStepper] Communications Fault, FailCount= 1
2024-05-20T21:35:54.556Z,1716240954.556 [DockingStepper](ERROR): Communications Fault
2024-05-20T21:35:54.560Z,1716240954.560 [CBIT](ERROR): Communications Fault in component: DockingStepper
2024-05-20T21:35:54.995Z,1716240954.995 [DockingStepper](INFO): Stop
2024-05-20T21:35:54.996Z,1716240954.996 [DockingStepper](DEBUG): Uninitialize Docking Stepper.
2024-05-20T21:35:54.996Z,1716240954.996 [DockingStepper](INFO): Powering down
2024-05-20T21:35:55.413Z,1716240955.413 [DockingStepper](INFO): Stopping
2024-05-20T21:35:55.759Z,1716240955.759 [DockingStepper](INFO): Stopped
2024-05-20T21:35:55.764Z,1716240955.764 [CBIT](INFO): Clearing failed state for component DockingStepper
2024-05-20T21:35:55.764Z,1716240955.764 [DockingStepper] No Fault, FailCount= 1
2024-05-20T21:35:56.189Z,1716240956.189 [DockingStepper](INFO): Start
2024-05-20T21:35:56.189Z,1716240956.189 [DockingStepper](DEBUG): Initializing EZServoServo.
2024-05-20T21:35:56.190Z,1716240956.190 [DockingStepper](DEBUG): Initializing DockingStepper.
2024-05-20T21:35:56.584Z,1716240956.584 [DockingStepper](INFO): Starting
2024-05-20T21:35:57.028Z,1716240957.028 [DockingStepper](INFO): Starting
2024-05-20T21:35:57.396Z,1716240957.396 [DockingStepper](INFO): Starting
2024-05-20T21:35:57.456Z,1716240957.456 [DockingStepper](INFO): Init string: /1z7552aE13561N3m50
2024-05-20T21:35:57.789Z,1716240957.789 [DockingStepper](INFO): Starting
2024-05-20T21:35:58.209Z,1716240958.209 [DockingStepper](INFO): Starting
2024-05-20T21:35:58.589Z,1716240958.589 [DockingStepper](INFO): Starting
2024-05-20T21:35:59.113Z,1716240959.113 [DockingStepper](INFO): Starting
2024-05-20T21:35:59.144Z,1716240959.144 [DockingStepper](INFO): Sent speed cmd:/1V10000 Response:ÿ/0@
2024-05-20T21:35:59.426Z,1716240959.426 [DockingStepper](INFO): Starting
2024-05-20T21:37:20.776Z,1716241040.776 [DockingStepper](ERROR): only read 0 of 4 ADC values. Response is: ÿ/0@
2024-05-20T21:37:20.777Z,1716241040.777 [DockingStepper](FAULT): Docking arm not reporting position
2024-05-20T21:37:20.777Z,1716241040.777 [DockingStepper] Communications Fault, FailCount= 1
2024-05-20T21:37:20.777Z,1716241040.777 [DockingStepper](ERROR): Communications Fault
2024-05-20T21:37:20.781Z,1716241040.781 [CBIT](ERROR): Communications Fault in component: DockingStepper
2024-05-20T21:37:21.181Z,1716241041.181 [DockingStepper](INFO): Stop
2024-05-20T21:37:21.181Z,1716241041.181 [DockingStepper](DEBUG): Uninitialize Docking Stepper.
2024-05-20T21:37:21.182Z,1716241041.182 [DockingStepper](INFO): Powering down
2024-05-20T21:37:21.601Z,1716241041.601 [DockingStepper](INFO): Stopping
2024-05-20T21:37:21.978Z,1716241041.978 [DockingStepper](INFO): Stopped
2024-05-20T21:37:21.982Z,1716241041.982 [CBIT](INFO): Clearing failed state for component DockingStepper
2024-05-20T21:37:21.982Z,1716241041.982 [DockingStepper] No Fault, FailCount= 1
2024-05-20T21:37:22.411Z,1716241042.411 [DockingStepper](INFO): Start
2024-05-20T21:37:22.411Z,1716241042.411 [DockingStepper](DEBUG): Initializing EZServoServo.
2024-05-20T21:37:22.412Z,1716241042.412 [DockingStepper](DEBUG): Initializing DockingStepper.
2024-05-20T21:37:22.801Z,1716241042.801 [DockingStepper](INFO): Starting
2024-05-20T21:37:23.193Z,1716241043.193 [DockingStepper](INFO): Starting
2024-05-20T21:37:23.630Z,1716241043.630 [DockingStepper](INFO): Starting
2024-05-20T21:37:23.680Z,1716241043.680 [DockingStepper](INFO): Init string: /1z7552aE13561N3m50
2024-05-20T21:37:23.000Z,1716241044.000 [DockingStepper](INFO): Starting
2024-05-20T21:37:24.433Z,1716241044.433 [DockingStepper](INFO): Starting
2024-05-20T21:37:24.830Z,1716241044.830 [DockingStepper](INFO): Starting
2024-05-20T21:37:25.213Z,1716241045.213 [DockingStepper](INFO): Starting
2024-05-20T21:37:25.237Z,1716241045.237 [DockingStepper](INFO): Sent speed cmd:/1V10000 Response:ÿ/0@
2024-05-20T21:37:25.698Z,1716241045.698 [DockingStepper](INFO): Starting
2024-05-20T21:37:43.779Z,1716241063.779 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2024-05-20T21:37:56.730Z,1716241076.730 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2024-05-20T21:38:09.637Z,1716241089.637 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2024-05-20T21:38:22.827Z,1716241102.827 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2024-05-20T21:38:36.165Z,1716241116.165 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2024-05-20T21:38:49.088Z,1716241129.088 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2024-05-20T21:39:02.020Z,1716241142.020 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2024-05-20T21:39:14.960Z,1716241154.960 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2024-05-20T21:39:27.879Z,1716241167.879 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2024-05-20T21:39:40.799Z,1716241180.799 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2024-05-20T21:39:53.728Z,1716241193.728 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2024-05-20T21:40:36.267Z,1716241236.267 [DefaultTankUndock:CheckIn:C.Wait](INFO): Done Waiting.
2024-05-20T21:40:36.267Z,1716241236.267 [DefaultTankUndock:CheckIn:C.Wait] Stopped
2024-05-20T21:40:36.267Z,1716241236.267 [DefaultTankUndock:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-05-20T21:40:36.267Z,1716241236.267 [DefaultTankUndock:CheckIn:D] Running Loop=1
2024-05-20T21:40:36.629Z,1716241236.629 [DefaultTankUndock:CheckIn:D] Stopped
2024-05-20T21:40:36.629Z,1716241236.629 [DefaultTankUndock:CheckIn:E] Running Loop=1
2024-05-20T21:40:37.042Z,1716241237.042 [DefaultTankUndock:CheckIn:E](IMPORTANT): Default mission has been running for 10.212527 min
2024-05-20T21:40:37.042Z,1716241237.042 [DefaultTankUndock:CheckIn:E] Stopped
2024-05-20T21:40:37.042Z,1716241237.042 [DefaultTankUndock:CheckIn](INFO): Completed DefaultTankUndock:CheckIn
2024-05-20T21:40:37.043Z,1716241237.043 [DefaultTankUndock:CheckIn] Stopped
2024-05-20T21:40:37.043Z,1716241237.043 [DefaultTankUndock:CheckIn](DEBUG): Aggregate::uninitialize DefaultTankUndock:CheckIn
2024-05-20T21:40:37.043Z,1716241237.043 [DefaultTankUndock:CheckIn](INFO): Running loop #2
2024-05-20T21:40:37.043Z,1716241237.043 [DefaultTankUndock:CheckIn] Running Loop=2
2024-05-20T21:40:37.043Z,1716241237.043 [DefaultTankUndock:CheckIn](DEBUG): Aggregate::initialize DefaultTankUndock:CheckIn
2024-05-20T21:40:37.043Z,1716241237.043 [DefaultTankUndock:CheckIn:Read_GPS] Running Loop=1
2024-05-20T21:40:39.035Z,1716241239.035 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,214043.00,A,3648.16349,N,12147.28623,W,0.214,130.48,200524,,,D*7D
2024-05-20T21:40:39.038Z,1716241239.038 [NAL9602](INFO): GPS fix at 20240520T214043: (36.802725, -121.788104)
2024-05-20T21:40:39.049Z,1716241239.049 [DefaultTankUndock:CheckIn:Read_GPS] Stopped
2024-05-20T21:40:39.049Z,1716241239.049 [DefaultTankUndock:CheckIn:Read_Iridium] Running Loop=1
2024-05-20T21:40:48.955Z,1716241248.955 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20240520T212742/Courier0004.lzma
2024-05-20T21:40:49.960Z,1716241249.960 [DataOverHttps](INFO): Moved sent file to Logs/20240520T212742/Courier0004.lzma.bak
2024-05-20T21:40:49.961Z,1716241249.961 [DataOverHttps](INFO): SBD MOMSN=21045965
2024-05-20T21:41:02.797Z,1716241262.797 [DockingStepper](ERROR): only read 0 of 4 ADC values. Response is: ÿ/0@
2024-05-20T21:41:02.798Z,1716241262.798 [DockingStepper](FAULT): Docking arm not reporting position
2024-05-20T21:41:02.798Z,1716241262.798 [DockingStepper] Communications Fault, FailCount= 1
2024-05-20T21:41:02.798Z,1716241262.798 [DockingStepper](ERROR): Communications Fault
2024-05-20T21:41:02.803Z,1716241262.803 [CBIT](ERROR): Communications Fault in component: DockingStepper
2024-05-20T21:41:03.177Z,1716241263.177 [DockingStepper](INFO): Stop
2024-05-20T21:41:03.177Z,1716241263.177 [DockingStepper](DEBUG): Uninitialize Docking Stepper.
2024-05-20T21:41:03.177Z,1716241263.177 [DockingStepper](INFO): Powering down
2024-05-20T21:41:03.601Z,1716241263.601 [DockingStepper](INFO): Stopping
2024-05-20T21:41:03.993Z,1716241263.993 [DockingStepper](INFO): Stopped
2024-05-20T21:41:04.002Z,1716241264.002 [CBIT](INFO): Clearing failed state for component DockingStepper
2024-05-20T21:41:04.002Z,1716241264.002 [DockingStepper] No Fault, FailCount= 1
2024-05-20T21:41:04.413Z,1716241264.413 [DockingStepper](INFO): Start
2024-05-20T21:41:04.413Z,1716241264.413 [DockingStepper](DEBUG): Initializing EZServoServo.
2024-05-20T21:41:04.413Z,1716241264.413 [DockingStepper](DEBUG): Initializing DockingStepper.
2024-05-20T21:41:04.843Z,1716241264.843 [DockingStepper](INFO): Starting
2024-05-20T21:41:05.204Z,1716241265.204 [DockingStepper](INFO): Starting
2024-05-20T21:41:05.633Z,1716241265.633 [DockingStepper](INFO): Starting
2024-05-20T21:41:05.688Z,1716241265.688 [DockingStepper](INFO): Init string: /1z7551aE13561N3m50
2024-05-20T21:41:06.001Z,1716241266.001 [DockingStepper](INFO): Starting
2024-05-20T21:41:06.413Z,1716241266.413 [DockingStepper](INFO): Starting
2024-05-20T21:41:06.838Z,1716241266.838 [DockingStepper](INFO): Starting
2024-05-20T21:41:07.226Z,1716241267.226 [DockingStepper](INFO): Starting
2024-05-20T21:41:07.261Z,1716241267.261 [DockingStepper](INFO): Sent speed cmd:/1V10000 Response:ÿ/0@
2024-05-20T21:41:07.719Z,1716241267.719 [DockingStepper](INFO): Starting
2024-05-20T21:41:12.139Z,1716241272.139 [DataOverHttps](INFO): Sending 229 bytes from file Logs/20240520T212742/Express0005.lzma
2024-05-20T21:41:13.138Z,1716241273.138 [DataOverHttps](INFO): Moved sent file to Logs/20240520T212742/Express0005.lzma.bak
2024-05-20T21:41:13.138Z,1716241273.138 [DataOverHttps](INFO): SBD MOMSN=21045968
2024-05-20T21:41:17.819Z,1716241277.819 [DefaultTankUndock:CheckIn:Read_Iridium] Stopped
2024-05-20T21:41:17.819Z,1716241277.819 [DefaultTankUndock:CheckIn:C.Wait] Running Loop=1
2024-05-20T21:41:17.819Z,1716241277.819 [DefaultTankUndock:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-05-20T21:41:54.552Z,1716241314.552 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-05-20T21:42:01.004Z,1716241321.004 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-05-20T21:42:14.340Z,1716241334.340 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-05-20T21:42:26.859Z,1716241346.859 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-05-20T21:42:39.384Z,1716241359.384 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-05-20T21:42:48.009Z,1716241368.009 [DataOverHttps](IMPORTANT): SBD MTMSN=20240520T214252
2024-05-20T21:42:52.717Z,1716241372.717 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-05-20T21:42:56.508Z,1716241376.508 [DataOverHttps](INFO): Received command: restart sys
2024-05-20T21:42:56.518Z,1716241376.518 [CommandExec](IMPORTANT): got command restart system
2024-05-20T21:42:58.656Z,1716241378.656 [Supervisor](INFO): Stop Mission called by Supervisor::terminate
2024-05-20T21:42:58.656Z,1716241378.656 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread.
2024-05-20T21:42:58.656Z,1716241378.656 [CommandExec](INFO): Uninitializing the command executive.
2024-05-20T21:42:58.657Z,1716241378.657 [CommandExec](INFO): Uninitializing the command scheduler.
2024-05-20T21:42:58.657Z,1716241378.657 [CommandExec ThreadHandler](INFO): Thread cancelled.
2024-05-20T21:42:58.660Z,1716241378.660 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye!
2024-05-20T21:42:58.660Z,1716241378.660 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2024-05-20T21:42:58.660Z,1716241378.660 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2024-05-20T21:42:58.661Z,1716241378.661 [NavChartDb](INFO): Join timeout helper Thread ID is 1509
2024-05-20T21:42:58.664Z,1716241378.664 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2024-05-20T21:42:58.664Z,1716241378.664 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2024-05-20T21:42:58.680Z,1716241378.680 [ComponentRegistry](INFO): Shutting down WetLabsUBAT ThreadHandler
2024-05-20T21:42:58.680Z,1716241378.680 [WetLabsUBAT ThreadHandler](INFO): Thread cancelled.
2024-05-20T21:42:58.680Z,1716241378.680 [WetLabsUBAT](INFO): Join timeout helper Thread ID is 1510
2024-05-20T21:42:58.716Z,1716241378.716 [WetLabsUBAT ThreadHandler](INFO): Uninitializing protected caller thread.
2024-05-20T21:42:58.716Z,1716241378.716 [WetLabsUBAT](INFO): Powering down
2024-05-20T21:42:58.717Z,1716241378.717 [WetLabsUBAT ThreadHandler](INFO): Thread cancelled.
2024-05-20T21:42:58.728Z,1716241378.728 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2024-05-20T21:42:58.728Z,1716241378.728 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2024-05-20T21:42:58.728Z,1716241378.728 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 1511
2024-05-20T21:42:58.757Z,1716241378.757 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2024-05-20T21:42:58.757Z,1716241378.757 [WetLabsBB2FL](INFO): Powering down
2024-05-20T21:42:58.758Z,1716241378.758 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2024-05-20T21:42:58.772Z,1716241378.772 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2024-05-20T21:42:58.772Z,1716241378.772 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2024-05-20T21:42:58.772Z,1716241378.772 [CTD_Seabird](INFO): Join timeout helper Thread ID is 1512
2024-05-20T21:42:58.872Z,1716241378.872 [CTD_Seabird](INFO): Powering down
2024-05-20T21:42:58.884Z,1716241378.884 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2024-05-20T21:42:58.885Z,1716241378.885 [CTD_Seabird](INFO): Powering down
2024-05-20T21:42:58.896Z,1716241378.896 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2024-05-20T21:42:58.912Z,1716241378.912 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler
2024-05-20T21:42:58.912Z,1716241378.912 [DAT ThreadHandler](INFO): Thread cancelled.
2024-05-20T21:42:58.913Z,1716241378.913 [DAT](INFO): Join timeout helper Thread ID is 1513
2024-05-20T21:42:59.008Z,1716241379.008 [DAT](INFO): Powering down
2024-05-20T21:42:59.009Z,1716241379.009 [DAT ThreadHandler](INFO): Uninitializing protected caller thread.
2024-05-20T21:42:59.009Z,1716241379.009 [DAT](INFO): Powering down
2024-05-20T21:42:59.010Z,1716241379.010 [DAT ThreadHandler](INFO): Thread cancelled.
2024-05-20T21:42:59.013Z,1716241379.013 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2024-05-20T21:42:59.013Z,1716241379.013 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2024-05-20T21:42:59.013Z,1716241379.013 [Radio_Surface](INFO): Join timeout helper Thread ID is 1514
2024-05-20T21:42:59.300Z,1716241379.300 [Radio_Surface](INFO): Powering down
2024-05-20T21:42:59.301Z,1716241379.301 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2024-05-20T21:42:59.301Z,1716241379.301 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2024-05-20T21:42:59.312Z,1716241379.312 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2024-05-20T21:42:59.313Z,1716241379.313 [Onboard ThreadHandler](INFO): Thread cancelled.
2024-05-20T21:42:59.313Z,1716241379.313 [Onboard](INFO): Join timeout helper Thread ID is 1515
2024-05-20T21:42:59.516Z,1716241379.516 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2024-05-20T21:43:00.764Z,1716241380.764 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2024-05-20T21:43:00.764Z,1716241380.764 [Onboard ThreadHandler](INFO): Thread cancelled.
2024-05-20T21:43:00.773Z,1716241380.773 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2024-05-20T21:43:00.773Z,1716241380.773 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2024-05-20T21:43:00.773Z,1716241380.773 [DataOverHttps](INFO): Join timeout helper Thread ID is 1516
2024-05-20T21:43:01.524Z,1716241381.524 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2024-05-20T21:43:01.524Z,1716241381.524 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2024-05-20T21:43:01.540Z,1716241381.540 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler
2024-05-20T21:43:01.541Z,1716241381.541 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2024-05-20T21:43:01.541Z,1716241381.541 [BackseatComponent](INFO): Join timeout helper Thread ID is 1517
2024-05-20T21:43:01.612Z,1716241381.612 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread.
2024-05-20T21:43:01.613Z,1716241381.613 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2024-05-20T21:43:01.614Z,1716241381.614 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2024-05-20T21:43:01.614Z,1716241381.614 [logger ThreadHandler](INFO): Thread cancelled.
2024-05-20T21:43:01.614Z,1716241381.614 [logger](INFO): Join timeout helper Thread ID is 1518
2024-05-20T21:43:01.616Z,1716241381.616 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2024-05-20T21:43:01.616Z,1716241381.616 [logger ThreadHandler](INFO): Thread cancelled.
2024-05-20T21:43:01.625Z,1716241381.625 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2024-05-20T21:43:01.625Z,1716241381.625 [CommandLine ThreadHandler](INFO): Thread cancelled.
2024-05-20T21:43:01.625Z,1716241381.625 [CommandLine](INFO): Join timeout helper Thread ID is 1519
2024-05-20T21:43:01.713Z,1716241381.713 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2024-05-20T21:43:01.713Z,1716241381.713 [CommandLine ThreadHandler](INFO): Thread cancelled.
2024-05-20T21:43:01.733Z,1716241381.733 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler
2024-05-20T21:43:01.733Z,1716241381.733 [CommandExec ThreadHandler](INFO): Thread cancelled.
2024-05-20T21:43:01.733Z,1716241381.733 [CommandExec](INFO): Join timeout helper Thread ID is 1520
2024-05-20T21:43:01.735Z,1716241381.735 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2024-05-20T21:43:01.735Z,1716241381.735 [controlThread ThreadHandler](INFO): Thread cancelled.
2024-05-20T21:43:01.736Z,1716241381.736 [controlThread](INFO): Join timeout helper Thread ID is 1521
2024-05-20T21:43:01.794Z,1716241381.794 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2024-05-20T21:43:01.794Z,1716241381.794 [controlThread](DEBUG): Uninitializing ControlThread
2024-05-20T21:43:01.794Z,1716241381.794 [AHRS_M2](INFO): Powering down
2024-05-20T21:43:01.796Z,1716241381.796 [NAL9602](INFO): Powering down
2024-05-20T21:43:01.798Z,1716241381.798 [RDI_Pathfinder](INFO): Powering down
2024-05-20T21:43:01.799Z,1716241381.799 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2024-05-20T21:43:01.800Z,1716241381.800 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2024-05-20T21:43:01.800Z,1716241381.800 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2024-05-20T21:43:01.801Z,1716241381.801 [MissionManager](INFO): Uninitializing Mission DefaultTankUndock
2024-05-20T21:43:01.801Z,1716241381.801 [DefaultTankUndock] Stopped
2024-05-20T21:43:01.801Z,1716241381.801 [DefaultTankUndock](DEBUG): Aggregate::uninitialize DefaultTankUndock
2024-05-20T21:43:01.801Z,1716241381.801 [DefaultTankUndock:B.GoToSurface] Stopped
2024-05-20T21:43:01.801Z,1716241381.801 [DefaultTankUndock:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2024-05-20T21:43:01.801Z,1716241381.801 [DefaultTankUndock:CheckIn] Stopped
2024-05-20T21:43:01.801Z,1716241381.801 [DefaultTankUndock:CheckIn](DEBUG): Aggregate::uninitialize DefaultTankUndock:CheckIn
2024-05-20T21:43:01.802Z,1716241381.802 [DefaultTankUndock:CheckIn:C.Wait] Stopped
2024-05-20T21:43:01.802Z,1716241381.802 [DefaultTankUndock:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-05-20T21:43:01.805Z,1716241381.805 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2024-05-20T21:43:01.805Z,1716241381.805 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2024-05-20T21:43:01.805Z,1716241381.805 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2024-05-20T21:43:01.806Z,1716241381.806 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2024-05-20T21:43:01.806Z,1716241381.806 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2024-05-20T21:43:01.806Z,1716241381.806 [BuoyancyServo](INFO): Powering down
2024-05-20T21:43:01.820Z,1716241381.820 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2024-05-20T21:43:01.820Z,1716241381.820 [ElevatorServo](INFO): Powering down
2024-05-20T21:43:01.821Z,1716241381.821 [DockingStepper](DEBUG): Uninitialize Docking Stepper.
2024-05-20T21:43:01.821Z,1716241381.821 [DockingStepper](INFO): Powering down
2024-05-20T21:43:01.822Z,1716241381.822 [MassServo](DEBUG): Uninitialize Mass Servo.
2024-05-20T21:43:01.822Z,1716241381.822 [MassServo](INFO): Powering down
2024-05-20T21:43:01.823Z,1716241381.823 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2024-05-20T21:43:01.823Z,1716241381.823 [RudderServo](INFO): Powering down
2024-05-20T21:43:01.824Z,1716241381.824 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2024-05-20T21:43:01.824Z,1716241381.824 [ThrusterServo](INFO): Powering down
2024-05-20T21:43:01.825Z,1716241381.825 [SBIT](DEBUG): Uninitialize SBIT Component.
2024-05-20T21:43:01.826Z,1716241381.826 [IBIT](DEBUG): Uninitialize IBIT Component.
2024-05-20T21:43:01.826Z,1716241381.826 [CBIT](DEBUG): Uninitialize CBIT Component.
2024-05-20T21:43:01.826Z,1716241381.826 [CBIT](DEBUG): Powering off loads.
2024-05-20T21:43:01.840Z,1716241381.840 [CBIT](DEBUG): Disabling WDT.
2024-05-20T21:43:01.852Z,1716241381.852 [CBIT](DEBUG): Opening all GF detection circuits.
2024-05-20T21:43:01.854Z,1716241381.854 [controlThread ThreadHandler](INFO): Thread cancelled.
2024-05-20T21:43:01.909Z,1716241381.909 [DAT ThreadHandler](INFO): Thread cancelled.
2024-05-20T21:43:01.917Z,1716241381.917 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2024-05-20T21:43:01.919Z,1716241381.919 [Onboard ThreadHandler](INFO): Thread cancelled.
2024-05-20T21:43:01.925Z,1716241381.925 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2024-05-20T21:43:01.974Z,1716241381.974 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2024-05-20T21:43:02.040Z,1716241382.040 [WetLabsUBAT ThreadHandler](INFO): Thread cancelled.
2024-05-20T21:43:02.042Z,1716241382.042 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2024-05-20T21:43:02.048Z,1716241382.048 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2024-05-20T21:43:02.057Z,1716241382.057 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2024-05-20T21:43:02.138Z,1716241382.138 [logger ThreadHandler](INFO): Thread cancelled.