2022-02-17T03:12:50.650Z,1645067570.650 [Supervisor](DEBUG): Initializing supervisor.
2022-02-17T03:12:50.655Z,1645067570.655 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2022-02-17T03:12:50.655Z,1645067570.655 [SyncHandler](INFO): Protected caller Thread ID is 8789
2022-02-17T03:12:50.655Z,1645067570.655 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2022-02-17T03:12:50.656Z,1645067570.656 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2022-02-17T03:12:50.657Z,1645067570.657 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 8790
2022-02-17T03:12:50.661Z,1645067570.661 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2022-02-17T03:12:50.679Z,1645067570.679 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2022-02-17T03:12:50.680Z,1645067570.680 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2022-02-17T03:12:50.680Z,1645067570.680 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 8791
2022-02-17T03:12:50.684Z,1645067570.684 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2022-02-17T03:12:50.685Z,1645067570.685 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2022-02-17T03:12:50.685Z,1645067570.685 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 8792
2022-02-17T03:12:50.688Z,1645067570.688 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2022-02-17T03:12:50.688Z,1645067570.688 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2022-02-17T03:12:50.689Z,1645067570.689 [logger ThreadHandler](INFO): Protected caller Thread ID is 8793
2022-02-17T03:12:50.692Z,1645067570.692 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2022-02-17T03:12:50.693Z,1645067570.693 [Supervisor](INFO): Looking for Config files in directory: Config/
2022-02-17T03:12:50.694Z,1645067570.694 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2022-02-17T03:12:51.111Z,1645067571.111 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2022-02-17T03:12:51.111Z,1645067571.111 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2022-02-17T03:12:51.330Z,1645067571.330 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2022-02-17T03:12:51.330Z,1645067571.330 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2022-02-17T03:12:51.519Z,1645067571.519 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2022-02-17T03:12:51.520Z,1645067571.520 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2022-02-17T03:12:51.630Z,1645067571.630 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2022-02-17T03:12:51.630Z,1645067571.630 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2022-02-17T03:12:51.999Z,1645067571.999 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2022-02-17T03:12:52.000Z,1645067572.000 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2022-02-17T03:12:52.326Z,1645067572.326 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2022-02-17T03:12:52.327Z,1645067572.327 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2022-02-17T03:12:52.424Z,1645067572.424 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2022-02-17T03:12:52.425Z,1645067572.425 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2022-02-17T03:12:52.577Z,1645067572.577 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2022-02-17T03:12:52.578Z,1645067572.578 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2022-02-17T03:12:53.103Z,1645067573.103 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2022-02-17T03:12:53.104Z,1645067573.104 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2022-02-17T03:12:53.459Z,1645067573.459 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2022-02-17T03:12:53.459Z,1645067573.459 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2022-02-17T03:12:53.541Z,1645067573.541 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2022-02-17T03:12:53.829Z,1645067573.829 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2022-02-17T03:12:53.830Z,1645067573.830 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2022-02-17T03:12:53.957Z,1645067573.957 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2022-02-17T03:12:53.957Z,1645067573.957 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2022-02-17T03:12:54.650Z,1645067574.650 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2022-02-17T03:12:54.650Z,1645067574.650 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2022-02-17T03:12:54.731Z,1645067574.731 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2022-02-17T03:12:55.011Z,1645067575.011 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2022-02-17T03:12:55.013Z,1645067575.013 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-galene/
2022-02-17T03:12:55.014Z,1645067575.014 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/vehicle.cfg
2022-02-17T03:12:55.189Z,1645067575.189 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/logger.cfg
2022-02-17T03:12:55.282Z,1645067575.282 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Servo.cfg
2022-02-17T03:12:55.405Z,1645067575.405 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Control.cfg
2022-02-17T03:12:55.632Z,1645067575.632 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/secure.cfg
2022-02-17T03:12:55.750Z,1645067575.750 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Simulator.cfg
2022-02-17T03:12:56.012Z,1645067576.012 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Science.cfg
2022-02-17T03:12:56.243Z,1645067576.243 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/BIT.cfg
2022-02-17T03:12:56.445Z,1645067576.445 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Sensor.cfg
2022-02-17T03:12:56.598Z,1645067576.598 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Battery.cfg
2022-02-17T03:12:56.858Z,1645067576.858 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2022-02-17T03:12:56.858Z,1645067576.858 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Navigation.cfg
2022-02-17T03:12:56.955Z,1645067576.955 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-galene/root/
2022-02-17T03:12:56.955Z,1645067576.955 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2022-02-17T03:12:56.971Z,1645067576.971 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2022-02-17T03:12:57.285Z,1645067577.285 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2022-02-17T03:12:57.285Z,1645067577.285 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2022-02-17T03:12:57.398Z,1645067577.398 [DeadReckonUsingMultipleVelocitySources] Loaded
2022-02-17T03:12:57.398Z,1645067577.398 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2022-02-17T03:12:57.436Z,1645067577.436 [DeadReckonUsingSpeedCalculator] Loaded
2022-02-17T03:12:57.436Z,1645067577.436 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2022-02-17T03:12:57.449Z,1645067577.449 [NavChart] Loaded
2022-02-17T03:12:57.449Z,1645067577.449 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2022-02-17T03:12:57.454Z,1645067577.454 [UniversalFixResidualReporter] Loaded
2022-02-17T03:12:57.454Z,1645067577.454 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2022-02-17T03:12:57.455Z,1645067577.455 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2022-02-17T03:12:57.455Z,1645067577.455 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2022-02-17T03:12:57.466Z,1645067577.466 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2022-02-17T03:12:57.467Z,1645067577.467 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2022-02-17T03:12:57.635Z,1645067577.635 [CTD_Seabird] Loaded
2022-02-17T03:12:57.635Z,1645067577.635 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2022-02-17T03:12:57.636Z,1645067577.636 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 406614E0
2022-02-17T03:12:57.637Z,1645067577.637 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 8876
2022-02-17T03:12:57.656Z,1645067577.656 [PAR_Licor] Loaded
2022-02-17T03:12:57.656Z,1645067577.656 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2022-02-17T03:12:57.686Z,1645067577.686 [WetLabsBB2FL] Loaded
2022-02-17T03:12:57.686Z,1645067577.686 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2022-02-17T03:12:57.688Z,1645067577.688 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 406914E0
2022-02-17T03:12:57.688Z,1645067577.688 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 8877
2022-02-17T03:12:57.689Z,1645067577.689 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2022-02-17T03:12:57.689Z,1645067577.689 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2022-02-17T03:12:57.740Z,1645067577.740 [VerticalControl](DEBUG): Construct VerticalControl.
2022-02-17T03:12:57.800Z,1645067577.800 [VerticalControl] Loaded
2022-02-17T03:12:57.801Z,1645067577.801 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2022-02-17T03:12:57.803Z,1645067577.803 [HorizontalControl](DEBUG): Construct HorizontalControl.
2022-02-17T03:12:57.841Z,1645067577.841 [HorizontalControl] Loaded
2022-02-17T03:12:57.841Z,1645067577.841 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2022-02-17T03:12:57.843Z,1645067577.843 [SpeedControl](DEBUG): Construct SpeedControl.
2022-02-17T03:12:57.846Z,1645067577.846 [SpeedControl] Loaded
2022-02-17T03:12:57.847Z,1645067577.847 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2022-02-17T03:12:57.849Z,1645067577.849 [LoopControl](DEBUG): Construct LoopControl.
2022-02-17T03:12:57.850Z,1645067577.850 [LoopControl] Loaded
2022-02-17T03:12:57.850Z,1645067577.850 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2022-02-17T03:12:57.850Z,1645067577.850 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2022-02-17T03:12:57.851Z,1645067577.851 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2022-02-17T03:12:57.892Z,1645067577.892 [DepthRateCalculator] Loaded
2022-02-17T03:12:57.893Z,1645067577.893 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2022-02-17T03:12:57.897Z,1645067577.897 [PitchRateCalculator] Loaded
2022-02-17T03:12:57.898Z,1645067577.898 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2022-02-17T03:12:57.907Z,1645067577.907 [SpeedCalculator] Loaded
2022-02-17T03:12:57.907Z,1645067577.907 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2022-02-17T03:12:57.920Z,1645067577.920 [TempGradientCalculator] Loaded
2022-02-17T03:12:57.920Z,1645067577.920 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2022-02-17T03:12:57.924Z,1645067577.924 [YawRateCalculator] Loaded
2022-02-17T03:12:57.924Z,1645067577.924 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2022-02-17T03:12:57.942Z,1645067577.942 [ElevatorOffsetCalculator] Loaded
2022-02-17T03:12:57.942Z,1645067577.942 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2022-02-17T03:12:57.943Z,1645067577.943 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2022-02-17T03:12:57.943Z,1645067577.943 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2022-02-17T03:12:58.038Z,1645067578.038 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2022-02-17T03:12:58.038Z,1645067578.038 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2022-02-17T03:12:58.095Z,1645067578.095 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2022-02-17T03:12:58.096Z,1645067578.096 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2022-02-17T03:12:58.219Z,1645067578.219 [BuoyancyServo] Loaded
2022-02-17T03:12:58.219Z,1645067578.219 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2022-02-17T03:12:58.238Z,1645067578.238 [ElevatorServo] Loaded
2022-02-17T03:12:58.238Z,1645067578.238 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2022-02-17T03:12:58.257Z,1645067578.257 [MassServo] Loaded
2022-02-17T03:12:58.257Z,1645067578.257 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2022-02-17T03:12:58.275Z,1645067578.275 [RudderServo] Loaded
2022-02-17T03:12:58.275Z,1645067578.275 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2022-02-17T03:12:58.290Z,1645067578.290 [ThrusterHE] Loaded
2022-02-17T03:12:58.290Z,1645067578.290 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread.
2022-02-17T03:12:58.290Z,1645067578.290 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2022-02-17T03:12:58.291Z,1645067578.291 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2022-02-17T03:12:58.391Z,1645067578.391 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2022-02-17T03:12:58.391Z,1645067578.391 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2022-02-17T03:12:58.785Z,1645067578.785 [AHRS_M2] Loaded
2022-02-17T03:12:58.786Z,1645067578.786 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2022-02-17T03:12:58.821Z,1645067578.821 [BackseatComponent] Loaded
2022-02-17T03:12:58.821Z,1645067578.821 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread.
2022-02-17T03:12:58.823Z,1645067578.823 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 40A774E0
2022-02-17T03:12:58.823Z,1645067578.823 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 8878
2022-02-17T03:12:58.826Z,1645067578.826 [LcmUniversalReporter] Loaded
2022-02-17T03:12:58.826Z,1645067578.826 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread.
2022-02-17T03:12:59.648Z,1645067579.648 [BPC1] Loaded
2022-02-17T03:12:59.649Z,1645067579.649 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2022-02-17T03:12:59.718Z,1645067579.718 [DataOverHttps] Loaded
2022-02-17T03:12:59.719Z,1645067579.719 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2022-02-17T03:12:59.720Z,1645067579.720 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 40AA74E0
2022-02-17T03:12:59.720Z,1645067579.720 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 8879
2022-02-17T03:12:59.740Z,1645067579.740 [Depth_Keller] Loaded
2022-02-17T03:12:59.740Z,1645067579.740 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2022-02-17T03:12:59.800Z,1645067579.800 [NAL9602] Loaded
2022-02-17T03:12:59.800Z,1645067579.800 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2022-02-17T03:12:59.829Z,1645067579.829 [Onboard] Loaded
2022-02-17T03:12:59.829Z,1645067579.829 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2022-02-17T03:12:59.830Z,1645067579.830 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 40AD74E0
2022-02-17T03:12:59.830Z,1645067579.830 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 8880
2022-02-17T03:12:59.841Z,1645067579.841 [Power24vConverter] Loaded
2022-02-17T03:12:59.842Z,1645067579.842 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2022-02-17T03:12:59.854Z,1645067579.854 [Radio_Surface] Loaded
2022-02-17T03:12:59.855Z,1645067579.855 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2022-02-17T03:12:59.856Z,1645067579.856 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 40B074E0
2022-02-17T03:12:59.856Z,1645067579.856 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 8881
2022-02-17T03:12:59.939Z,1645067579.939 [DAT] Loaded
2022-02-17T03:12:59.939Z,1645067579.939 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread.
2022-02-17T03:12:59.940Z,1645067579.940 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 40B374E0
2022-02-17T03:12:59.941Z,1645067579.941 [DAT ThreadHandler](INFO): Protected caller Thread ID is 8882
2022-02-17T03:12:59.941Z,1645067579.941 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2022-02-17T03:12:59.942Z,1645067579.942 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2022-02-17T03:13:00.085Z,1645067580.085 [SBIT](DEBUG): Construct Startup Built In Test.
2022-02-17T03:13:00.094Z,1645067580.094 [SBIT] Loaded
2022-02-17T03:13:00.094Z,1645067580.094 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2022-02-17T03:13:00.097Z,1645067580.097 [IBIT](DEBUG): Construct Initiated Built In Test.
2022-02-17T03:13:00.109Z,1645067580.109 [IBIT] Loaded
2022-02-17T03:13:00.110Z,1645067580.110 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2022-02-17T03:13:00.115Z,1645067580.115 [CBIT](DEBUG): Construct Continuous Built In Test.
2022-02-17T03:13:00.216Z,1645067580.216 [CBIT] Loaded
2022-02-17T03:13:00.216Z,1645067580.216 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2022-02-17T03:13:00.217Z,1645067580.217 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2022-02-17T03:13:00.217Z,1645067580.217 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2022-02-17T03:13:00.245Z,1645067580.245 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2022-02-17T03:13:00.251Z,1645067580.251 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2022-02-17T03:13:00.253Z,1645067580.253 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2022-02-17T03:13:00.264Z,1645067580.264 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2022-02-17T03:13:00.265Z,1645067580.265 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40BC44E0
2022-02-17T03:13:00.265Z,1645067580.265 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 8883
2022-02-17T03:13:00.270Z,1645067580.270 [Supervisor](INFO): Main Thread ID is 8788
2022-02-17T03:13:00.270Z,1645067580.270 [Supervisor](DEBUG): Running supervisor.
2022-02-17T03:13:00.270Z,1645067580.270 [CommandExec ThreadHandler](INFO): Handler Thread ID is 8884
2022-02-17T03:13:00.271Z,1645067580.271 [CommandExec](INFO): Initializing the command executive.
2022-02-17T03:13:00.273Z,1645067580.273 [CommandLine ThreadHandler](INFO): Handler Thread ID is 8885
2022-02-17T03:13:00.276Z,1645067580.276 [controlThread ThreadHandler](INFO): Handler Thread ID is 8886
2022-02-17T03:13:00.277Z,1645067580.277 [controlThread](DEBUG): Initializing ControlThread
2022-02-17T03:13:00.278Z,1645067580.278 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2022-02-17T03:13:00.279Z,1645067580.279 [NavChart](DEBUG): Initialize NavChart Navigation.
2022-02-17T03:13:00.279Z,1645067580.279 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2022-02-17T03:13:00.284Z,1645067580.284 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2022-02-17T03:13:00.286Z,1645067580.286 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2022-02-17T03:13:00.286Z,1645067580.286 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2022-02-17T03:13:00.287Z,1645067580.287 [LoopControl](DEBUG): Initialize LoopControlComponent.
2022-02-17T03:13:00.287Z,1645067580.287 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2022-02-17T03:13:00.287Z,1645067580.287 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2022-02-17T03:13:00.288Z,1645067580.288 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2022-02-17T03:13:00.288Z,1645067580.288 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2022-02-17T03:13:00.289Z,1645067580.289 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2022-02-17T03:13:00.289Z,1645067580.289 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2022-02-17T03:13:00.293Z,1645067580.293 [SBIT](INFO): Initialize SBIT Component.
2022-02-17T03:13:00.293Z,1645067580.293 [SBIT](IMPORTANT): git: 2022-02-01-41-g055a528aa
2022-02-17T03:13:00.293Z,1645067580.293 [SBIT](INFO): git hash: 055a528aa498dab0a50a7c43a264b31c2ead9ecb
2022-02-17T03:13:00.294Z,1645067580.294 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2022-02-17T03:13:00.295Z,1645067580.295 [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
2022-02-17T03:13:00.296Z,1645067580.296 [SBIT](INFO): Beginning SBIT in 38.000000 seconds.
2022-02-17T03:13:00.297Z,1645067580.297 [IBIT](INFO): Initialize IBIT Component.
2022-02-17T03:13:00.298Z,1645067580.298 [CBIT](DEBUG): Initialize CBIT Component.
2022-02-17T03:13:00.298Z,1645067580.298 [logger ThreadHandler](INFO): Handler Thread ID is 8887
2022-02-17T03:13:00.312Z,1645067580.312 [CBIT](DEBUG): Initialized mux pins.
2022-02-17T03:13:00.312Z,1645067580.312 [CBIT](DEBUG): Initializing the watchdog timer.
2022-02-17T03:13:00.316Z,1645067580.316 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 8888
2022-02-17T03:13:00.317Z,1645067580.317 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2022-02-17T03:13:00.321Z,1645067580.321 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 8890
2022-02-17T03:13:00.324Z,1645067580.324 [WetLabsBB2FL](INFO): Powering up
2022-02-17T03:13:00.326Z,1645067580.326 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 8892
2022-02-17T03:13:00.333Z,1645067580.333 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 8893
2022-02-17T03:13:00.333Z,1645067580.333 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2022-02-17T03:13:00.336Z,1645067580.336 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2022-02-17T03:13:00.337Z,1645067580.337 [CBIT](DEBUG): Initializing heartbeat.
2022-02-17T03:13:00.345Z,1645067580.345 [Onboard ThreadHandler](INFO): Handler Thread ID is 8894
2022-02-17T03:13:00.362Z,1645067580.362 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 8895
2022-02-17T03:13:00.380Z,1645067580.380 [DAT ThreadHandler](INFO): Handler Thread ID is 8896
2022-02-17T03:13:00.381Z,1645067580.381 [DAT](INFO): Powering up
2022-02-17T03:13:00.381Z,1645067580.381 [DAT](DEBUG): Initializing DAT.
2022-02-17T03:13:00.385Z,1645067580.385 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 8898
2022-02-17T03:13:00.388Z,1645067580.388 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2022-02-17T03:13:00.388Z,1645067580.388 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2022-02-17T03:13:00.389Z,1645067580.389 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2022-02-17T03:13:00.389Z,1645067580.389 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2022-02-17T03:13:00.389Z,1645067580.389 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2022-02-17T03:13:00.389Z,1645067580.389 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2022-02-17T03:13:00.389Z,1645067580.389 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2022-02-17T03:13:00.389Z,1645067580.389 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2022-02-17T03:13:00.390Z,1645067580.390 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2022-02-17T03:13:00.390Z,1645067580.390 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2022-02-17T03:13:00.390Z,1645067580.390 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2022-02-17T03:13:00.390Z,1645067580.390 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2022-02-17T03:13:00.390Z,1645067580.390 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2022-02-17T03:13:00.390Z,1645067580.390 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2022-02-17T03:13:00.391Z,1645067580.391 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2022-02-17T03:13:00.391Z,1645067580.391 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2022-02-17T03:13:00.408Z,1645067580.408 [CBIT](DEBUG): Deactivating GF circuits.
2022-02-17T03:13:00.408Z,1645067580.408 [CBIT](DEBUG): Deactivating emergency mode.
2022-02-17T03:13:00.444Z,1645067580.444 [CBIT](DEBUG): Backplane powered.
2022-02-17T03:13:00.445Z,1645067580.445 [MissionManager](INFO): Loading Mission from file: Missions/Startup_lab.xml
2022-02-17T03:13:00.456Z,1645067580.456 [Startup_lab:A.GoToSurface](DEBUG): Construct GoToSurface.
2022-02-17T03:13:00.473Z,1645067580.473 [Startup_lab:B.Wait](DEBUG): Construct Wait.
2022-02-17T03:13:00.475Z,1645067580.475 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns="Tethys"
       xmlns:Control="Tethys/Control"
       xmlns:Guidance="Tethys/Guidance" 
       xmlns:Units="Tethys/Units"
       xmlns:Universal="Tethys/Universal"
       xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
       xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                           Tethys/Control http://okeanids.mbari.org/tethys/Xml/Control.xsd
                           Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                           Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                           Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
       Id="Startup_lab">

    <Guidance:GoToSurface>
        <Progression/>
    </Guidance:GoToSurface>
    
    <Guidance:Wait>
        <Sequence/>
        <Setting><Guidance:Wait.duration/><Units:second/><Value>3</Value></Setting>
    </Guidance:Wait>

</Mission>


2022-02-17T03:13:00.489Z,1645067580.489 [MissionManager](INFO): Loading Mission from file: Missions/Default.xml
2022-02-17T03:13:00.593Z,1645067580.593 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2022-02-17T03:13:00.595Z,1645067580.595 [Default:A.Wait](DEBUG): Construct Wait.
2022-02-17T03:13:00.615Z,1645067580.615 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2022-02-17T03:13:00.643Z,1645067580.643 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2022-02-17T03:13:00.646Z,1645067580.646 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2022-02-17T03:13:00.664Z,1645067580.664 [Default:E.Execute](DEBUG): Construct Execute.
2022-02-17T03:13:00.667Z,1645067580.667 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
         xmlns="Tethys"
         xmlns:Units="Tethys/Units"
         xmlns:Guidance="Tethys/Guidance"
         xmlns:Universal="Tethys/Universal"
         xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                             Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                             Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                             Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
         Id="Default">

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

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

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

    <Aggregate Id="CheckIn">

        <Sequence Repeat="288"/>

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

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

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

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

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

    </Aggregate>

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

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

</Mission>


2022-02-17T03:13:00.688Z,1645067580.688 [controlThread](DEBUG): Component order: CycleStarter,PAR_Licor,AHRS_M2,BPC1,Depth_Keller,NAL9602,Power24vConverter,PAR_Licor,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter,
2022-02-17T03:13:00.709Z,1645067580.709 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2022-02-17T03:13:00.768Z,1645067580.768 [Radio_Surface](INFO): Powering up
2022-02-17T03:13:00.776Z,1645067580.776 [Depth_Keller](ERROR): Pressure reading out of range: 1628.471313 decibar
2022-02-17T03:13:00.777Z,1645067580.777 [Power24vConverter](INFO): Powering up.
2022-02-17T03:13:00.779Z,1645067580.779 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-02-17T03:13:00.811Z,1645067580.811 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2022-02-17T03:13:00.820Z,1645067580.820 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2022-02-17T03:13:00.821Z,1645067580.821 [ElevatorServo](DEBUG): Initializing EZServoServo.
2022-02-17T03:13:00.828Z,1645067580.828 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2022-02-17T03:13:00.829Z,1645067580.829 [MassServo](DEBUG): Initializing EZServoServo.
2022-02-17T03:13:00.838Z,1645067580.838 [MassServo](DEBUG): Initializing MassServo.
2022-02-17T03:13:00.840Z,1645067580.840 [RudderServo](DEBUG): Initializing EZServoServo.
2022-02-17T03:13:00.854Z,1645067580.854 [RudderServo](DEBUG): Initializing RudderServo.
2022-02-17T03:13:00.855Z,1645067580.855 [ThrusterHE](DEBUG): Initializing EZServoServo.
2022-02-17T03:13:00.864Z,1645067580.864 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2022-02-17T03:13:02.936Z,1645067582.936 [WetLabsBB2FL](INFO): Powering down
2022-02-17T03:13:06.593Z,1645067586.593 [ThrusterHE](ERROR): Zero Speed Commanded.
2022-02-17T03:13:07.349Z,1645067587.349 [CTD_Seabird](ERROR): Device message queue exceeded the allowed limit.
2022-02-17T03:13:14.354Z,1645067594.354 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004722
2022-02-17T03:13:29.192Z,1645067609.192 [CommandExec](IMPORTANT): got command failComponent
2022-02-17T03:13:29.192Z,1645067609.192 [CommandExec](IMPORTANT): Failed components:
2022-02-17T03:13:29.193Z,1645067609.193 [CommandExec](IMPORTANT): No failed Components.
2022-02-17T03:13:30.197Z,1645067610.197 [NAL9602](INFO): Powering up NAL9602
2022-02-17T03:13:39.138Z,1645067619.138 [SBIT](IMPORTANT): Beginning Startup BIT
2022-02-17T03:13:39.177Z,1645067619.177 [CBIT](IMPORTANT): Beginning ground fault scan
2022-02-17T03:13:50.091Z,1645067630.091 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.000193
CHAN A1 (24V): 0.000722
CHAN A2 (12V): -0.005176
CHAN A3 (5V): -0.003007
CHAN B0 (3.3V): -0.001875
CHAN B1 (3.15aV): -0.001332
CHAN B2 (3.15bV): -0.001323
CHAN B3 (GND): -0.000516
OPEN: 0.004179
Full Scale: +/- 1 mA
2022-02-17T03:13:50.801Z,1645067630.801 [NAL9602](ERROR): NAL9602 initialization error.
2022-02-17T03:13:50.801Z,1645067630.801 [NAL9602] Communications Fault, FailCount= 1
2022-02-17T03:13:50.801Z,1645067630.801 [NAL9602](ERROR): Communications Fault
2022-02-17T03:13:50.889Z,1645067630.889 [CBIT](ERROR): Communications Fault in component: NAL9602
2022-02-17T03:13:51.209Z,1645067631.209 [NAL9602](INFO): Powering down
2022-02-17T03:13:52.050Z,1645067632.050 [CBIT](INFO): Clearing failed state for component NAL9602
2022-02-17T03:13:52.050Z,1645067632.050 [NAL9602] No Fault, FailCount= 1
2022-02-17T03:14:00.616Z,1645067640.616 [DAT](FAULT): failed to initialize, no bytes available on serial interface
2022-02-17T03:14:00.616Z,1645067640.616 [DAT] Communications Fault, FailCount= 1
2022-02-17T03:14:00.616Z,1645067640.616 [DAT](ERROR): Communications Fault
2022-02-17T03:14:00.945Z,1645067640.945 [CBIT](ERROR): Communications Fault in component: DAT
2022-02-17T03:14:01.020Z,1645067641.020 [DAT](INFO): Powering down
2022-02-17T03:14:02.161Z,1645067642.161 [CBIT](INFO): Clearing failed state for component DAT
2022-02-17T03:14:02.161Z,1645067642.161 [DAT] No Fault, FailCount= 1
2022-02-17T03:14:04.072Z,1645067644.072 [DAT](INFO): Powering up
2022-02-17T03:14:04.072Z,1645067644.072 [DAT](DEBUG): Initializing DAT.
2022-02-17T03:14:15.672Z,1645067655.672 [DAT](INFO): DAT read: 

2022-02-17T03:14:15.674Z,1645067655.674 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series

2022-02-17T03:14:17.185Z,1645067657.185 [DAT](INFO): DAT read: MF Frequency Band

2022-02-17T03:14:17.186Z,1645067657.186 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.15.0

2022-02-17T03:14:17.186Z,1645067657.186 [DAT](INFO): DAT read: Feb 17 2022 03:14:12 

2022-02-17T03:14:18.445Z,1645067658.445 [DAT](INFO): DAT read: Features enabled [Bearing]

2022-02-17T03:14:18.446Z,1645067658.446 [DAT](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP

2022-02-17T03:14:18.446Z,1645067658.446 [DAT](INFO): commRate: 800
2022-02-17T03:14:20.512Z,1645067660.512 [DAT](INFO): entering command mode
2022-02-17T03:14:20.718Z,1645067660.718 [DAT](INFO): DAT read: 

2022-02-17T03:14:20.718Z,1645067660.718 [DAT](INFO): DAT read: user:1>

2022-02-17T03:14:20.719Z,1645067660.719 [DAT](INFO): setting verbose to 3
2022-02-17T03:14:20.968Z,1645067660.968 [DAT](INFO): DAT read: user:1>

2022-02-17T03:14:20.969Z,1645067660.969 [DAT](INFO): DAT read: Verbose         | 3           

2022-02-17T03:14:20.970Z,1645067660.970 [DAT](INFO): set verbose to 3
2022-02-17T03:14:20.970Z,1645067660.970 [DAT](INFO): setting DatVerbose to 27440
2022-02-17T03:14:21.221Z,1645067661.221 [DAT](INFO): DAT read: user:2>

2022-02-17T03:14:21.222Z,1645067661.222 [DAT](INFO): DAT read: DatVerbose      | 27440       

2022-02-17T03:14:21.222Z,1645067661.222 [DAT](INFO): set DatVerbose to 27440
2022-02-17T03:14:21.222Z,1645067661.222 [DAT](INFO): setting transmit power to 8
2022-02-17T03:14:21.472Z,1645067661.472 [DAT](INFO): DAT read: user:3>

2022-02-17T03:14:21.473Z,1645067661.473 [DAT](INFO): DAT read: TxPower         | 8 (Max)     

2022-02-17T03:14:21.474Z,1645067661.474 [DAT](INFO): set transmit power to 8
2022-02-17T03:14:21.474Z,1645067661.474 [DAT](INFO): setting local address to 10
2022-02-17T03:14:21.567Z,1645067661.567 [NAL9602](INFO): Powering up NAL9602
2022-02-17T03:14:21.724Z,1645067661.724 [DAT](INFO): DAT read: user:4>

2022-02-17T03:14:21.725Z,1645067661.725 [DAT](INFO): DAT read: LocalAddr       | 10          

2022-02-17T03:14:21.726Z,1645067661.726 [DAT](INFO): set local address to 10
2022-02-17T03:14:21.727Z,1645067661.727 [DAT](INFO): Setting time to: 3:14:21 And date to:2/17/2022
2022-02-17T03:14:21.976Z,1645067661.976 [DAT](INFO): DAT read: user:5>

2022-02-17T03:14:21.977Z,1645067661.977 [DAT](INFO): DAT read: Thu Feb 17, 2022  03:14:21  

2022-02-17T03:14:21.978Z,1645067661.978 [DAT](INFO): Local DAT time set to Thu Feb 17, 2022  03:14:21  

2022-02-17T03:14:32.417Z,1645067672.417 [NAL9602](INFO): NAL9602 initialized
2022-02-17T03:14:33.255Z,1645067673.255 [SBIT](IMPORTANT): SBIT PASSED
2022-02-17T03:14:33.256Z,1645067673.256 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2022-02-17T03:14:33.256Z,1645067673.256 [SBIT](IMPORTANT): BackseatComponent.needs24v=1 bool;

2022-02-17T03:14:33.257Z,1645067673.257 [SBIT](IMPORTANT): BuoyancyServo.fastPumpCoefficient=6 none;

2022-02-17T03:14:33.257Z,1645067673.257 [SBIT](IMPORTANT): CBIT.gf24Offset=149 microampere;

2022-02-17T03:14:33.257Z,1645067673.257 [SBIT](IMPORTANT): DAT.sbdAddress=21 enum;

2022-02-17T03:14:33.257Z,1645067673.257 [SBIT](IMPORTANT): DAT.surfaceThreshold=3 meter;

2022-02-17T03:14:33.257Z,1645067673.257 [SBIT](IMPORTANT): DAT.verbosity=3 count;

2022-02-17T03:14:33.257Z,1645067673.257 [SBIT](IMPORTANT): DropWeight.loadAtStartup=0 bool;

2022-02-17T03:14:33.257Z,1645067673.257 [SBIT](IMPORTANT): Express linearApproximation _.ayeris_disk_space 10.000000 gigabyte;

2022-02-17T03:14:33.257Z,1645067673.257 [SBIT](IMPORTANT): Express linearApproximation _.ayeris_particle_counts 100.000000 count;

2022-02-17T03:14:33.258Z,1645067673.258 [SBIT](IMPORTANT): Express linearApproximation _.ayeris_particle_size 2.500000 millimeter;

2022-02-17T03:14:33.258Z,1645067673.258 [SBIT](IMPORTANT): Express linearApproximation _.eyeris_particle_counts 100.000000 count;

2022-02-17T03:14:33.258Z,1645067673.258 [SBIT](IMPORTANT): IBIT.batteryCapacityThreshold=5 ampere_hour;

2022-02-17T03:14:33.258Z,1645067673.258 [SBIT](IMPORTANT): IBIT.batteryVoltageThreshold=11 volt;

2022-02-17T03:14:33.258Z,1645067673.258 [SBIT](IMPORTANT): PowerOnly.loadAtStartup=0 bool;

2022-02-17T03:14:33.258Z,1645067673.258 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=115.741138 cubic_centimeter;

2022-02-17T03:14:33.258Z,1645067673.258 [SBIT](IMPORTANT): VerticalControl.massDefault=-4.597572 millimeter;

2022-02-17T03:14:33.663Z,1645067673.663 [MissionManager](IMPORTANT): Started mission Startup_lab
2022-02-17T03:14:33.663Z,1645067673.663 [Startup_lab] Running Loop=1
2022-02-17T03:14:33.663Z,1645067673.663 [Startup_lab](DEBUG): Aggregate::initialize Startup_lab
2022-02-17T03:14:33.663Z,1645067673.663 [Startup_lab:A.GoToSurface] Running Loop=1
2022-02-17T03:14:33.663Z,1645067673.663 [Startup_lab:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2022-02-17T03:14:33.664Z,1645067673.664 [Startup_lab:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2022-02-17T03:14:33.664Z,1645067673.664 [Startup_lab:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2022-02-17T03:14:33.665Z,1645067673.665 [Startup_lab:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2022-02-17T03:14:33.665Z,1645067673.665 [Startup_lab:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2022-02-17T03:14:33.665Z,1645067673.665 [Startup_lab:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2022-02-17T03:14:33.667Z,1645067673.667 [Startup_lab:B.Wait] Running Loop=1
2022-02-17T03:14:33.667Z,1645067673.667 [Startup_lab:B.Wait](DEBUG): Initialize Wait Component.
2022-02-17T03:14:37.270Z,1645067677.270 [Startup_lab:B.Wait](INFO): Done Waiting.
2022-02-17T03:14:37.270Z,1645067677.270 [Startup_lab:B.Wait] Stopped
2022-02-17T03:14:37.270Z,1645067677.270 [Startup_lab:B.Wait](DEBUG): Uninitialize Wait Component.
2022-02-17T03:14:37.270Z,1645067677.270 [Startup_lab](INFO): Completed Startup_lab
2022-02-17T03:14:37.271Z,1645067677.271 [MissionManager](INFO): Startup_lab is completed.
2022-02-17T03:14:37.271Z,1645067677.271 [MissionManager](INFO): Uninitializing Mission Startup_lab
2022-02-17T03:14:37.271Z,1645067677.271 [Startup_lab] Stopped
2022-02-17T03:14:37.271Z,1645067677.271 [Startup_lab](DEBUG): Aggregate::uninitialize Startup_lab
2022-02-17T03:14:37.271Z,1645067677.271 [Startup_lab:A.GoToSurface] Stopped
2022-02-17T03:14:37.271Z,1645067677.271 [Startup_lab:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2022-02-17T03:14:37.683Z,1645067677.683 [MissionManager](IMPORTANT): Started mission Default
2022-02-17T03:14:37.683Z,1645067677.683 [Default] Running Loop=1
2022-02-17T03:14:37.683Z,1645067677.683 [Default](DEBUG): Aggregate::initialize Default
2022-02-17T03:14:37.683Z,1645067677.683 [Default:B.GoToSurface] Running Loop=1
2022-02-17T03:14:37.683Z,1645067677.683 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2022-02-17T03:14:37.684Z,1645067677.684 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2022-02-17T03:14:37.684Z,1645067677.684 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2022-02-17T03:14:37.684Z,1645067677.684 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2022-02-17T03:14:37.685Z,1645067677.685 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2022-02-17T03:14:37.685Z,1645067677.685 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2022-02-17T03:14:37.685Z,1645067677.685 [Default:A.Wait] Running Loop=1
2022-02-17T03:14:37.685Z,1645067677.685 [Default:A.Wait](DEBUG): Initialize Wait Component.
2022-02-17T03:14:51.031Z,1645067691.031 [Default:A.Wait](INFO): Done Waiting.
2022-02-17T03:14:51.031Z,1645067691.031 [Default:A.Wait] Stopped
2022-02-17T03:14:51.031Z,1645067691.031 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2022-02-17T03:14:51.423Z,1645067691.423 [Default:CheckIn] Running Loop=1
2022-02-17T03:14:51.423Z,1645067691.423 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2022-02-17T03:14:51.423Z,1645067691.423 [Default:CheckIn:Read_GPS] Running Loop=1
2022-02-17T03:14:51.843Z,1645067691.843 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2022-02-17T03:15:11.121Z,1645067711.121 [CommandExec](IMPORTANT): got command run ./Missions/Engineering/lineCaptureHoming.xml
2022-02-17T03:15:11.121Z,1645067711.121 [MissionManager](INFO): Loading Mission from file: ./Missions/Engineering/lineCaptureHoming.xml
2022-02-17T03:15:11.327Z,1645067711.327 [MissionManager](INFO): DefineArg lineCaptureHoming.MissionTimeout = 4.000000 h
2022-02-17T03:15:11.349Z,1645067711.349 [MissionManager](INFO): DefineArg lineCaptureHoming.NeedCommsTime = 240.000000 min
2022-02-17T03:15:11.352Z,1645067711.352 [MissionManager](INFO): DefineArg lineCaptureHoming.MicromodemCommsInterval = 5.000000 min
2022-02-17T03:15:11.355Z,1645067711.355 [MissionManager](INFO): DefineArg lineCaptureHoming.Repeat = 1.000000 count
2022-02-17T03:15:11.358Z,1645067711.358 [MissionManager](INFO): DefineArg lineCaptureHoming.WaitOnDockTimeout = 5.000000 min
2022-02-17T03:15:11.361Z,1645067711.361 [MissionManager](INFO): DefineArg lineCaptureHoming.TransponderCode = 2 count
2022-02-17T03:15:11.365Z,1645067711.365 [MissionManager](INFO): DefineArg lineCaptureHoming.TrackingUpdatePeriodMidcourse = 60.000000 s
2022-02-17T03:15:11.368Z,1645067711.368 [MissionManager](INFO): DefineArg lineCaptureHoming.TrackingUpdatePeriodTerminal = 2.500000 s
2022-02-17T03:15:11.371Z,1645067711.371 [MissionManager](INFO): DefineArg lineCaptureHoming.TrackingNumFixesLowPassFilter = 5.000000 count
2022-02-17T03:15:11.374Z,1645067711.374 [MissionManager](INFO): DefineArg lineCaptureHoming.NumberOfPings = 1.000000 count
2022-02-17T03:15:11.377Z,1645067711.377 [MissionManager](INFO): DefineArg lineCaptureHoming.NumPingsUSBL = 5.000000 count
2022-02-17T03:15:11.379Z,1645067711.379 [MissionManager](INFO): DefineArg lineCaptureHoming.RangeUSBL = 40.000000 m
2022-02-17T03:15:11.419Z,1645067711.419 [MissionManager](INFO): DefineArg lineCaptureHoming.DockingAltitude = nan m
2022-02-17T03:15:11.422Z,1645067711.422 [MissionManager](INFO): DefineArg lineCaptureHoming.InvalidAltitudeTimeout = nan min
2022-02-17T03:15:11.433Z,1645067711.433 [MissionManager](INFO): DefineArg lineCaptureHoming.AltitudeDepthLimit = nan m
2022-02-17T03:15:11.435Z,1645067711.435 [MissionManager](INFO): DefineArg lineCaptureHoming.MinAltitude = 5.000000 m
2022-02-17T03:15:11.450Z,1645067711.450 [MissionManager](INFO): DefineArg lineCaptureHoming.MaxDepth = 205.000000 m
2022-02-17T03:15:11.454Z,1645067711.454 [MissionManager](INFO): DefineArg lineCaptureHoming.MinOffshore = 2.000000 km
2022-02-17T03:15:11.477Z,1645067711.477 [MissionManager](INFO): DefineOutput lineCaptureHoming.Mode = -1.000000 count
2022-02-17T03:15:11.484Z,1645067711.484 [MissionManager](INFO): DefineOutput lineCaptureHoming.NumPings = 1.000000 count
2022-02-17T03:15:11.487Z,1645067711.487 [MissionManager](INFO): DefineArg lineCaptureHoming.TrackingPeriod = 60.000000 s
2022-02-17T03:15:11.492Z,1645067711.492 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/Science.xml
2022-02-17T03:15:12.103Z,1645067712.103 [MissionManager](INFO): DefineArg lineCaptureHoming:Science.PeakDetectChlActive = 0 bool
2022-02-17T03:15:12.106Z,1645067712.106 [MissionManager](INFO): DefineArg lineCaptureHoming:Science.TimeWindowPeakReport = nan min
2022-02-17T03:15:12.109Z,1645067712.109 [MissionManager](INFO): DefineArg lineCaptureHoming:Science.HighestChlPeakReportActive = 0 bool
2022-02-17T03:15:12.140Z,1645067712.140 [MissionManager](INFO): DefineArg lineCaptureHoming:Science.HighestSaltPeakReportActive = 0 bool
2022-02-17T03:15:12.142Z,1645067712.142 [MissionManager](INFO): DefineArg lineCaptureHoming:Science.HighestOilPeakReportActive = 0 bool
2022-02-17T03:15:12.145Z,1645067712.145 [MissionManager](INFO): DefineArg lineCaptureHoming:Science.PatchTracking = 0 bool
2022-02-17T03:15:12.168Z,1645067712.168 [MissionManager](INFO): DefineArg lineCaptureHoming:Science.DetectTrough = 0 bool
2022-02-17T03:15:12.171Z,1645067712.171 [MissionManager](INFO): DefineArg lineCaptureHoming:Science.FilterWidthHorizontal = 3.000000 count
2022-02-17T03:15:12.188Z,1645067712.188 [MissionManager](INFO): DefineArg lineCaptureHoming:Science.NumProfilesSlidingwindow = 100.000000 count
2022-02-17T03:15:12.191Z,1645067712.191 [MissionManager](INFO): DefineArg lineCaptureHoming:Science.OffPeakFractionHorizontal = 80.000000 %
2022-02-17T03:15:12.198Z,1645067712.198 [MissionManager](INFO): DefineArg lineCaptureHoming:Science.PeakDetectNO3Active = 0 bool
2022-02-17T03:15:12.201Z,1645067712.201 [MissionManager](INFO): DefineArg lineCaptureHoming:Science.PeakDetectOilActive = 0 bool
2022-02-17T03:15:12.220Z,1645067712.220 [MissionManager](INFO): DefineArg lineCaptureHoming:Science.PeakDetectFDOMActive = 0 bool
2022-02-17T03:15:12.222Z,1645067712.222 [MissionManager](INFO): DefineArg lineCaptureHoming:Science.PeakDetectSalinityActive = 0 bool
2022-02-17T03:15:12.227Z,1645067712.227 [MissionManager](INFO): DefineArg lineCaptureHoming:Science.UpwardDerivativeOfTemperatureActive = 0 bool
2022-02-17T03:15:12.247Z,1645067712.247 [MissionManager](INFO): DefineArg lineCaptureHoming:Science.EnabledAanderaaO2 = 0 bool
2022-02-17T03:15:12.250Z,1645067712.250 [MissionManager](INFO): DefineArg lineCaptureHoming:Science.EnabledNeilBrown = 0 bool
2022-02-17T03:15:12.270Z,1645067712.270 [MissionManager](INFO): DefineArg lineCaptureHoming:Science.EnabledSeabird = 1 bool
2022-02-17T03:15:12.274Z,1645067712.274 [MissionManager](INFO): DefineArg lineCaptureHoming:Science.EnabledWetLabsBB2FL = 1 bool
2022-02-17T03:15:12.297Z,1645067712.297 [MissionManager](INFO): DefineArg lineCaptureHoming:Science.EnabledWetLabsSeaOWL_UV_A = 0 bool
2022-02-17T03:15:12.305Z,1645067712.305 [MissionManager](INFO): DefineArg lineCaptureHoming:Science.EnabledWetLabsUBAT = 0 bool
2022-02-17T03:15:12.316Z,1645067712.316 [MissionManager](INFO): DefineArg lineCaptureHoming:Science.LowPassWindowLength = 20.000000 count
2022-02-17T03:15:12.319Z,1645067712.319 [MissionManager](INFO): DefineArg lineCaptureHoming:Science.MedianFilterLen = 5.000000 count
2022-02-17T03:15:12.326Z,1645067712.326 [MissionManager](INFO): DefineArg lineCaptureHoming:Science.PeakShallowBound = nan m
2022-02-17T03:15:12.330Z,1645067712.330 [MissionManager](INFO): DefineArg lineCaptureHoming:Science.PeakDeepBound = nan m
2022-02-17T03:15:12.333Z,1645067712.333 [MissionManager](INFO): DefineArg lineCaptureHoming:Science.DepChangeThreshForAttitudeFlip = 2.000000 m
2022-02-17T03:15:12.372Z,1645067712.372 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PeakChl = 0.000000 ug/l
2022-02-17T03:15:12.375Z,1645067712.375 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PeakChlDepth = 0.000000 m
2022-02-17T03:15:12.378Z,1645067712.378 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PeakChlTemperature = 0.000000 degC
2022-02-17T03:15:12.427Z,1645067712.427 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PeakChlLatitude = nan arcdeg
2022-02-17T03:15:12.430Z,1645067712.430 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PeakChlLongitude = nan arcdeg
2022-02-17T03:15:12.453Z,1645067712.453 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PeakNO3 = 0.000000 umol/l
2022-02-17T03:15:12.464Z,1645067712.464 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PeakNO3Depth = 0.000000 m
2022-02-17T03:15:12.467Z,1645067712.467 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PeakNO3Latitude = nan arcdeg
2022-02-17T03:15:12.500Z,1645067712.500 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PeakNO3Longitude = nan arcdeg
2022-02-17T03:15:12.503Z,1645067712.503 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PeakOil = 0.000000 kg/m3
2022-02-17T03:15:12.517Z,1645067712.517 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PeakOilDepth = 0.000000 m
2022-02-17T03:15:12.532Z,1645067712.532 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PeakOilLatitude = nan arcdeg
2022-02-17T03:15:12.537Z,1645067712.537 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PeakOilLongitude = nan arcdeg
2022-02-17T03:15:12.560Z,1645067712.560 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PeakFDOM = 0.000000 ppb
2022-02-17T03:15:12.563Z,1645067712.563 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PeakFDOMDepth = 0.000000 m
2022-02-17T03:15:12.570Z,1645067712.570 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PeakFDOMTemperature = nan degC
2022-02-17T03:15:12.574Z,1645067712.574 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PeakFDOMLatitude = nan arcdeg
2022-02-17T03:15:12.593Z,1645067712.593 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PeakFDOMLongitude = nan arcdeg
2022-02-17T03:15:12.600Z,1645067712.600 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PatchFDOMDistance = nan m
2022-02-17T03:15:12.603Z,1645067712.603 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PeakSalt = 0.000000 psu
2022-02-17T03:15:12.610Z,1645067712.610 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PeakSaltDepth = 0.000000 m
2022-02-17T03:15:12.622Z,1645067712.622 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PeakSaltTemperature = 0.000000 degC
2022-02-17T03:15:12.627Z,1645067712.627 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PeakSaltLatitude = nan arcdeg
2022-02-17T03:15:12.638Z,1645067712.638 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PeakSaltLongitude = nan arcdeg
2022-02-17T03:15:12.662Z,1645067712.662 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PatchChl = 0.000000 ug/l
2022-02-17T03:15:12.665Z,1645067712.665 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PatchChlDepth = 0.000000 m
2022-02-17T03:15:12.684Z,1645067712.684 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PatchChlLatitude = nan arcdeg
2022-02-17T03:15:12.687Z,1645067712.687 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PatchChlLongitude = nan arcdeg
2022-02-17T03:15:12.694Z,1645067712.694 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PatchChlDistance = nan m
2022-02-17T03:15:12.698Z,1645067712.698 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PatchSalt = 0.000000 psu
2022-02-17T03:15:12.721Z,1645067712.721 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PatchSaltDepth = 0.000000 m
2022-02-17T03:15:12.724Z,1645067712.724 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PatchSaltLatitude = nan arcdeg
2022-02-17T03:15:12.727Z,1645067712.727 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PatchSaltLongitude = nan arcdeg
2022-02-17T03:15:12.734Z,1645067712.734 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PatchSaltDistance = nan m
2022-02-17T03:15:12.747Z,1645067712.747 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PatchOil = 0.000000 psu
2022-02-17T03:15:12.773Z,1645067712.773 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PatchOilDepth = 0.000000 m
2022-02-17T03:15:12.780Z,1645067712.780 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PatchOilLatitude = nan arcdeg
2022-02-17T03:15:12.826Z,1645067712.826 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PatchOilLongitude = nan arcdeg
2022-02-17T03:15:12.856Z,1645067712.856 [MissionManager](INFO): DefineOutput lineCaptureHoming:Science.PatchOilDistance = nan m
2022-02-17T03:15:12.974Z,1645067712.974 [lineCaptureHoming:Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2022-02-17T03:15:13.014Z,1645067713.014 [lineCaptureHoming:Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal.
2022-02-17T03:15:13.058Z,1645067713.058 [lineCaptureHoming:Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2022-02-17T03:15:13.093Z,1645067713.093 [lineCaptureHoming:Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2022-02-17T03:15:13.125Z,1645067713.125 [lineCaptureHoming:Science:HighestOilPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal.
2022-02-17T03:15:13.176Z,1645067713.176 [lineCaptureHoming:Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2022-02-17T03:15:13.240Z,1645067713.240 [lineCaptureHoming:Science:PeakDetectSalinity:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2022-02-17T03:15:13.295Z,1645067713.295 [lineCaptureHoming:Science:HighestSaltPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal.
2022-02-17T03:15:13.327Z,1645067713.327 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/StandardEnvelopes.xml
2022-02-17T03:15:13.401Z,1645067713.401 [MissionManager](INFO): DefineArg lineCaptureHoming:StandardEnvelopes.MinAltitude = 5.000000 m
2022-02-17T03:15:13.417Z,1645067713.417 [MissionManager](INFO): DefineArg lineCaptureHoming:StandardEnvelopes.MaxDepth = 200.000000 m
2022-02-17T03:15:13.424Z,1645067713.424 [MissionManager](INFO): DefineArg lineCaptureHoming:StandardEnvelopes.MinOffshore = 2000.000000 m
2022-02-17T03:15:13.425Z,1645067713.425 [lineCaptureHoming:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Construct AltitudeEnvelope.
2022-02-17T03:15:13.451Z,1645067713.451 [lineCaptureHoming:StandardEnvelopes:B.DepthEnvelope](DEBUG): Construct DepthEnvelope.
2022-02-17T03:15:13.481Z,1645067713.481 [lineCaptureHoming:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Construct OffshoreEnvelope.
2022-02-17T03:15:13.510Z,1645067713.510 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/NeedComms.xml
2022-02-17T03:15:13.677Z,1645067713.677 [MissionManager](INFO): DefineArg lineCaptureHoming:NeedComms.DiveInterval = 3.000000 h
2022-02-17T03:15:13.688Z,1645067713.688 [MissionManager](INFO): DefineArg lineCaptureHoming:NeedComms.WaitForPitchUp = 10.000000 min
2022-02-17T03:15:13.691Z,1645067713.691 [MissionManager](INFO): DefineArg lineCaptureHoming:NeedComms.SurfacePitch = 20.000000 arcdeg
2022-02-17T03:15:13.698Z,1645067713.698 [MissionManager](INFO): DefineArg lineCaptureHoming:NeedComms.SurfaceDepthRate = nan m/s
2022-02-17T03:15:13.702Z,1645067713.702 [MissionManager](INFO): DefineArg lineCaptureHoming:NeedComms.SurfaceSpeed = 1.000000 m/s
2022-02-17T03:15:13.722Z,1645067713.722 [MissionManager](INFO): DefineArg lineCaptureHoming:NeedComms.GPSTimeout = 7.000000 min
2022-02-17T03:15:13.725Z,1645067713.725 [MissionManager](INFO): DefineArg lineCaptureHoming:NeedComms.CommsTimeout = 30.000000 min
2022-02-17T03:15:13.752Z,1645067713.752 [lineCaptureHoming:NeedComms:B.GoToSurface](DEBUG): Construct GoToSurface.
2022-02-17T03:15:13.808Z,1645067713.808 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/MicromodemComms.xml
2022-02-17T03:15:13.851Z,1645067713.851 [MissionManager](INFO): DefineArg lineCaptureHoming:MicromodemComms.Timeout = 10.000000 min
2022-02-17T03:15:13.859Z,1645067713.859 [MissionManager](INFO): DefineArg lineCaptureHoming:MicromodemComms.CommsInterval = 5.000000 min
2022-02-17T03:15:13.881Z,1645067713.881 [MissionManager](INFO): RedefineArg lineCaptureHoming:MicromodemComms.CommsInterval = reader:lineCaptureHoming.MicromodemCommsInterval
2022-02-17T03:15:13.881Z,1645067713.881 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/LineCapture.xml
2022-02-17T03:15:14.356Z,1645067714.356 [MissionManager](INFO): DefineArg lineCaptureHoming:LineCapture.DockLat = 36.803400 arcdeg
2022-02-17T03:15:14.359Z,1645067714.359 [MissionManager](INFO): DefineArg lineCaptureHoming:LineCapture.DockLon = -121.822300 arcdeg
2022-02-17T03:15:14.367Z,1645067714.367 [MissionManager](INFO): DefineArg lineCaptureHoming:LineCapture.DetachTimeout = 30.000000 min
2022-02-17T03:15:14.371Z,1645067714.371 [MissionManager](INFO): DefineArg lineCaptureHoming:LineCapture.MidcourseDepth = 6.000000 m
2022-02-17T03:15:14.385Z,1645067714.385 [MissionManager](INFO): DefineArg lineCaptureHoming:LineCapture.MidcourseSpeed = 1.000000 m/s
2022-02-17T03:15:14.389Z,1645067714.389 [MissionManager](INFO): DefineArg lineCaptureHoming:LineCapture.MidcourseTimeout = 6.000000 h
2022-02-17T03:15:14.393Z,1645067714.393 [MissionManager](INFO): DefineArg lineCaptureHoming:LineCapture.TerminalRange = 650.000000 m
2022-02-17T03:15:14.405Z,1645067714.405 [MissionManager](INFO): DefineArg lineCaptureHoming:LineCapture.AcousticTimeout = 5.000000 min
2022-02-17T03:15:14.444Z,1645067714.444 [MissionManager](INFO): DefineArg lineCaptureHoming:LineCapture.losRateIIRFilterDecay = 0.000000 n/a
2022-02-17T03:15:14.456Z,1645067714.456 [MissionManager](INFO): DefineArg lineCaptureHoming:LineCapture.SearchTimeout = 1.000000 h
2022-02-17T03:15:14.460Z,1645067714.460 [MissionManager](INFO): DefineArg lineCaptureHoming:LineCapture.CircleRadius = 25.000000 m
2022-02-17T03:15:14.463Z,1645067714.463 [MissionManager](INFO): DefineArg lineCaptureHoming:LineCapture.CircleMaxError = 1.000000 m
2022-02-17T03:15:14.470Z,1645067714.470 [MissionManager](INFO): DefineArg lineCaptureHoming:LineCapture.CircleTurnToPort = 0 bool
2022-02-17T03:15:14.473Z,1645067714.473 [MissionManager](INFO): DefineArg lineCaptureHoming:LineCapture.DepthDeadband = 0.010000 m
2022-02-17T03:15:14.496Z,1645067714.496 [MissionManager](INFO): DefineArg lineCaptureHoming:LineCapture.RudderDeadband = 0.001000 arcdeg
2022-02-17T03:15:14.499Z,1645067714.499 [MissionManager](INFO): DefineArg lineCaptureHoming:LineCapture.MinAltitude = 2.000000 m
2022-02-17T03:15:14.516Z,1645067714.516 [MissionManager](INFO): DefineArg lineCaptureHoming:LineCapture.MaxDepth = 8.000000 m
2022-02-17T03:15:14.519Z,1645067714.519 [MissionManager](INFO): DefineArg lineCaptureHoming:LineCapture.MinOffshore = 1.000000 m
2022-02-17T03:15:14.531Z,1645067714.531 [MissionManager](INFO): DefineArg lineCaptureHoming:LineCapture.DockingAltitude = nan m
2022-02-17T03:15:14.541Z,1645067714.541 [MissionManager](INFO): DefineArg lineCaptureHoming:LineCapture.InvalidAltitudeTimeout = nan min
2022-02-17T03:15:14.545Z,1645067714.545 [MissionManager](INFO): DefineArg lineCaptureHoming:LineCapture.AltitudeDepthLimit = nan m
2022-02-17T03:15:14.552Z,1645067714.552 [MissionManager](INFO): DefineOutput lineCaptureHoming:LineCapture.DoneTimeout = -1.000000 count
2022-02-17T03:15:14.555Z,1645067714.555 [MissionManager](INFO): DefineOutput lineCaptureHoming:LineCapture.Done = 0.000000 count
2022-02-17T03:15:14.571Z,1645067714.571 [MissionManager](INFO): DefineOutput lineCaptureHoming:LineCapture.DetachFromDock = 1.000000 count
2022-02-17T03:15:14.574Z,1645067714.574 [MissionManager](INFO): DefineOutput lineCaptureHoming:LineCapture.Midcourse = 2.000000 count
2022-02-17T03:15:14.586Z,1645067714.586 [MissionManager](INFO): DefineOutput lineCaptureHoming:LineCapture.Terminal = 3.000000 count
2022-02-17T03:15:14.601Z,1645067714.601 [MissionManager](INFO): DefineOutput lineCaptureHoming:LineCapture.GuidanceMode = 1.000000 count
2022-02-17T03:15:14.606Z,1645067714.606 [MissionManager](INFO): DefineOutput lineCaptureHoming:LineCapture.DockingDepth = 1.000000 m
2022-02-17T03:15:14.609Z,1645067714.609 [MissionManager](INFO): DefineArg lineCaptureHoming:LineCapture.ElapsedRange = 0.000000 min
2022-02-17T03:15:14.613Z,1645067714.613 [MissionManager](INFO): DefineArg lineCaptureHoming:LineCapture.Range = nan m
2022-02-17T03:15:14.638Z,1645067714.638 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/StandardEnvelopes.xml
2022-02-17T03:15:14.682Z,1645067714.682 [MissionManager](INFO): DefineArg lineCaptureHoming:LineCapture:StandardEnvelopes.MinAltitude = 5.000000 m
2022-02-17T03:15:14.694Z,1645067714.694 [MissionManager](INFO): DefineArg lineCaptureHoming:LineCapture:StandardEnvelopes.MaxDepth = 200.000000 m
2022-02-17T03:15:14.698Z,1645067714.698 [MissionManager](INFO): DefineArg lineCaptureHoming:LineCapture:StandardEnvelopes.MinOffshore = 2000.000000 m
2022-02-17T03:15:14.699Z,1645067714.699 [lineCaptureHoming:LineCapture:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Construct AltitudeEnvelope.
2022-02-17T03:15:14.719Z,1645067714.719 [lineCaptureHoming:LineCapture:StandardEnvelopes:B.DepthEnvelope](DEBUG): Construct DepthEnvelope.
2022-02-17T03:15:14.739Z,1645067714.739 [lineCaptureHoming:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Construct OffshoreEnvelope.
2022-02-17T03:15:14.802Z,1645067714.802 [lineCaptureHoming:LineCapture:HoldMassAndBuoyancy:B.Mass](DEBUG): Construct.
2022-02-17T03:15:14.807Z,1645067714.807 [lineCaptureHoming:LineCapture:HoldMassAndBuoyancy:C.Buoyancy](DEBUG): Construct Buoyancy.
2022-02-17T03:15:14.856Z,1645067714.856 [lineCaptureHoming:LineCapture:HomingSequence:DetachFromDock:guide:A.Undock](DEBUG): Construct.
2022-02-17T03:15:14.856Z,1645067714.856 [lineCaptureHoming:LineCapture:HomingSequence:DetachFromDock:guide:A.Undock](DEBUG): Initializing internal variables to default values.
2022-02-17T03:15:14.919Z,1645067714.919 [lineCaptureHoming:LineCapture:HomingSequence:MidcourseGuidance:guide:C.SetSpeed](DEBUG): Construct.
2022-02-17T03:15:14.935Z,1645067714.935 [lineCaptureHoming:LineCapture:HomingSequence:MidcourseGuidance:guide:D.Pitch](DEBUG): Construct.
2022-02-17T03:15:14.949Z,1645067714.949 [lineCaptureHoming:LineCapture:HomingSequence:MidcourseGuidance:guide:E.Waypoint](DEBUG): Construct Waypoint.
2022-02-17T03:15:14.983Z,1645067714.983 [lineCaptureHoming:LineCapture:HomingSequence:MidcourseGuidance:guide:SearchPattern:A.Circle](DEBUG): Construct.
2022-02-17T03:15:15.006Z,1645067715.006 [lineCaptureHoming:LineCapture:HomingSequence:MidcourseGuidance:guide:SearchPattern:B.Wait](DEBUG): Construct Wait.
2022-02-17T03:15:15.037Z,1645067715.037 [lineCaptureHoming:LineCapture:HomingSequence:TerminalGuidance:guide:altitudeControl:A.AltitudeServo](DEBUG): Construct.
2022-02-17T03:15:15.052Z,1645067715.052 [lineCaptureHoming:LineCapture:HomingSequence:TerminalGuidance:guide:depthControl:A.Pitch](DEBUG): Construct.
2022-02-17T03:15:15.093Z,1645067715.093 [lineCaptureHoming:LineCapture:HomingSequence:TerminalGuidance:guide:G.LineCapture](DEBUG): Construct.
2022-02-17T03:15:15.171Z,1645067715.171 [lineCaptureHoming:LineCapture:HomingSequence:TerminalGuidance:guide:G.LineCapture](DEBUG): Initializing internal variables to default values.
2022-02-17T03:15:15.179Z,1645067715.179 [lineCaptureHoming:LineCapture:K.Wait](DEBUG): Construct Wait.
2022-02-17T03:15:15.203Z,1645067715.203 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/SetNavAcoustic.xml
2022-02-17T03:15:15.283Z,1645067715.283 [MissionManager](INFO): DefineArg lineCaptureHoming:SetNavAcoustic.DockLat = 36.803400 arcdeg
2022-02-17T03:15:15.295Z,1645067715.295 [MissionManager](INFO): DefineArg lineCaptureHoming:SetNavAcoustic.DockLon = -121.822300 arcdeg
2022-02-17T03:15:15.303Z,1645067715.303 [MissionManager](INFO): DefineArg lineCaptureHoming:SetNavAcoustic.DockRange = 5.000000 m
2022-02-17T03:15:15.327Z,1645067715.327 [MissionManager](INFO): DefineArg lineCaptureHoming:SetNavAcoustic.RangeTimeout = 5.000000 min
2022-02-17T03:15:15.358Z,1645067715.358 [lineCaptureHoming:SetNavAcoustic:UpdateNav:B.SetNav](DEBUG): Construct SetNav.
2022-02-17T03:15:15.734Z,1645067715.734 [lineCaptureHoming:Lap:Docked:Docked.Docked](DEBUG): Construct.
2022-02-17T03:15:15.734Z,1645067715.734 [lineCaptureHoming:Lap:Docked:Docked.Docked](DEBUG): Initializing internal variables to default values.
2022-02-17T03:15:15.767Z,1645067715.767 [lineCaptureHoming:Lap:Docked:Detach:Undock.Undock](DEBUG): Construct.
2022-02-17T03:15:15.767Z,1645067715.767 [lineCaptureHoming:Lap:Docked:Detach:Undock.Undock](DEBUG): Initializing internal variables to default values.
2022-02-17T03:15:15.910Z,1645067715.910 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns="Tethys"
    xmlns:Estimation="Tethys/Estimation"
    xmlns:Guidance="Tethys/Guidance"
    xmlns:Units="Tethys/Units"
    xmlns:Dock="Tethys/Dock"
    xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
    xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                        Tethys/Dock http://okeanids.mbari.org/tethys/Xml/Dock.xsd
                        Tethys/Estimation http://okeanids.mbari.org/tethys/Xml/Estimation.xsd
                        Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                        Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd"
    Id="lineCaptureHoming">

    <Description>
        Home to transponder while maintaining altitude or depth. Altitude gets
        priority if non nan. 
        The mission sequence:
        (*) Start (1) Midcourse guidance: nav to target WP while querying
        transponder (2) Terminal guidance: home to target using DUSBL tracking
        data (4) Dock: final approach using fixed heading.
    </Description>

<!-- Define mission arguments -->

    <DefineArg Name="MissionTimeout"><Description>
        Maximum length of mission
    </Description><Units:hour/><Value>4</Value></DefineArg>

    <DefineArg Name="NeedCommsTime"><Description>
        How often to surface for commumications
    </Description><Units:minute/><Value>240</Value></DefineArg>

    <DefineArg Name="MicromodemCommsInterval"><Description>
        How often to trigger Umodem communications
    </Description><Units:minute/><Value>5</Value></DefineArg>

    <DefineArg Name="Repeat"><Description>
        Number of times the vehicle should try to cycle through the homing
        sequence.
    </Description><Units:count/><Value>1</Value></DefineArg>

    <DefineArg Name="WaitOnDockTimeout"><Description>
        Time duration to wait on the dock after a successful line capture.
    </Description><Units:minute/><Value>5</Value></DefineArg>

    <DefineArg Name="TransponderCode"><Description>
        Transponder Address.
    </Description><Dock:Dock.transponderCode/></DefineArg>

    <DefineArg Name="TrackingUpdatePeriodMidcourse"><Description>
        How long to wait between acoustic queries.
    </Description><Units:second/><Value>60</Value></DefineArg>

    <DefineArg Name="TrackingUpdatePeriodTerminal"><Description>
        How long to wait between acoustic queries.
    </Description><Units:second/><Value>2.5</Value></DefineArg>

    <DefineArg Name="TrackingNumFixesLowPassFilter"><Description>
        Median filter bin size. Filters the contact estimated lat/lon position.
        Prefer odd number, set to 1 to disable filter.
    </Description><Units:count/><Value>5</Value></DefineArg>

    <DefineArg Name="NumberOfPings"><Description>
        Number of pings requested each time.
    </Description><Units:count/><Value>1</Value></DefineArg>

    <DefineArg Name="NumPingsUSBL"><Description>
        Number of pings requested while in USBL mode range.
    </Description><Units:count/><Value>5</Value></DefineArg>

    <DefineArg Name="RangeUSBL"><Description>
        USBL mode range.
    </Description><Units:meter/><Value>40</Value></DefineArg>

    <DefineArg Name="DockingAltitude"><Description>
        Docking altitude. Ignored when NaN and used over depth when a valid altitude is set.
    </Description><Units:meter/><Value>NaN</Value></DefineArg> 

    <DefineArg Name="InvalidAltitudeTimeout"><Description>
        The mission will use the last good depth command if no valid altitude readings are received within
        this specified time duration. 
    </Description><Units:minute/><Value>NaN</Value></DefineArg>    
 
    <DefineArg Name="AltitudeDepthLimit"><Description>
        Vehicle will not be commanded deeper than this regardless of altitude command.
    </Description><Units:meter/><Value>NaN</Value></DefineArg>   
    
    <DefineArg Name="MinAltitude"><Description>
        Minimum height above the sea floor for the entire mission.
    </Description><Units:meter/><Value>5</Value></DefineArg>

    <DefineArg Name="MaxDepth"><Description>
        Maximum depth for the entire mission.
    </Description><Units:meter/><Value>205</Value></DefineArg>

    <DefineArg Name="MinOffshore"><Description>
        Minimum offshore distance for the entire mission.
    </Description><Units:kilometer/><Value>2</Value></DefineArg>

<!-- Mission Variables (don't change) -->

    <DefineOutput Name="Mode"><Description>
        Mission variable (don't change). The mission sets this variable to
        reflect the termination status of the LineCapture insert.
    </Description><Units:count/><Value>-1</Value></DefineOutput>

    <DefineOutput Name="NumPings"><Description>
        Mission variable (don't change). The mission sets this variable to
        update the requested ping number and enter usbl mode.
    </Description><Units:count/><Value>1</Value></DefineOutput>

    <DefineArg Name="TrackingPeriod"><Description>
        Mission variable (don't change). The mission sets this variable to
        update the how long to wait between acoustic queries.
    </Description><Units:second/><Value>60</Value></DefineArg>

<!-- Mission timeout -->

    <Timeout Duration="MissionTimeout"/>

    <Insert Filename="Insert/Science.xml">
        <Description>
            Most missions will run the science sensors. If you don't place this
            aggregate above NeedComms, science instruments get turned off on the
            last upcast and while floating on the surface.
        </Description>
    </Insert>

<!-- Safety nets and surfacing behaviors -->

    <Insert Filename="Insert/StandardEnvelopes.xml"/>

    <Assign><Sequence/><Arg Name="StandardEnvelopes:MinAltitude"/><Arg Name="MinAltitude"/></Assign>

    <Assign><Sequence/><Arg Name="StandardEnvelopes:MaxDepth"/><Arg Name="MaxDepth"/></Assign>

    <Assign><Sequence/><Arg Name="StandardEnvelopes:MinOffshore"/><Arg Name="MinOffshore"/></Assign>

    <Insert Filename="Insert/NeedComms.xml" Id="NeedComms"/>

    <Assign><Sequence/><Arg Name="NeedComms:DiveInterval"/><Arg Name="NeedCommsTime"/></Assign>

    <Assign><Sequence/><Arg Name="NeedComms:WaitForPitchUp"/><Units:minute/><Value>0</Value></Assign>

<!-- Micromodem comms -->

    <Insert Filename="Insert/MicromodemComms.xml" Id="MicromodemComms">
        <RedefineArg Name="CommsInterval"><Arg Name="MicromodemCommsInterval"/></RedefineArg>
    </Insert>


<!-- Add LineCapture directives. -->

    <Insert Filename="Insert/LineCapture.xml"/>

    <Assign><Sequence/><Arg Name="LineCapture:MaxDepth"/><Arg Name="MaxDepth"/></Assign>

    <Assign><Sequence/><Arg Name="LineCapture:MinOffshore"/><Arg Name="MinOffshore"/></Assign>

    <Assign><Sequence/><Arg Name="LineCapture:MinAltitude"/><Arg Name="MinAltitude"/></Assign>
    
    <Assign><Sequence/><Arg Name="LineCapture:DockingAltitude"/><Arg Name="DockingAltitude"/></Assign>

<!-- Add SetNav directives. -->

    <Insert Filename="Insert/SetNavAcoustic.xml"/>

<!-- Add track acoustic contact directive. -->

    <Assign><Sequence/><Arg Name="NumPings"/><Arg Name="NumberOfPings"/></Assign>

    <Estimation:TrackAcousticContact Id="TrackAC">
        <Parallel/>
        <Setting><Estimation:TrackAcousticContact.contactLabelSetting/><Arg Name="TransponderCode"/></Setting>
        <Setting><Estimation:TrackAcousticContact.numberOfSamplesSetting/><Arg Name="NumPings"/></Setting>
        <Setting><Estimation:TrackAcousticContact.updatePeriodSetting/><Arg Name="TrackingPeriod"/></Setting>
        <Setting><Estimation:TrackAcousticContact.numFixesLowPassSetting/><Arg Name="TrackingNumFixesLowPassFilter"/></Setting>
    </Estimation:TrackAcousticContact>

<!-- Add USBL mode directives. -->

    <Aggregate Id="UpdateNumPings_NotTerminal">

        <While>
            <Not><Arg Name="LineCapture:GuidanceMode"/><Eq><Arg Name="LineCapture:Terminal"/></Eq></Not>
            <And><Not><Arg Name="NumPings"/><Eq><Arg Name="NumberOfPings"/></Eq></Not></And>
        </While>

        <Syslog Severity="Info">No longer in Terminal. Resuming normal ranging with <Arg Name="NumberOfPings"/><Units:count/>pings.</Syslog>

        <Assign><Sequence/><Arg Name="NumPings"/><Arg Name="NumberOfPings"/></Assign>

    </Aggregate>


    <Aggregate Id="UpdateNumPings_Terminal">

        <While>
            <Arg Name="LineCapture:GuidanceMode"/><Eq><Arg Name="LineCapture:Terminal"/></Eq>
        </While>

        <Aggregate Id="UpdateNumPingsUSBL">

            <When>
                <Not><Arg Name="NumPings"/><Eq><Arg Name="NumPingsUSBL"/></Eq></Not>
                <And>
                    <Arg Name="LineCapture:Range"/><Lt><Arg Name="RangeUSBL"/></Lt>
                    <And><Not><Guidance:LineCapture.guidanceMode/><Eq><Units:count/><Value>4</Value></Eq></Not></And> <!-- don't enter USBL mode during rollout -->
                </And>
            </When>

            <Syslog Severity="Info">Entering USBL mode with <Arg Name="NumPingsUSBL"/><Units:count/>pings at <Arg Name="LineCapture:Range"/><Units:meter/>(mode <Guidance:LineCapture.guidanceMode/><Units:count/>).</Syslog>

            <Assign><Sequence/><Arg Name="NumPings"/><Arg Name="NumPingsUSBL"/></Assign>

        </Aggregate>

        <Aggregate Id="UpdateNumPingsATR">

            <When>
                <Not><Arg Name="NumPings"/><Eq><Arg Name="NumberOfPings"/></Eq></Not>
                 <And>
                     <Arg Name="LineCapture:Range"/><Ge><Arg Name="RangeUSBL"/></Ge>
                     <Or><Guidance:LineCapture.guidanceMode/><Eq><Units:count/><Value>4</Value></Eq></Or> <!-- do ATR mode during rollout -->
                </And>
            </When>

            <Syslog Severity="Info">Resuming normal ranging with <Arg Name="NumberOfPings"/><Units:count/>pings <Arg Name="LineCapture:Range"/><Units:meter/>(mode <Guidance:LineCapture.guidanceMode/><Units:count/>).</Syslog>

            <Assign><Sequence/><Arg Name="NumPings"/><Arg Name="NumberOfPings"/></Assign>

        </Aggregate>
    </Aggregate>


    <Aggregate Id="UpdatePingUpdateRate_Midcourse">

        <When>
            <Not><Arg Name="TrackingPeriod"/><Eq><Arg Name="TrackingUpdatePeriodMidcourse"/></Eq></Not>
            <And>
                <Arg Name="LineCapture:Range"/><Gt><Arg Name="LineCapture:TerminalRange"/></Gt>
                <Or><Guidance:LineCapture.guidanceMode/><Eq><Units:count/><Value>4</Value></Eq></Or> <!-- do slow ping mode during rollout -->
            </And>
        </When>

        <Syslog Severity="Info">Entering Midcourse tracking update period <Arg Name="TrackingUpdatePeriodMidcourse"/><Units:second/>sec at<Arg Name="LineCapture:Range"/><Units:meter/>(mode <Guidance:LineCapture.guidanceMode/><Units:count/>).</Syslog>

        <Assign><Sequence/><Arg Name="TrackingPeriod"/><Arg Name="TrackingUpdatePeriodMidcourse"/></Assign>

    </Aggregate>

    <Aggregate Id="UpdatePingUpdateRate_Terminal">

        <When>
            <Not><Arg Name="TrackingPeriod"/><Eq><Arg Name="TrackingUpdatePeriodTerminal"/></Eq></Not>
            <And>
                <Arg Name="LineCapture:Range"/><Le><Arg Name="LineCapture:TerminalRange"/></Le>
                <And><Not><Guidance:LineCapture.guidanceMode/><Eq><Units:count/><Value>4</Value></Eq></Not></And> <!-- don't enter fast ping mode during rollout -->
            </And>
        </When>

        <Syslog Severity="Info">Entering Terminal tracking update period <Arg Name="TrackingUpdatePeriodTerminal"/><Units:second/>sec at<Arg Name="LineCapture:Range"/><Units:meter/>(mode <Guidance:LineCapture.guidanceMode/><Units:count/>).</Syslog>

        <Assign><Sequence/><Arg Name="TrackingPeriod"/><Arg Name="TrackingUpdatePeriodTerminal"/></Assign>

    </Aggregate>

<!-- Start mission sequence. -->

    <Aggregate Id="Lap">

        <Sequence Repeat="Repeat"/>

        <Assign><Sequence/><Arg Name="Mode"/><Units:count/><Value>-99</Value></Assign>

<!-- Execute the LineCapture sequence. -->

        <Call RefId="LineCapture"/>

        <Assign><Sequence/><Arg Name="Mode"/><Arg Name="LineCapture:GuidanceMode"/></Assign>

        <Syslog Severity="Info">Mode<Arg Name="Mode"/><Units:count/></Syslog>

        <Aggregate Id="Docked">

            <Sequence/>

            <Break><Arg Name="Mode"/>
                <Lt><Units:count/><Value>0</Value></Lt>
            </Break>

            <Syslog Severity="Info">Waiting on dock for <Arg Name="WaitOnDockTimeout"/><Units:minute/></Syslog>

            <Guidance:Docked Id="Docked">
                <Sequence/>
                <Timeout Duration="WaitOnDockTimeout"/>
            </Guidance:Docked>

            <Aggregate Id="Detach">

                <Sequence/>

                <Syslog Severity="Important">Breaking off. Range: <Estimation:TrackAcousticContact.range_to_contact/><Units:meter/>.</Syslog>

                <Guidance:Undock Id="Undock">
                    <Sequence/>
                </Guidance:Undock>

            </Aggregate>

        </Aggregate>

    </Aggregate>

</Mission>


2022-02-17T03:15:15.918Z,1645067715.918 [CommandExec](IMPORTANT): Running ./Missions/Engineering/lineCaptureHoming.xml
2022-02-17T03:15:16.078Z,1645067716.078 [Default] Stopped
2022-02-17T03:15:16.078Z,1645067716.078 [Default](DEBUG): Aggregate::uninitialize Default
2022-02-17T03:15:16.078Z,1645067716.078 [Default:B.GoToSurface] Stopped
2022-02-17T03:15:16.078Z,1645067716.078 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2022-02-17T03:15:16.078Z,1645067716.078 [Default:CheckIn] Stopped
2022-02-17T03:15:16.079Z,1645067716.079 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2022-02-17T03:15:16.079Z,1645067716.079 [Default:CheckIn:Read_GPS] Stopped
2022-02-17T03:15:16.079Z,1645067716.079 [MissionManager](IMPORTANT): Started mission lineCaptureHoming
2022-02-17T03:15:16.079Z,1645067716.079 [lineCaptureHoming] Running Loop=1
2022-02-17T03:15:16.079Z,1645067716.079 [lineCaptureHoming](DEBUG): Aggregate::initialize lineCaptureHoming
2022-02-17T03:15:16.079Z,1645067716.079 [lineCaptureHoming:Science] Running Loop=1
2022-02-17T03:15:16.079Z,1645067716.079 [lineCaptureHoming:Science](DEBUG): Aggregate::initialize lineCaptureHoming:Science
2022-02-17T03:15:16.079Z,1645067716.079 [lineCaptureHoming:Science:A] Running Loop=1
2022-02-17T03:15:16.084Z,1645067716.084 [lineCaptureHoming:Science:B] Running Loop=1
2022-02-17T03:15:16.084Z,1645067716.084 [lineCaptureHoming:Science:C] Running Loop=1
2022-02-17T03:15:16.084Z,1645067716.084 [lineCaptureHoming:Science:D] Running Loop=1
2022-02-17T03:15:16.084Z,1645067716.084 [lineCaptureHoming:Science:E] Running Loop=1
2022-02-17T03:15:16.084Z,1645067716.084 [lineCaptureHoming:Science:F] Running Loop=1
2022-02-17T03:15:16.084Z,1645067716.084 [lineCaptureHoming:Science:Read_Oil] Running Loop=1
2022-02-17T03:15:16.084Z,1645067716.084 [lineCaptureHoming:Science:PeakDetectChl] Running Loop=1
2022-02-17T03:15:16.084Z,1645067716.084 [lineCaptureHoming:Science:PeakDetectChl](DEBUG): Aggregate::initialize lineCaptureHoming:Science:PeakDetectChl
2022-02-17T03:15:16.084Z,1645067716.084 [lineCaptureHoming:Science:PeakDetectChl:A.PeakDetectVsDepth] Running Loop=1
2022-02-17T03:15:16.084Z,1645067716.084 [lineCaptureHoming:Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Initialize.
2022-02-17T03:15:16.087Z,1645067716.087 [lineCaptureHoming:Science:HighestChlPeakReport] Running Loop=1
2022-02-17T03:15:16.087Z,1645067716.087 [lineCaptureHoming:Science:HighestChlPeakReport](DEBUG): Aggregate::initialize lineCaptureHoming:Science:HighestChlPeakReport
2022-02-17T03:15:16.087Z,1645067716.087 [lineCaptureHoming:Science:HighestChlPeakReport:A.PeakDetectHorizontal] Running Loop=1
2022-02-17T03:15:16.087Z,1645067716.087 [lineCaptureHoming:Science:HighestChlPeakReport:A.PeakDetectHorizontal](INFO): Initialize.
2022-02-17T03:15:16.087Z,1645067716.087 [lineCaptureHoming:Science:PeakDetectNO3] Running Loop=1
2022-02-17T03:15:16.087Z,1645067716.087 [lineCaptureHoming:Science:PeakDetectNO3](DEBUG): Aggregate::initialize lineCaptureHoming:Science:PeakDetectNO3
2022-02-17T03:15:16.100Z,1645067716.100 [lineCaptureHoming:Science:PeakDetectNO3:A.PeakDetectVsDepth] Running Loop=1
2022-02-17T03:15:16.100Z,1645067716.100 [lineCaptureHoming:Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Initialize.
2022-02-17T03:15:16.102Z,1645067716.102 [lineCaptureHoming:Science:PeakDetectOil] Running Loop=1
2022-02-17T03:15:16.102Z,1645067716.102 [lineCaptureHoming:Science:PeakDetectOil](DEBUG): Aggregate::initialize lineCaptureHoming:Science:PeakDetectOil
2022-02-17T03:15:16.102Z,1645067716.102 [lineCaptureHoming:Science:PeakDetectOil:A.PeakDetectVsDepth] Running Loop=1
2022-02-17T03:15:16.102Z,1645067716.102 [lineCaptureHoming:Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Initialize.
2022-02-17T03:15:16.109Z,1645067716.109 [lineCaptureHoming:Science:HighestOilPeakReport] Running Loop=1
2022-02-17T03:15:16.109Z,1645067716.109 [lineCaptureHoming:Science:HighestOilPeakReport](DEBUG): Aggregate::initialize lineCaptureHoming:Science:HighestOilPeakReport
2022-02-17T03:15:16.109Z,1645067716.109 [lineCaptureHoming:Science:HighestOilPeakReport:A.PeakDetectHorizontal] Running Loop=1
2022-02-17T03:15:16.109Z,1645067716.109 [lineCaptureHoming:Science:HighestOilPeakReport:A.PeakDetectHorizontal](INFO): Initialize.
2022-02-17T03:15:16.109Z,1645067716.109 [lineCaptureHoming:Science:PeakDetectFDOM] Running Loop=1
2022-02-17T03:15:16.109Z,1645067716.109 [lineCaptureHoming:Science:PeakDetectFDOM](DEBUG): Aggregate::initialize lineCaptureHoming:Science:PeakDetectFDOM
2022-02-17T03:15:16.110Z,1645067716.110 [lineCaptureHoming:Science:PeakDetectFDOM:A.PeakDetectVsDepth] Running Loop=1
2022-02-17T03:15:16.110Z,1645067716.110 [lineCaptureHoming:Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Initialize.
2022-02-17T03:15:16.113Z,1645067716.113 [lineCaptureHoming:Science:PeakDetectSalinity] Running Loop=1
2022-02-17T03:15:16.113Z,1645067716.113 [lineCaptureHoming:Science:PeakDetectSalinity](DEBUG): Aggregate::initialize lineCaptureHoming:Science:PeakDetectSalinity
2022-02-17T03:15:16.113Z,1645067716.113 [lineCaptureHoming:Science:PeakDetectSalinity:A.PeakDetectVsDepth] Running Loop=1
2022-02-17T03:15:16.113Z,1645067716.113 [lineCaptureHoming:Science:PeakDetectSalinity:A.PeakDetectVsDepth](DEBUG): Initialize.
2022-02-17T03:15:16.115Z,1645067716.115 [lineCaptureHoming:Science:HighestSaltPeakReport] Running Loop=1
2022-02-17T03:15:16.115Z,1645067716.115 [lineCaptureHoming:Science:HighestSaltPeakReport](DEBUG): Aggregate::initialize lineCaptureHoming:Science:HighestSaltPeakReport
2022-02-17T03:15:16.115Z,1645067716.115 [lineCaptureHoming:Science:HighestSaltPeakReport:A.PeakDetectHorizontal] Running Loop=1
2022-02-17T03:15:16.115Z,1645067716.115 [lineCaptureHoming:Science:HighestSaltPeakReport:A.PeakDetectHorizontal](INFO): Initialize.
2022-02-17T03:15:16.132Z,1645067716.132 [lineCaptureHoming:Science:OceanCurrent] Running Loop=1
2022-02-17T03:15:16.132Z,1645067716.132 [lineCaptureHoming:Science:OceanCurrent](DEBUG): Aggregate::initialize lineCaptureHoming:Science:OceanCurrent
2022-02-17T03:15:16.132Z,1645067716.132 [lineCaptureHoming:Science:OceanCurrent:A.] Running Loop=1
2022-02-17T03:15:16.133Z,1645067716.133 [lineCaptureHoming:Science:OceanCurrent:A.](INFO): Initializing CurrentEstimator.
2022-02-17T03:15:16.133Z,1645067716.133 [lineCaptureHoming:StandardEnvelopes] Running Loop=1
2022-02-17T03:15:16.133Z,1645067716.133 [lineCaptureHoming:StandardEnvelopes](DEBUG): Aggregate::initialize lineCaptureHoming:StandardEnvelopes
2022-02-17T03:15:16.133Z,1645067716.133 [lineCaptureHoming:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1
2022-02-17T03:15:16.133Z,1645067716.133 [lineCaptureHoming:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Initialize AltitudeEnvelopeComponent.
2022-02-17T03:15:16.133Z,1645067716.133 [lineCaptureHoming:StandardEnvelopes:B.DepthEnvelope] Running Loop=1
2022-02-17T03:15:16.133Z,1645067716.133 [lineCaptureHoming:StandardEnvelopes:B.DepthEnvelope](DEBUG): Initialize DepthEnvelopeComponent.
2022-02-17T03:15:16.134Z,1645067716.134 [lineCaptureHoming:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1
2022-02-17T03:15:16.134Z,1645067716.134 [lineCaptureHoming:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Initialize OffshoreEnvelopeComponent.
2022-02-17T03:15:16.134Z,1645067716.134 [lineCaptureHoming:MicromodemComms] Running Loop=1
2022-02-17T03:15:16.134Z,1645067716.134 [lineCaptureHoming:MicromodemComms](DEBUG): Aggregate::initialize lineCaptureHoming:MicromodemComms
2022-02-17T03:15:16.141Z,1645067716.141 [lineCaptureHoming:MicromodemComms:CheckIn] Running Loop=1
2022-02-17T03:15:16.141Z,1645067716.141 [lineCaptureHoming:MicromodemComms:CheckIn](DEBUG): Aggregate::initialize lineCaptureHoming:MicromodemComms:CheckIn
2022-02-17T03:15:16.142Z,1645067716.142 [lineCaptureHoming:MicromodemComms:CheckIn:A] Running Loop=1
2022-02-17T03:15:16.142Z,1645067716.142 [lineCaptureHoming:TrackAC.] Running Loop=1
2022-02-17T03:15:16.142Z,1645067716.142 [lineCaptureHoming:TrackAC.](INFO): Initializing TrackAcousticContact.
2022-02-17T03:15:16.142Z,1645067716.142 [lineCaptureHoming:UpdateNumPings_NotTerminal] Running Loop=1
2022-02-17T03:15:16.142Z,1645067716.142 [lineCaptureHoming:UpdateNumPings_NotTerminal](DEBUG): Aggregate::initialize lineCaptureHoming:UpdateNumPings_NotTerminal
2022-02-17T03:15:16.142Z,1645067716.142 [lineCaptureHoming:UpdateNumPings_NotTerminal:A] Running Loop=1
2022-02-17T03:15:16.142Z,1645067716.142 [lineCaptureHoming:UpdateNumPings_Terminal] Running Loop=1
2022-02-17T03:15:16.143Z,1645067716.143 [lineCaptureHoming:UpdateNumPings_Terminal](DEBUG): Aggregate::initialize lineCaptureHoming:UpdateNumPings_Terminal
2022-02-17T03:15:16.143Z,1645067716.143 [lineCaptureHoming:C] Running Loop=1
2022-02-17T03:15:16.149Z,1645067716.149 [lineCaptureHoming:UpdateNumPings_Terminal] Stopped
2022-02-17T03:15:16.149Z,1645067716.149 [lineCaptureHoming:UpdateNumPings_Terminal](DEBUG): Aggregate::uninitialize lineCaptureHoming:UpdateNumPings_Terminal
2022-02-17T03:15:16.149Z,1645067716.149 [lineCaptureHoming:UpdateNumPings_NotTerminal] Stopped
2022-02-17T03:15:16.149Z,1645067716.149 [lineCaptureHoming:UpdateNumPings_NotTerminal](DEBUG): Aggregate::uninitialize lineCaptureHoming:UpdateNumPings_NotTerminal
2022-02-17T03:15:16.149Z,1645067716.149 [lineCaptureHoming:UpdateNumPings_NotTerminal:A] Stopped
2022-02-17T03:15:16.149Z,1645067716.149 [lineCaptureHoming:TrackAC.] Running Loop=1
2022-02-17T03:15:16.150Z,1645067716.150 [lineCaptureHoming:MicromodemComms] Running Loop=1
2022-02-17T03:15:16.151Z,1645067716.151 [lineCaptureHoming:MicromodemComms:CheckIn:A](DEBUG): Initialize ReadDataComponent to sense platform_communications
2022-02-17T03:15:16.151Z,1645067716.151 [lineCaptureHoming:NeedComms] Running Loop=1
2022-02-17T03:15:16.151Z,1645067716.151 [lineCaptureHoming:NeedComms](DEBUG): Aggregate::initialize lineCaptureHoming:NeedComms
2022-02-17T03:15:16.151Z,1645067716.151 [lineCaptureHoming:NeedComms:B.GoToSurface] Running Loop=1
2022-02-17T03:15:16.151Z,1645067716.151 [lineCaptureHoming:NeedComms:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2022-02-17T03:15:16.164Z,1645067716.164 [lineCaptureHoming:NeedComms:B.GoToSurface](INFO): Received depth rate setting nan m/s.
2022-02-17T03:15:16.164Z,1645067716.164 [lineCaptureHoming:NeedComms:B.GoToSurface](INFO): Received pitch setting 19.999999 degrees.
2022-02-17T03:15:16.165Z,1645067716.165 [lineCaptureHoming:NeedComms:B.GoToSurface](INFO): Received speed setting 1.000000 m/s.
2022-02-17T03:15:16.165Z,1645067716.165 [lineCaptureHoming:NeedComms:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2022-02-17T03:15:16.165Z,1645067716.165 [lineCaptureHoming:NeedComms:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2022-02-17T03:15:16.166Z,1645067716.166 [lineCaptureHoming:NeedComms:A] Running Loop=1
2022-02-17T03:15:16.166Z,1645067716.166 [lineCaptureHoming:NeedComms:A](ERROR): data element is not active.
2022-02-17T03:15:16.167Z,1645067716.167 [lineCaptureHoming:NeedComms:A](INFO): last time_fix was: nan second since 1970/01/01T00:00:00Z 
2022-02-17T03:15:16.167Z,1645067716.167 [lineCaptureHoming:NeedComms:A] Stopped
2022-02-17T03:15:16.172Z,1645067716.172 [lineCaptureHoming:C] Stopped
2022-02-17T03:15:16.172Z,1645067716.172 [lineCaptureHoming:D] Running Loop=1
2022-02-17T03:15:16.172Z,1645067716.172 [lineCaptureHoming:StandardEnvelopes] Running Loop=1
2022-02-17T03:15:16.172Z,1645067716.172 [lineCaptureHoming:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1
2022-02-17T03:15:16.172Z,1645067716.172 [lineCaptureHoming:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active.
2022-02-17T03:15:16.173Z,1645067716.173 [lineCaptureHoming:StandardEnvelopes:B.DepthEnvelope] Running Loop=1
2022-02-17T03:15:16.173Z,1645067716.173 [lineCaptureHoming:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1
2022-02-17T03:15:16.174Z,1645067716.174 [lineCaptureHoming:Science] Running Loop=1
2022-02-17T03:15:16.175Z,1645067716.175 [lineCaptureHoming:Science:HighestSaltPeakReport] Stopped
2022-02-17T03:15:16.175Z,1645067716.175 [lineCaptureHoming:Science:HighestSaltPeakReport](DEBUG): Aggregate::uninitialize lineCaptureHoming:Science:HighestSaltPeakReport
2022-02-17T03:15:16.175Z,1645067716.175 [lineCaptureHoming:Science:HighestSaltPeakReport:A.PeakDetectHorizontal] Stopped
2022-02-17T03:15:16.175Z,1645067716.175 [lineCaptureHoming:Science:HighestSaltPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize.
2022-02-17T03:15:16.175Z,1645067716.175 [lineCaptureHoming:Science:PeakDetectSalinity] Stopped
2022-02-17T03:15:16.175Z,1645067716.175 [lineCaptureHoming:Science:PeakDetectSalinity](DEBUG): Aggregate::uninitialize lineCaptureHoming:Science:PeakDetectSalinity
2022-02-17T03:15:16.175Z,1645067716.175 [lineCaptureHoming:Science:PeakDetectSalinity:A.PeakDetectVsDepth] Stopped
2022-02-17T03:15:16.175Z,1645067716.175 [lineCaptureHoming:Science:PeakDetectSalinity:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2022-02-17T03:15:16.175Z,1645067716.175 [lineCaptureHoming:Science:PeakDetectFDOM] Stopped
2022-02-17T03:15:16.175Z,1645067716.175 [lineCaptureHoming:Science:PeakDetectFDOM](DEBUG): Aggregate::uninitialize lineCaptureHoming:Science:PeakDetectFDOM
2022-02-17T03:15:16.189Z,1645067716.189 [lineCaptureHoming:Science:PeakDetectFDOM:A.PeakDetectVsDepth] Stopped
2022-02-17T03:15:16.189Z,1645067716.189 [lineCaptureHoming:Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2022-02-17T03:15:16.189Z,1645067716.189 [lineCaptureHoming:Science:HighestOilPeakReport] Stopped
2022-02-17T03:15:16.189Z,1645067716.189 [lineCaptureHoming:Science:HighestOilPeakReport](DEBUG): Aggregate::uninitialize lineCaptureHoming:Science:HighestOilPeakReport
2022-02-17T03:15:16.189Z,1645067716.189 [lineCaptureHoming:Science:HighestOilPeakReport:A.PeakDetectHorizontal] Stopped
2022-02-17T03:15:16.189Z,1645067716.189 [lineCaptureHoming:Science:HighestOilPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize.
2022-02-17T03:15:16.189Z,1645067716.189 [lineCaptureHoming:Science:PeakDetectOil] Stopped
2022-02-17T03:15:16.189Z,1645067716.189 [lineCaptureHoming:Science:PeakDetectOil](DEBUG): Aggregate::uninitialize lineCaptureHoming:Science:PeakDetectOil
2022-02-17T03:15:16.189Z,1645067716.189 [lineCaptureHoming:Science:PeakDetectOil:A.PeakDetectVsDepth] Stopped
2022-02-17T03:15:16.189Z,1645067716.189 [lineCaptureHoming:Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2022-02-17T03:15:16.189Z,1645067716.189 [lineCaptureHoming:Science:PeakDetectNO3] Stopped
2022-02-17T03:15:16.190Z,1645067716.190 [lineCaptureHoming:Science:PeakDetectNO3](DEBUG): Aggregate::uninitialize lineCaptureHoming:Science:PeakDetectNO3
2022-02-17T03:15:16.190Z,1645067716.190 [lineCaptureHoming:Science:PeakDetectNO3:A.PeakDetectVsDepth] Stopped
2022-02-17T03:15:16.190Z,1645067716.190 [lineCaptureHoming:Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2022-02-17T03:15:16.190Z,1645067716.190 [lineCaptureHoming:Science:HighestChlPeakReport] Stopped
2022-02-17T03:15:16.190Z,1645067716.190 [lineCaptureHoming:Science:HighestChlPeakReport](DEBUG): Aggregate::uninitialize lineCaptureHoming:Science:HighestChlPeakReport
2022-02-17T03:15:16.190Z,1645067716.190 [lineCaptureHoming:Science:HighestChlPeakReport:A.PeakDetectHorizontal] Stopped
2022-02-17T03:15:16.190Z,1645067716.190 [lineCaptureHoming:Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize.
2022-02-17T03:15:16.190Z,1645067716.190 [lineCaptureHoming:Science:PeakDetectChl] Stopped
2022-02-17T03:15:16.190Z,1645067716.190 [lineCaptureHoming:Science:PeakDetectChl](DEBUG): Aggregate::uninitialize lineCaptureHoming:Science:PeakDetectChl
2022-02-17T03:15:16.190Z,1645067716.190 [lineCaptureHoming:Science:PeakDetectChl:A.PeakDetectVsDepth] Stopped
2022-02-17T03:15:16.190Z,1645067716.190 [lineCaptureHoming:Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2022-02-17T03:15:16.190Z,1645067716.190 [lineCaptureHoming:Science:OceanCurrent:A.] Running Loop=1
2022-02-17T03:15:16.191Z,1645067716.191 [lineCaptureHoming:Science:Read_Oil] Stopped
2022-02-17T03:15:16.191Z,1645067716.191 [lineCaptureHoming:Science:F] Stopped
2022-02-17T03:15:16.191Z,1645067716.191 [lineCaptureHoming:Science:E] Running Loop=1
2022-02-17T03:15:16.192Z,1645067716.192 [lineCaptureHoming:Science:E](DEBUG): Initialize ReadDataComponent to sense mass_concentration_of_chlorophyll_in_sea_water
2022-02-17T03:15:16.192Z,1645067716.192 [lineCaptureHoming:Science:D] Stopped
2022-02-17T03:15:16.192Z,1645067716.192 [lineCaptureHoming:Science:C] Running Loop=1
2022-02-17T03:15:16.193Z,1645067716.193 [lineCaptureHoming:Science:C](DEBUG): Initialize ReadDataComponent to sense CTD_Seabird.sea_water_temperature
2022-02-17T03:15:16.194Z,1645067716.194 [lineCaptureHoming:Science:C](DEBUG): Initialize ReadDataComponent to sense CTD_Seabird.sea_water_salinity
2022-02-17T03:15:16.194Z,1645067716.194 [lineCaptureHoming:Science:B] Running Loop=1
2022-02-17T03:15:16.195Z,1645067716.195 [lineCaptureHoming:Science:B](DEBUG): Initialize ReadDataComponent to sense sea_water_temperature
2022-02-17T03:15:16.195Z,1645067716.195 [lineCaptureHoming:Science:B](DEBUG): Initialize ReadDataComponent to sense sea_water_salinity
2022-02-17T03:15:16.195Z,1645067716.195 [lineCaptureHoming:Science:A] Stopped
2022-02-17T03:15:16.438Z,1645067716.438 [WetLabsBB2FL](INFO): Powering up
2022-02-17T03:15:17.069Z,1645067717.069 [lineCaptureHoming:NeedComms:C] Running Loop=1
2022-02-17T03:15:17.069Z,1645067717.069 [lineCaptureHoming:D] Stopped
2022-02-17T03:15:17.070Z,1645067717.070 [lineCaptureHoming:E] Running Loop=1
2022-02-17T03:15:17.070Z,1645067717.070 [lineCaptureHoming:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active.
2022-02-17T03:15:17.466Z,1645067717.466 [lineCaptureHoming:NeedComms:C](DEBUG): Initialize ReadDataComponent to sense time_fix
2022-02-17T03:15:17.467Z,1645067717.467 [lineCaptureHoming:E] Stopped
2022-02-17T03:15:17.467Z,1645067717.467 [lineCaptureHoming:G] Running Loop=1
2022-02-17T03:15:17.467Z,1645067717.467 [lineCaptureHoming:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active.
2022-02-17T03:15:17.858Z,1645067717.858 [lineCaptureHoming:G] Stopped
2022-02-17T03:15:17.858Z,1645067717.858 [lineCaptureHoming:H] Running Loop=1
2022-02-17T03:15:17.859Z,1645067717.859 [lineCaptureHoming:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active.
2022-02-17T03:15:18.239Z,1645067718.239 [lineCaptureHoming:H] Stopped
2022-02-17T03:15:18.239Z,1645067718.239 [lineCaptureHoming:K] Running Loop=1
2022-02-17T03:15:18.248Z,1645067718.248 [lineCaptureHoming:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active.
2022-02-17T03:15:18.249Z,1645067718.249 [lineCaptureHoming:StandardEnvelopes:A.AltitudeEnvelope](ERROR): Altitude Measurement is not Active.
2022-02-17T03:15:18.639Z,1645067718.639 [lineCaptureHoming:K] Stopped
2022-02-17T03:15:18.639Z,1645067718.639 [lineCaptureHoming:L] Running Loop=1
2022-02-17T03:15:18.648Z,1645067718.648 [lineCaptureHoming:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active.
2022-02-17T03:15:18.878Z,1645067718.878 [CTD_Seabird](ERROR): Pressure reading out of range: -10.970000 decibar
2022-02-17T03:15:19.040Z,1645067719.040 [lineCaptureHoming:L] Stopped
2022-02-17T03:15:19.040Z,1645067719.040 [lineCaptureHoming:M] Running Loop=1
2022-02-17T03:15:19.041Z,1645067719.041 [lineCaptureHoming:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active.
2022-02-17T03:15:19.445Z,1645067719.445 [lineCaptureHoming:M] Stopped
2022-02-17T03:15:19.445Z,1645067719.445 [lineCaptureHoming:N] Running Loop=1
2022-02-17T03:15:19.447Z,1645067719.447 [lineCaptureHoming:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active.
2022-02-17T03:15:19.848Z,1645067719.848 [lineCaptureHoming:N] Stopped
2022-02-17T03:15:19.848Z,1645067719.848 [lineCaptureHoming:P] Running Loop=1
2022-02-17T03:15:19.849Z,1645067719.849 [lineCaptureHoming:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active.
2022-02-17T03:15:19.883Z,1645067719.883 [CTD_Seabird](ERROR): Salinity reading out of range: 0.226420 psu
2022-02-17T03:15:20.250Z,1645067720.250 [lineCaptureHoming:P] Stopped
2022-02-17T03:15:20.250Z,1645067720.250 [lineCaptureHoming:Lap] Running Loop=1
2022-02-17T03:15:20.250Z,1645067720.250 [lineCaptureHoming:Lap](DEBUG): Aggregate::initialize lineCaptureHoming:Lap
2022-02-17T03:15:20.250Z,1645067720.250 [lineCaptureHoming:Lap:A] Running Loop=1
2022-02-17T03:15:20.276Z,1645067720.276 [lineCaptureHoming:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active.
2022-02-17T03:15:20.652Z,1645067720.652 [lineCaptureHoming:Lap:A] Stopped
2022-02-17T03:15:20.652Z,1645067720.652 [lineCaptureHoming:Lap:B] Running Loop=1
2022-02-17T03:15:20.652Z,1645067720.652 [lineCaptureHoming:Lap:B](DEBUG): Aggregate::initialize lineCaptureHoming:Lap:B
2022-02-17T03:15:20.653Z,1645067720.653 [lineCaptureHoming:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active.
2022-02-17T03:15:21.055Z,1645067721.055 [lineCaptureHoming:LineCapture] Running Loop=1
2022-02-17T03:15:21.055Z,1645067721.055 [lineCaptureHoming:LineCapture](DEBUG): Aggregate::initialize lineCaptureHoming:LineCapture
2022-02-17T03:15:21.056Z,1645067721.056 [lineCaptureHoming:LineCapture:StandardEnvelopes] Running Loop=1
2022-02-17T03:15:21.056Z,1645067721.056 [lineCaptureHoming:LineCapture:StandardEnvelopes](DEBUG): Aggregate::initialize lineCaptureHoming:LineCapture:StandardEnvelopes
2022-02-17T03:15:21.056Z,1645067721.056 [lineCaptureHoming:LineCapture:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1
2022-02-17T03:15:21.056Z,1645067721.056 [lineCaptureHoming:LineCapture:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Initialize AltitudeEnvelopeComponent.
2022-02-17T03:15:21.056Z,1645067721.056 [lineCaptureHoming:LineCapture:StandardEnvelopes:B.DepthEnvelope] Running Loop=1
2022-02-17T03:15:21.056Z,1645067721.056 [lineCaptureHoming:LineCapture:StandardEnvelopes:B.DepthEnvelope](DEBUG): Initialize DepthEnvelopeComponent.
2022-02-17T03:15:21.056Z,1645067721.056 [lineCaptureHoming:LineCapture:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1
2022-02-17T03:15:21.056Z,1645067721.056 [lineCaptureHoming:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Initialize OffshoreEnvelopeComponent.
2022-02-17T03:15:21.057Z,1645067721.057 [lineCaptureHoming:LineCapture:G] Running Loop=1
2022-02-17T03:15:21.057Z,1645067721.057 [lineCaptureHoming:LineCapture:H] Running Loop=1
2022-02-17T03:15:21.057Z,1645067721.057 [lineCaptureHoming:LineCapture:HoldMassAndBuoyancy] Running Loop=1
2022-02-17T03:15:21.057Z,1645067721.057 [lineCaptureHoming:LineCapture:HoldMassAndBuoyancy](DEBUG): Aggregate::initialize lineCaptureHoming:LineCapture:HoldMassAndBuoyancy
2022-02-17T03:15:21.057Z,1645067721.057 [lineCaptureHoming:LineCapture:HoldMassAndBuoyancy:A] Running Loop=1
2022-02-17T03:15:21.057Z,1645067721.057 [lineCaptureHoming:LineCapture:HoldMassAndBuoyancy:B.Mass] Running Loop=1
2022-02-17T03:15:21.057Z,1645067721.057 [lineCaptureHoming:LineCapture:HoldMassAndBuoyancy:B.Mass](DEBUG): Initialize.
2022-02-17T03:15:21.057Z,1645067721.057 [lineCaptureHoming:LineCapture:HoldMassAndBuoyancy:C.Buoyancy] Running Loop=1
2022-02-17T03:15:21.057Z,1645067721.057 [lineCaptureHoming:LineCapture:HoldMassAndBuoyancy:C.Buoyancy](DEBUG): Initialize Buoyancy Component.
2022-02-17T03:15:21.057Z,1645067721.057 [lineCaptureHoming:LineCapture:A] Running Loop=1
2022-02-17T03:15:21.058Z,1645067721.058 [lineCaptureHoming:LineCapture:HoldMassAndBuoyancy] Stopped
2022-02-17T03:15:21.058Z,1645067721.058 [lineCaptureHoming:LineCapture:HoldMassAndBuoyancy](DEBUG): Aggregate::uninitialize lineCaptureHoming:LineCapture:HoldMassAndBuoyancy
2022-02-17T03:15:21.058Z,1645067721.058 [lineCaptureHoming:LineCapture:HoldMassAndBuoyancy:A] Stopped
2022-02-17T03:15:21.058Z,1645067721.058 [lineCaptureHoming:LineCapture:HoldMassAndBuoyancy:B.Mass] Stopped
2022-02-17T03:15:21.058Z,1645067721.058 [lineCaptureHoming:LineCapture:HoldMassAndBuoyancy:B.Mass](DEBUG): Uninitialize.
2022-02-17T03:15:21.058Z,1645067721.058 [lineCaptureHoming:LineCapture:HoldMassAndBuoyancy:C.Buoyancy] Stopped
2022-02-17T03:15:21.058Z,1645067721.058 [lineCaptureHoming:LineCapture:HoldMassAndBuoyancy:C.Buoyancy](DEBUG): Uninitialize Buoyancy Component.
2022-02-17T03:15:21.058Z,1645067721.058 [lineCaptureHoming:LineCapture:H] Running Loop=1
2022-02-17T03:15:21.059Z,1645067721.059 [lineCaptureHoming:LineCapture:G] Running Loop=1
2022-02-17T03:15:21.059Z,1645067721.059 [lineCaptureHoming:LineCapture:StandardEnvelopes] Running Loop=1
2022-02-17T03:15:21.059Z,1645067721.059 [lineCaptureHoming:LineCapture:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1
2022-02-17T03:15:21.059Z,1645067721.059 [lineCaptureHoming:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active.
2022-02-17T03:15:21.059Z,1645067721.059 [lineCaptureHoming:LineCapture:StandardEnvelopes:B.DepthEnvelope] Running Loop=1
2022-02-17T03:15:21.059Z,1645067721.059 [lineCaptureHoming:LineCapture:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1
2022-02-17T03:15:21.064Z,1645067721.064 [lineCaptureHoming:LineCapture:A] Stopped
2022-02-17T03:15:21.064Z,1645067721.064 [lineCaptureHoming:LineCapture:B] Running Loop=1
2022-02-17T03:15:21.065Z,1645067721.065 [lineCaptureHoming:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active.
2022-02-17T03:15:21.481Z,1645067721.481 [lineCaptureHoming:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active.
2022-02-17T03:15:21.482Z,1645067721.482 [lineCaptureHoming:LineCapture:B] Stopped
2022-02-17T03:15:21.482Z,1645067721.482 [lineCaptureHoming:LineCapture:D] Running Loop=1
2022-02-17T03:15:21.483Z,1645067721.483 [lineCaptureHoming:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active.
2022-02-17T03:15:21.864Z,1645067721.864 [lineCaptureHoming:LineCapture:D] Stopped
2022-02-17T03:15:21.864Z,1645067721.864 [lineCaptureHoming:LineCapture:E] Running Loop=1
2022-02-17T03:15:21.864Z,1645067721.864 [lineCaptureHoming:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active.
2022-02-17T03:15:21.866Z,1645067721.866 [lineCaptureHoming:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active.
2022-02-17T03:15:21.890Z,1645067721.890 [CTD_Seabird](ERROR): Salinity reading out of range: 0.070750 psu
2022-02-17T03:15:22.313Z,1645067722.313 [lineCaptureHoming:LineCapture:E] Stopped
2022-02-17T03:15:22.313Z,1645067722.313 [lineCaptureHoming:LineCapture:F] Running Loop=1
2022-02-17T03:15:22.313Z,1645067722.313 [lineCaptureHoming:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active.
2022-02-17T03:15:22.315Z,1645067722.315 [lineCaptureHoming:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active.
2022-02-17T03:15:22.339Z,1645067722.339 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20220217T030122/Courier0007.lzma
2022-02-17T03:15:22.684Z,1645067722.684 [lineCaptureHoming:LineCapture:F] Stopped
2022-02-17T03:15:22.684Z,1645067722.684 [lineCaptureHoming:LineCapture:HomingSequence] Running Loop=1
2022-02-17T03:15:22.685Z,1645067722.685 [lineCaptureHoming:LineCapture:HomingSequence](DEBUG): Aggregate::initialize lineCaptureHoming:LineCapture:HomingSequence
2022-02-17T03:15:22.685Z,1645067722.685 [lineCaptureHoming:LineCapture:HomingSequence:DetachFromDock] Running Loop=1
2022-02-17T03:15:22.685Z,1645067722.685 [lineCaptureHoming:LineCapture:HomingSequence:DetachFromDock](DEBUG): Aggregate::initialize lineCaptureHoming:LineCapture:HomingSequence:DetachFromDock
2022-02-17T03:15:22.685Z,1645067722.685 [lineCaptureHoming:LineCapture:HomingSequence:DetachFromDock:guide] Running Loop=1
2022-02-17T03:15:22.685Z,1645067722.685 [lineCaptureHoming:LineCapture:HomingSequence:DetachFromDock:guide](DEBUG): Aggregate::initialize lineCaptureHoming:LineCapture:HomingSequence:DetachFromDock:guide
2022-02-17T03:15:22.685Z,1645067722.685 [lineCaptureHoming:LineCapture:HomingSequence:DetachFromDock:guide:A.Undock] Running Loop=1
2022-02-17T03:15:22.685Z,1645067722.685 [lineCaptureHoming:LineCapture:HomingSequence:DetachFromDock:guide:A.Undock](DEBUG): Initialize.
2022-02-17T03:15:22.685Z,1645067722.685 [lineCaptureHoming:LineCapture:HomingSequence:DetachFromDock:guide:A.Undock](DEBUG): Initializing internal variables to default values.
2022-02-17T03:15:22.686Z,1645067722.686 [lineCaptureHoming:LineCapture:HomingSequence:MidcourseGuidance] Running Loop=1
2022-02-17T03:15:22.686Z,1645067722.686 [lineCaptureHoming:LineCapture:HomingSequence:MidcourseGuidance](DEBUG): Aggregate::initialize lineCaptureHoming:LineCapture:HomingSequence:MidcourseGuidance
2022-02-17T03:15:22.686Z,1645067722.686 [lineCaptureHoming:LineCapture:HomingSequence:MidcourseGuidance:guide] Running Loop=1
2022-02-17T03:15:22.686Z,1645067722.686 [lineCaptureHoming:LineCapture:HomingSequence:MidcourseGuidance:guide](DEBUG): Aggregate::initialize lineCaptureHoming:LineCapture:HomingSequence:MidcourseGuidance:guide
2022-02-17T03:15:22.686Z,1645067722.686 [lineCaptureHoming:LineCapture:HomingSequence:MidcourseGuidance:guide:C.SetSpeed] Running Loop=1
2022-02-17T03:15:22.686Z,1645067722.686 [lineCaptureHoming:LineCapture:HomingSequence:MidcourseGuidance:guide:C.SetSpeed](DEBUG): Initialize.
2022-02-17T03:15:22.687Z,1645067722.687 [lineCaptureHoming:LineCapture:HomingSequence:MidcourseGuidance:guide:D.Pitch] Running Loop=1
2022-02-17T03:15:22.687Z,1645067722.687 [lineCaptureHoming:LineCapture:HomingSequence:MidcourseGuidance:guide:D.Pitch](DEBUG): Initialize.
2022-02-17T03:15:22.687Z,1645067722.687 [lineCaptureHoming:LineCapture:HomingSequence:MidcourseGuidance:guide:A] Running Loop=1
2022-02-17T03:15:22.687Z,1645067722.687 [lineCaptureHoming:LineCapture:HomingSequence:TerminalGuidance] Running Loop=1
2022-02-17T03:15:22.687Z,1645067722.687 [lineCaptureHoming:LineCapture:HomingSequence:TerminalGuidance](DEBUG): Aggregate::initialize lineCaptureHoming:LineCapture:HomingSequence:TerminalGuidance
2022-02-17T03:15:22.687Z,1645067722.687 [lineCaptureHoming:LineCapture:HomingSequence:TerminalGuidance:guide] Running Loop=1
2022-02-17T03:15:22.688Z,1645067722.688 [lineCaptureHoming:LineCapture:HomingSequence:TerminalGuidance:guide](DEBUG): Aggregate::initialize lineCaptureHoming:LineCapture:HomingSequence:TerminalGuidance:guide
2022-02-17T03:15:22.688Z,1645067722.688 [lineCaptureHoming:LineCapture:HomingSequence:TerminalGuidance:guide:altitudeControl] Running Loop=1
2022-02-17T03:15:22.688Z,1645067722.688 [lineCaptureHoming:LineCapture:HomingSequence:TerminalGuidance:guide:altitudeControl](DEBUG): Aggregate::initialize lineCaptureHoming:LineCapture:HomingSequence:TerminalGuidance:guide:altitudeControl
2022-02-17T03:15:22.688Z,1645067722.688 [lineCaptureHoming:LineCapture:HomingSequence:TerminalGuidance:guide:altitudeControl:A.AltitudeServo] Running Loop=1
2022-02-17T03:15:22.688Z,1645067722.688 [lineCaptureHoming:LineCapture:HomingSequence:TerminalGuidance:guide:altitudeControl:A.AltitudeServo](INFO): Initialize.
2022-02-17T03:15:22.689Z,1645067722.689 [lineCaptureHoming:LineCapture:HomingSequence:TerminalGuidance:guide:depthControl] Running Loop=1
2022-02-17T03:15:22.689Z,1645067722.689 [lineCaptureHoming:LineCapture:HomingSequence:TerminalGuidance:guide:depthControl](DEBUG): Aggregate::initialize lineCaptureHoming:LineCapture:HomingSequence:TerminalGuidance:guide:depthControl
2022-02-17T03:15:22.689Z,1645067722.689 [lineCaptureHoming:LineCapture:HomingSequence:TerminalGuidance:guide:depthControl:A.Pitch] Running Loop=1
2022-02-17T03:15:22.689Z,1645067722.689 [lineCaptureHoming:LineCapture:HomingSequence:TerminalGuidance:guide:depthControl:A.Pitch](DEBUG): Initialize.
2022-02-17T03:15:22.689Z,1645067722.689 [lineCaptureHoming:LineCapture:HomingSequence:TerminalGuidance:guide:E] Running Loop=1
2022-02-17T03:15:22.689Z,1645067722.689 [lineCaptureHoming:LineCapture:HomingSequence:TerminalGuidance:guide:F] Running Loop=1
2022-02-17T03:15:22.689Z,1645067722.689 [lineCaptureHoming:LineCapture:HomingSequence:TerminalGuidance:guide:A] Running Loop=1
2022-02-17T03:15:22.689Z,1645067722.689 [lineCaptureHoming:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active.
2022-02-17T03:15:22.690Z,1645067722.690 [lineCaptureHoming:LineCapture:StandardEnvelopes:A.AltitudeEnvelope](ERROR): Altitude Measurement is not Active.
2022-02-17T03:15:22.691Z,1645067722.691 [lineCaptureHoming:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active.
2022-02-17T03:15:22.894Z,1645067722.894 [CTD_Seabird](ERROR): Salinity reading out of range: 0.070697 psu
2022-02-17T03:15:23.086Z,1645067723.086 [lineCaptureHoming:LineCapture:HomingSequence:TerminalGuidance] Stopped
2022-02-17T03:15:23.086Z,1645067723.086 [lineCaptureHoming:LineCapture:HomingSequence:TerminalGuidance](DEBUG): Aggregate::uninitialize lineCaptureHoming:LineCapture:HomingSequence:TerminalGuidance
2022-02-17T03:15:23.086Z,1645067723.086 [lineCaptureHoming:LineCapture:HomingSequence:TerminalGuidance:guide] Stopped
2022-02-17T03:15:23.086Z,1645067723.086 [lineCaptureHoming:LineCapture:HomingSequence:TerminalGuidance:guide](DEBUG): Aggregate::uninitialize lineCaptureHoming:LineCapture:HomingSequence:TerminalGuidance:guide
2022-02-17T03:15:23.086Z,1645067723.086 [lineCaptureHoming:LineCapture:HomingSequence:TerminalGuidance:guide:A] Stopped
2022-02-17T03:15:23.086Z,1645067723.086 [lineCaptureHoming:LineCapture:HomingSequence:TerminalGuidance:guide:altitudeControl] Stopped
2022-02-17T03:15:23.087Z,1645067723.087 [lineCaptureHoming:LineCapture:HomingSequence:TerminalGuidance:guide:altitudeControl](DEBUG): Aggregate::uninitialize lineCaptureHoming:LineCapture:HomingSequence:TerminalGuidance:guide:altitudeControl
2022-02-17T03:15:23.087Z,1645067723.087 [lineCaptureHoming:LineCapture:HomingSequence:TerminalGuidance:guide:altitudeControl:A.AltitudeServo] Stopped
2022-02-17T03:15:23.087Z,1645067723.087 [lineCaptureHoming:LineCapture:HomingSequence:TerminalGuidance:guide:altitudeControl:A.AltitudeServo](DEBUG): Uninitialize.
2022-02-17T03:15:23.087Z,1645067723.087 [lineCaptureHoming:LineCapture:HomingSequence:TerminalGuidance:guide:depthControl] Stopped
2022-02-17T03:15:23.087Z,1645067723.087 [lineCaptureHoming:LineCapture:HomingSequence:TerminalGuidance:guide:depthControl](DEBUG): Aggregate::uninitialize lineCaptureHoming:LineCapture:HomingSequence:TerminalGuidance:guide:depthControl
2022-02-17T03:15:23.087Z,1645067723.087 [lineCaptureHoming:LineCapture:HomingSequence:TerminalGuidance:guide:depthControl:A.Pitch] Stopped
2022-02-17T03:15:23.087Z,1645067723.087 [lineCaptureHoming:LineCapture:HomingSequence:TerminalGuidance:guide:E] Stopped
2022-02-17T03:15:23.087Z,1645067723.087 [lineCaptureHoming:LineCapture:HomingSequence:TerminalGuidance:guide:F] Stopped
2022-02-17T03:15:23.087Z,1645067723.087 [lineCaptureHoming:LineCapture:HomingSequence:MidcourseGuidance] Stopped
2022-02-17T03:15:23.087Z,1645067723.087 [lineCaptureHoming:LineCapture:HomingSequence:MidcourseGuidance](DEBUG): Aggregate::uninitialize lineCaptureHoming:LineCapture:HomingSequence:MidcourseGuidance
2022-02-17T03:15:23.087Z,1645067723.087 [lineCaptureHoming:LineCapture:HomingSequence:MidcourseGuidance:guide] Stopped
2022-02-17T03:15:23.087Z,1645067723.087 [lineCaptureHoming:LineCapture:HomingSequence:MidcourseGuidance:guide](DEBUG): Aggregate::uninitialize lineCaptureHoming:LineCapture:HomingSequence:MidcourseGuidance:guide
2022-02-17T03:15:23.087Z,1645067723.087 [lineCaptureHoming:LineCapture:HomingSequence:MidcourseGuidance:guide:A] Stopped
2022-02-17T03:15:23.088Z,1645067723.088 [lineCaptureHoming:LineCapture:HomingSequence:MidcourseGuidance:guide:C.SetSpeed] Stopped
2022-02-17T03:15:23.088Z,1645067723.088 [lineCaptureHoming:LineCapture:HomingSequence:MidcourseGuidance:guide:C.SetSpeed](DEBUG): Uninitialize.
2022-02-17T03:15:23.088Z,1645067723.088 [lineCaptureHoming:LineCapture:HomingSequence:MidcourseGuidance:guide:D.Pitch] Stopped
2022-02-17T03:15:23.088Z,1645067723.088 [lineCaptureHoming:LineCapture:HomingSequence:DetachFromDock] Running Loop=1
2022-02-17T03:15:23.088Z,1645067723.088 [lineCaptureHoming:LineCapture:HomingSequence:DetachFromDock:guide:A.Undock](INFO): Docking module hardware isn't loaded, so simply satisfying DockingState request.
2022-02-17T03:15:23.089Z,1645067723.089 [lineCaptureHoming:LineCapture:HomingSequence:DetachFromDock:guide:A.Undock](INFO): Detaching from dock.
2022-02-17T03:15:23.089Z,1645067723.089 [lineCaptureHoming:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active.
2022-02-17T03:15:23.091Z,1645067723.091 [lineCaptureHoming:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active.
2022-02-17T03:15:23.342Z,1645067723.342 [DataOverHttps](INFO): Moved sent file to Logs/20220217T030122/Courier0007.lzma.bak
2022-02-17T03:15:23.342Z,1645067723.342 [DataOverHttps](INFO): SBD MOMSN=16504778
2022-02-17T03:15:23.485Z,1645067723.485 [lineCaptureHoming:LineCapture:HomingSequence:DetachFromDock:guide:A.Undock](INFO): Detected possible detachment. Starting timer.
2022-02-17T03:15:23.486Z,1645067723.486 [lineCaptureHoming:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active.
2022-02-17T03:15:23.487Z,1645067723.487 [lineCaptureHoming:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active.
2022-02-17T03:15:23.879Z,1645067723.879 [lineCaptureHoming:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active.
2022-02-17T03:15:23.881Z,1645067723.881 [lineCaptureHoming:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active.
2022-02-17T03:15:24.291Z,1645067724.291 [lineCaptureHoming:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active.
2022-02-17T03:15:24.292Z,1645067724.292 [lineCaptureHoming:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active.
2022-02-17T03:15:24.685Z,1645067724.685 [lineCaptureHoming:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active.
2022-02-17T03:15:24.687Z,1645067724.687 [lineCaptureHoming:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active.
2022-02-17T03:15:24.902Z,1645067724.902 [CTD_Seabird](ERROR): Salinity reading out of range: 0.070696 psu
2022-02-17T03:15:25.083Z,1645067725.083 [lineCaptureHoming:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active.
2022-02-17T03:15:25.085Z,1645067725.085 [lineCaptureHoming:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active.
2022-02-17T03:15:25.530Z,1645067725.530 [lineCaptureHoming:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active.
2022-02-17T03:15:25.536Z,1645067725.536 [lineCaptureHoming:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active.
2022-02-17T03:15:25.891Z,1645067725.891 [lineCaptureHoming:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active.
2022-02-17T03:15:25.906Z,1645067725.906 [CTD_Seabird](ERROR): Salinity reading out of range: 0.070696 psu
2022-02-17T03:15:25.909Z,1645067725.909 [lineCaptureHoming:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active.
2022-02-17T03:15:26.299Z,1645067726.299 [lineCaptureHoming:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active.
2022-02-17T03:15:26.301Z,1645067726.301 [lineCaptureHoming:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active.
2022-02-17T03:15:26.365Z,1645067726.365 [CommandExec](IMPORTANT): got command stop
2022-02-17T03:15:26.365Z,1645067726.365 [CommandExec](IMPORTANT): Scheduling is paused
2022-02-17T03:15:26.365Z,1645067726.365 [Supervisor](INFO): Stop Mission called by CommandExec::commandStop
2022-02-17T03:15:26.731Z,1645067726.731 [lineCaptureHoming:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active.
2022-02-17T03:15:26.737Z,1645067726.737 [lineCaptureHoming:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active.
2022-02-17T03:15:26.739Z,1645067726.739 [MissionManager](INFO): MissionManager is completed.
2022-02-17T03:15:26.739Z,1645067726.739 [MissionManager](INFO): Uninitializing Mission lineCaptureHoming
2022-02-17T03:15:26.739Z,1645067726.739 [lineCaptureHoming] Stopped
2022-02-17T03:15:26.739Z,1645067726.739 [lineCaptureHoming](DEBUG): Aggregate::uninitialize lineCaptureHoming
2022-02-17T03:15:26.744Z,1645067726.744 [lineCaptureHoming:Science] Stopped
2022-02-17T03:15:26.744Z,1645067726.744 [lineCaptureHoming:Science](DEBUG): Aggregate::uninitialize lineCaptureHoming:Science
2022-02-17T03:15:26.744Z,1645067726.744 [lineCaptureHoming:Science:B] Stopped
2022-02-17T03:15:26.744Z,1645067726.744 [lineCaptureHoming:Science:C] Stopped
2022-02-17T03:15:26.744Z,1645067726.744 [lineCaptureHoming:Science:E] Stopped
2022-02-17T03:15:26.744Z,1645067726.744 [lineCaptureHoming:Science:OceanCurrent] Stopped
2022-02-17T03:15:26.745Z,1645067726.745 [lineCaptureHoming:Science:OceanCurrent](DEBUG): Aggregate::uninitialize lineCaptureHoming:Science:OceanCurrent
2022-02-17T03:15:26.745Z,1645067726.745 [lineCaptureHoming:Science:OceanCurrent:A.] Stopped
2022-02-17T03:15:26.745Z,1645067726.745 [lineCaptureHoming:StandardEnvelopes] Stopped
2022-02-17T03:15:26.745Z,1645067726.745 [lineCaptureHoming:StandardEnvelopes](DEBUG): Aggregate::uninitialize lineCaptureHoming:StandardEnvelopes
2022-02-17T03:15:26.745Z,1645067726.745 [lineCaptureHoming:StandardEnvelopes:A.AltitudeEnvelope] Stopped
2022-02-17T03:15:26.745Z,1645067726.745 [lineCaptureHoming:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Uninitialize AltitudeEnvelopeComponent.
2022-02-17T03:15:26.745Z,1645067726.745 [lineCaptureHoming:StandardEnvelopes:B.DepthEnvelope] Stopped
2022-02-17T03:15:26.745Z,1645067726.745 [lineCaptureHoming:StandardEnvelopes:B.DepthEnvelope](DEBUG): Uninitialize.
2022-02-17T03:15:26.745Z,1645067726.745 [lineCaptureHoming:StandardEnvelopes:C.OffshoreEnvelope] Stopped
2022-02-17T03:15:26.745Z,1645067726.745 [lineCaptureHoming:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Uninitialize OffshoreEnvelopeComponent.
2022-02-17T03:15:26.745Z,1645067726.745 [lineCaptureHoming:NeedComms] Stopped
2022-02-17T03:15:26.745Z,1645067726.745 [lineCaptureHoming:NeedComms](DEBUG): Aggregate::uninitialize lineCaptureHoming:NeedComms
2022-02-17T03:15:26.746Z,1645067726.746 [lineCaptureHoming:NeedComms:B.GoToSurface] Stopped
2022-02-17T03:15:26.746Z,1645067726.746 [lineCaptureHoming:NeedComms:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2022-02-17T03:15:26.746Z,1645067726.746 [lineCaptureHoming:NeedComms:C] Stopped
2022-02-17T03:15:26.746Z,1645067726.746 [lineCaptureHoming:MicromodemComms] Stopped
2022-02-17T03:15:26.746Z,1645067726.746 [lineCaptureHoming:MicromodemComms](DEBUG): Aggregate::uninitialize lineCaptureHoming:MicromodemComms
2022-02-17T03:15:26.746Z,1645067726.746 [lineCaptureHoming:MicromodemComms:CheckIn] Stopped
2022-02-17T03:15:26.746Z,1645067726.746 [lineCaptureHoming:MicromodemComms:CheckIn](DEBUG): Aggregate::uninitialize lineCaptureHoming:MicromodemComms:CheckIn
2022-02-17T03:15:26.746Z,1645067726.746 [lineCaptureHoming:MicromodemComms:CheckIn:A] Stopped
2022-02-17T03:15:26.746Z,1645067726.746 [lineCaptureHoming:LineCapture] Stopped
2022-02-17T03:15:26.746Z,1645067726.746 [lineCaptureHoming:LineCapture](DEBUG): Aggregate::uninitialize lineCaptureHoming:LineCapture
2022-02-17T03:15:26.746Z,1645067726.746 [lineCaptureHoming:LineCapture:StandardEnvelopes] Stopped
2022-02-17T03:15:26.746Z,1645067726.746 [lineCaptureHoming:LineCapture:StandardEnvelopes](DEBUG): Aggregate::uninitialize lineCaptureHoming:LineCapture:StandardEnvelopes
2022-02-17T03:15:26.746Z,1645067726.746 [lineCaptureHoming:LineCapture:StandardEnvelopes:A.AltitudeEnvelope] Stopped
2022-02-17T03:15:26.747Z,1645067726.747 [lineCaptureHoming:LineCapture:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Uninitialize AltitudeEnvelopeComponent.
2022-02-17T03:15:26.747Z,1645067726.747 [lineCaptureHoming:LineCapture:StandardEnvelopes:B.DepthEnvelope] Stopped
2022-02-17T03:15:26.747Z,1645067726.747 [lineCaptureHoming:LineCapture:StandardEnvelopes:B.DepthEnvelope](DEBUG): Uninitialize.
2022-02-17T03:15:26.747Z,1645067726.747 [lineCaptureHoming:LineCapture:StandardEnvelopes:C.OffshoreEnvelope] Stopped
2022-02-17T03:15:26.747Z,1645067726.747 [lineCaptureHoming:LineCapture:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Uninitialize OffshoreEnvelopeComponent.
2022-02-17T03:15:26.747Z,1645067726.747 [lineCaptureHoming:LineCapture:G] Stopped
2022-02-17T03:15:26.747Z,1645067726.747 [lineCaptureHoming:LineCapture:H] Stopped
2022-02-17T03:15:26.747Z,1645067726.747 [lineCaptureHoming:LineCapture:HomingSequence] Stopped
2022-02-17T03:15:26.747Z,1645067726.747 [lineCaptureHoming:LineCapture:HomingSequence](DEBUG): Aggregate::uninitialize lineCaptureHoming:LineCapture:HomingSequence
2022-02-17T03:15:26.747Z,1645067726.747 [lineCaptureHoming:LineCapture:HomingSequence:DetachFromDock] Stopped
2022-02-17T03:15:26.747Z,1645067726.747 [lineCaptureHoming:LineCapture:HomingSequence:DetachFromDock](DEBUG): Aggregate::uninitialize lineCaptureHoming:LineCapture:HomingSequence:DetachFromDock
2022-02-17T03:15:26.747Z,1645067726.747 [lineCaptureHoming:LineCapture:HomingSequence:DetachFromDock:guide] Stopped
2022-02-17T03:15:26.747Z,1645067726.747 [lineCaptureHoming:LineCapture:HomingSequence:DetachFromDock:guide](DEBUG): Aggregate::uninitialize lineCaptureHoming:LineCapture:HomingSequence:DetachFromDock:guide
2022-02-17T03:15:26.752Z,1645067726.752 [lineCaptureHoming:LineCapture:HomingSequence:DetachFromDock:guide:A.Undock] Stopped
2022-02-17T03:15:26.752Z,1645067726.752 [lineCaptureHoming:TrackAC.] Stopped
2022-02-17T03:15:26.752Z,1645067726.752 [lineCaptureHoming:TrackAC.](DEBUG): Uninitializing TrackAcousticContact.
2022-02-17T03:15:26.752Z,1645067726.752 [lineCaptureHoming:Lap] Stopped
2022-02-17T03:15:26.752Z,1645067726.752 [lineCaptureHoming:Lap](DEBUG): Aggregate::uninitialize lineCaptureHoming:Lap
2022-02-17T03:15:26.752Z,1645067726.752 [lineCaptureHoming:Lap:B] Stopped
2022-02-17T03:15:26.752Z,1645067726.752 [lineCaptureHoming:Lap:B](DEBUG): Aggregate::uninitialize lineCaptureHoming:Lap:B
2022-02-17T03:15:27.116Z,1645067727.116 [WetLabsBB2FL](INFO): Powering down
2022-02-17T03:15:27.144Z,1645067727.144 [MissionManager](IMPORTANT): Started mission Default
2022-02-17T03:15:27.144Z,1645067727.144 [Default] Running Loop=1
2022-02-17T03:15:27.145Z,1645067727.145 [Default](DEBUG): Aggregate::initialize Default
2022-02-17T03:15:27.145Z,1645067727.145 [Default:B.GoToSurface] Running Loop=1
2022-02-17T03:15:27.145Z,1645067727.145 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2022-02-17T03:15:27.145Z,1645067727.145 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2022-02-17T03:15:27.145Z,1645067727.145 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2022-02-17T03:15:27.146Z,1645067727.146 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2022-02-17T03:15:27.146Z,1645067727.146 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2022-02-17T03:15:27.146Z,1645067727.146 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2022-02-17T03:15:27.147Z,1645067727.147 [Default:A.Wait] Running Loop=1
2022-02-17T03:15:27.147Z,1645067727.147 [Default:A.Wait](DEBUG): Initialize Wait Component.
2022-02-17T03:15:40.387Z,1645067740.387 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20220217T031250/Courier0000.lzma
2022-02-17T03:15:40.450Z,1645067740.450 [Default:A.Wait](INFO): Done Waiting.
2022-02-17T03:15:40.450Z,1645067740.450 [Default:A.Wait] Stopped
2022-02-17T03:15:40.451Z,1645067740.451 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2022-02-17T03:15:40.897Z,1645067740.897 [Default:CheckIn] Running Loop=1
2022-02-17T03:15:40.897Z,1645067740.897 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2022-02-17T03:15:40.897Z,1645067740.897 [Default:CheckIn:Read_GPS] Running Loop=1
2022-02-17T03:15:41.232Z,1645067741.232 [BPC1](ERROR): BPC1A: No match for serial number FFFF in BPC1A's battery stick inventory (sticks 1-32 in onboard configuration file).
2022-02-17T03:15:41.389Z,1645067741.389 [DataOverHttps](INFO): Moved sent file to Logs/20220217T031250/Courier0000.lzma.bak
2022-02-17T03:15:41.390Z,1645067741.390 [DataOverHttps](INFO): SBD MOMSN=16504780
2022-02-17T03:15:51.488Z,1645067751.488 [CommandExec](IMPORTANT): got command set NAL9602.time_fix 1645067741.390 second
2022-02-17T03:15:51.754Z,1645067751.754 [Default:CheckIn:Read_GPS] Stopped
2022-02-17T03:15:51.754Z,1645067751.754 [Default:CheckIn:Read_Iridium] Running Loop=1
2022-02-17T03:15:52.164Z,1645067752.164 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2022-02-17T03:16:00.624Z,1645067760.624 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2022-02-17T03:16:00.624Z,1645067760.624 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2022-02-17T03:16:00.625Z,1645067760.625 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1
2022-02-17T03:16:00.625Z,1645067760.625 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2022-02-17T03:16:00.636Z,1645067760.636 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2022-02-17T03:16:00.636Z,1645067760.636 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2022-02-17T03:16:01.061Z,1645067761.061 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2022-02-17T03:16:01.061Z,1645067761.061 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2022-02-17T03:16:01.062Z,1645067761.062 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2022-02-17T03:16:01.062Z,1645067761.062 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1
2022-02-17T03:16:01.438Z,1645067761.438 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2022-02-17T03:16:08.243Z,1645067768.243 [DataOverHttps](INFO): Sending 156 bytes from file Logs/20220217T031250/Courier0004.lzma
2022-02-17T03:16:09.246Z,1645067769.246 [DataOverHttps](INFO): Moved sent file to Logs/20220217T031250/Courier0004.lzma.bak
2022-02-17T03:16:09.246Z,1645067769.246 [DataOverHttps](INFO): SBD MOMSN=16504783
2022-02-17T03:16:16.338Z,1645067776.338 [CommandExec](IMPORTANT): got command set NAL9602.time_fix 1645067751.488 second
2022-02-17T03:16:26.189Z,1645067786.189 [DataOverHttps](INFO): Sending 1000 bytes from file Logs/20220217T001428/Express0001.lzma
2022-02-17T03:16:27.190Z,1645067787.190 [DataOverHttps](INFO): Moved sent file to Logs/20220217T001428/Express0001.lzma.bak
2022-02-17T03:16:27.190Z,1645067787.190 [DataOverHttps](INFO): SBD MOMSN=16504785
2022-02-17T03:16:44.133Z,1645067804.133 [DataOverHttps](INFO): Sending 1161 bytes from file Logs/20220217T030122/Express0001.lzma
2022-02-17T03:16:45.134Z,1645067805.134 [DataOverHttps](INFO): Moved sent file to Logs/20220217T030122/Express0001.lzma.bak
2022-02-17T03:16:45.134Z,1645067805.134 [DataOverHttps](INFO): SBD MOMSN=16504817
2022-02-17T03:16:59.893Z,1645067819.893 [DataOverHttps](INFO): Sending 619 bytes from file Logs/20220217T030122/Express0005.lzma
2022-02-17T03:17:00.894Z,1645067820.894 [DataOverHttps](INFO): Moved sent file to Logs/20220217T030122/Express0005.lzma.bak
2022-02-17T03:17:00.894Z,1645067820.894 [DataOverHttps](INFO): SBD MOMSN=16504851
2022-02-17T03:17:01.610Z,1645067821.610 [CommandExec](IMPORTANT): got command set NAL9602.time_fix 1645067805.134 second
2022-02-17T03:17:07.437Z,1645067827.437 [CommandExec](IMPORTANT): got command maintain list
2022-02-17T03:17:17.723Z,1645067837.723 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20220217T030122/Express0008.lzma
2022-02-17T03:17:18.725Z,1645067838.725 [DataOverHttps](INFO): Moved sent file to Logs/20220217T030122/Express0008.lzma.bak
2022-02-17T03:17:18.726Z,1645067838.726 [DataOverHttps](INFO): SBD MOMSN=16504862
2022-02-17T03:17:35.133Z,1645067855.133 [DataOverHttps](INFO): Sending 1119 bytes from file Logs/20220217T031250/Express0001.lzma
2022-02-17T03:17:36.134Z,1645067856.134 [DataOverHttps](INFO): Moved sent file to Logs/20220217T031250/Express0001.lzma.bak
2022-02-17T03:17:36.134Z,1645067856.134 [DataOverHttps](INFO): SBD MOMSN=16504864
2022-02-17T03:17:36.356Z,1645067856.356 [CommandExec](IMPORTANT): got command maintain sensor NAL9602.latitude_fix 36.8 degree
2022-02-17T03:17:36.359Z,1645067856.359 [ComponentRegistry](DEBUG): SyncComponent "Maintain_NAL9602.latitude_fix" handled in the control thread.
2022-02-17T03:17:36.439Z,1645067856.439 [controlThread](DEBUG): Component order: CycleStarter,PAR_Licor,AHRS_M2,BPC1,Depth_Keller,NAL9602,Power24vConverter,PAR_Licor,Depth_Keller,Maintain_NAL9602.latitude_fix,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter,
2022-02-17T03:17:53.156Z,1645067873.156 [DataOverHttps](INFO): Sending 219 bytes from file Logs/20220217T031250/Express0005.lzma
2022-02-17T03:17:54.157Z,1645067874.157 [DataOverHttps](INFO): Moved sent file to Logs/20220217T031250/Express0005.lzma.bak
2022-02-17T03:17:54.158Z,1645067874.158 [DataOverHttps](INFO): SBD MOMSN=16504897
2022-02-17T03:17:55.820Z,1645067875.820 [Default:CheckIn:Read_Iridium] Stopped
2022-02-17T03:17:55.820Z,1645067875.820 [Default:CheckIn:C.Wait] Running Loop=1
2022-02-17T03:17:55.820Z,1645067875.820 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2022-02-17T03:18:01.402Z,1645067881.402 [CommandExec](IMPORTANT): got command maintain sensor NAL9602.longitude_fix -122.2 degree
2022-02-17T03:18:01.472Z,1645067881.472 [ComponentRegistry](DEBUG): SyncComponent "Maintain_NAL9602.longitude_fix" handled in the control thread.
2022-02-17T03:18:01.494Z,1645067881.494 [controlThread](DEBUG): Component order: CycleStarter,PAR_Licor,AHRS_M2,BPC1,Depth_Keller,NAL9602,Power24vConverter,PAR_Licor,Depth_Keller,Maintain_NAL9602.latitude_fix,Maintain_NAL9602.longitude_fix,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter,
2022-02-17T03:18:22.086Z,1645067902.086 [CommandExec](IMPORTANT): got command set NAL9602.time_fix 1645067881.402 second
2022-02-17T03:18:29.621Z,1645067909.621 [CommandExec](IMPORTANT): got command failComponent
2022-02-17T03:18:29.621Z,1645067909.621 [CommandExec](IMPORTANT): Failed components:
2022-02-17T03:18:29.621Z,1645067909.621 [CommandExec](IMPORTANT): No failed Components.
2022-02-17T03:18:41.627Z,1645067921.627 [CommandExec](IMPORTANT): got command set NAL9602.time_fix 1645067909.621 second
2022-02-17T03:19:35.169Z,1645067975.169 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2022-02-17T03:20:03.219Z,1645068003.219 [CommandExec](IMPORTANT): got command set NAL9602.time_fix 1645067909.621 second
2022-02-17T03:20:05.874Z,1645068005.874 [NAL9602](INFO): Not Powering down - fast GPS
2022-02-17T03:20:18.438Z,1645068018.438 [CommandExec](IMPORTANT): got command set NAL9602.time_fix 1645068005.874 
2022-02-17T03:20:18.438Z,1645068018.438 [CommandExec](FAULT): Incomplete syntax. Try: help set
2022-02-17T03:20:26.079Z,1645068026.079 [CommandExec](IMPORTANT): got command set NAL9602.time_fix 1645068005.874 second
2022-02-17T03:20:28.094Z,1645068028.094 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6.
2022-02-17T03:20:28.113Z,1645068028.113 [BPC1](INFO): Received data from all battery sticks.
2022-02-17T03:20:31.822Z,1645068031.822 [CommandExec](IMPORTANT): got command maintain list
2022-02-17T03:20:31.822Z,1645068031.822 [Maintain_NAL9602.latitude_fix](INFO): NAL9602.latitude_fix maintaining 36.799999 arcdeg
2022-02-17T03:20:31.823Z,1645068031.823 [Maintain_NAL9602.longitude_fix](INFO): NAL9602.longitude_fix maintaining -122.199997 arcdeg
2022-02-17T03:20:46.894Z,1645068046.894 [CommandExec](IMPORTANT): got command set NAL9602.time_fix 1645068031.823 second
2022-02-17T03:22:56.388Z,1645068176.388 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2022-02-17T03:22:56.388Z,1645068176.388 [Default:CheckIn:C.Wait] Stopped
2022-02-17T03:22:56.388Z,1645068176.388 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2022-02-17T03:22:56.388Z,1645068176.388 [Default:CheckIn:D] Running Loop=1
2022-02-17T03:22:56.800Z,1645068176.800 [Default:CheckIn:D] Stopped
2022-02-17T03:22:56.801Z,1645068176.801 [Default:CheckIn:E] Running Loop=1
2022-02-17T03:22:57.210Z,1645068177.210 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 7.494265 min 
2022-02-17T03:22:57.210Z,1645068177.210 [Default:CheckIn:E] Stopped
2022-02-17T03:22:57.211Z,1645068177.211 [Default:CheckIn](INFO): Completed Default:CheckIn
2022-02-17T03:22:57.211Z,1645068177.211 [Default:CheckIn] Stopped
2022-02-17T03:22:57.211Z,1645068177.211 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2022-02-17T03:22:57.211Z,1645068177.211 [Default:CheckIn](INFO): Running loop #2
2022-02-17T03:22:57.211Z,1645068177.211 [Default:CheckIn] Running Loop=2
2022-02-17T03:22:57.211Z,1645068177.211 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2022-02-17T03:22:57.211Z,1645068177.211 [Default:CheckIn:Read_GPS] Running Loop=1
2022-02-17T03:23:29.917Z,1645068209.917 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check.
2022-02-17T03:23:29.000Z,1645068210.000 [NAL9602](ERROR): received: 
+CSQ:0

OK
2022-02-17T03:27:57.430Z,1645068477.430 [Default:CheckIn:Read_GPS](INFO): Timed out from 2022-02-17T03:22:57.2Z
2022-02-17T03:27:57.430Z,1645068477.430 [Default:CheckIn:Read_GPS] Stopped
2022-02-17T03:27:57.431Z,1645068477.431 [Default:CheckIn:Read_Iridium] Running Loop=1
2022-02-17T03:28:00.332Z,1645068480.332 [DataOverHttps](INFO): Sending 184 bytes from file Logs/20220217T031250/Courier0007.lzma
2022-02-17T03:28:01.158Z,1645068481.158 [DataOverHttps](INFO): Moved sent file to Logs/20220217T031250/Courier0007.lzma.bak
2022-02-17T03:28:01.158Z,1645068481.158 [DataOverHttps](INFO): SBD MOMSN=16504905
2022-02-17T03:28:01.536Z,1645068481.536 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2022-02-17T03:28:18.156Z,1645068498.156 [DataOverHttps](INFO): Sending 624 bytes from file Logs/20220217T031250/Express0008.lzma
2022-02-17T03:28:19.158Z,1645068499.158 [DataOverHttps](INFO): Moved sent file to Logs/20220217T031250/Express0008.lzma.bak
2022-02-17T03:28:19.158Z,1645068499.158 [DataOverHttps](INFO): SBD MOMSN=16504907
2022-02-17T03:28:20.945Z,1645068500.945 [Default:CheckIn:Read_Iridium] Stopped
2022-02-17T03:28:20.946Z,1645068500.946 [Default:CheckIn:C.Wait] Running Loop=1
2022-02-17T03:28:20.946Z,1645068500.946 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2022-02-17T03:28:32.237Z,1645068512.237 [NAL9602](INFO): Not Powering down - fast GPS
2022-02-17T03:33:21.540Z,1645068801.540 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2022-02-17T03:33:21.540Z,1645068801.540 [Default:CheckIn:C.Wait] Stopped
2022-02-17T03:33:21.540Z,1645068801.540 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2022-02-17T03:33:21.540Z,1645068801.540 [Default:CheckIn:D] Running Loop=1
2022-02-17T03:33:21.951Z,1645068801.951 [Default:CheckIn:D] Stopped
2022-02-17T03:33:21.951Z,1645068801.951 [Default:CheckIn:E] Running Loop=1
2022-02-17T03:33:22.347Z,1645068802.347 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 17.913438 min 
2022-02-17T03:33:22.347Z,1645068802.347 [Default:CheckIn:E] Stopped
2022-02-17T03:33:22.347Z,1645068802.347 [Default:CheckIn](INFO): Completed Default:CheckIn
2022-02-17T03:33:22.347Z,1645068802.347 [Default:CheckIn] Stopped
2022-02-17T03:33:22.347Z,1645068802.347 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2022-02-17T03:33:22.347Z,1645068802.347 [Default:CheckIn](INFO): Running loop #3
2022-02-17T03:33:22.364Z,1645068802.364 [Default:CheckIn] Running Loop=3
2022-02-17T03:33:22.364Z,1645068802.364 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2022-02-17T03:33:22.364Z,1645068802.364 [Default:CheckIn:Read_GPS] Running Loop=1
2022-02-17T03:33:23.951Z,1645068803.951 [NAL9602](FAULT): GPS failed to acquire within timeout.
2022-02-17T03:33:23.951Z,1645068803.951 [NAL9602] Data Fault, FailCount= 2
2022-02-17T03:33:23.952Z,1645068803.952 [NAL9602](ERROR): Data Fault
2022-02-17T03:33:23.973Z,1645068803.973 [CBIT](ERROR): Data Fault in component: NAL9602
2022-02-17T03:33:24.357Z,1645068804.357 [NAL9602](INFO): Powering down
2022-02-17T03:33:25.210Z,1645068805.210 [CBIT](INFO): Clearing failed state for component NAL9602
2022-02-17T03:33:25.210Z,1645068805.210 [NAL9602] No Fault, FailCount= 2
2022-02-17T03:33:54.647Z,1645068834.647 [NAL9602](INFO): Powering up NAL9602
2022-02-17T03:34:05.556Z,1645068845.556 [NAL9602](INFO): NAL9602 initialized
2022-02-17T03:38:22.546Z,1645069102.546 [Default:CheckIn:Read_GPS](INFO): Timed out from 2022-02-17T03:33:22.4Z
2022-02-17T03:38:22.546Z,1645069102.546 [Default:CheckIn:Read_GPS] Stopped
2022-02-17T03:38:22.546Z,1645069102.546 [Default:CheckIn:Read_Iridium] Running Loop=1
2022-02-17T03:38:24.875Z,1645069104.875 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20220217T031250/Courier0010.lzma
2022-02-17T03:38:25.717Z,1645069105.717 [DataOverHttps](INFO): Moved sent file to Logs/20220217T031250/Courier0010.lzma.bak
2022-02-17T03:38:25.718Z,1645069105.718 [DataOverHttps](INFO): SBD MOMSN=16504927
2022-02-17T03:38:42.852Z,1645069122.852 [DataOverHttps](INFO): Sending 227 bytes from file Logs/20220217T031250/Express0011.lzma
2022-02-17T03:38:43.854Z,1645069123.854 [DataOverHttps](INFO): Moved sent file to Logs/20220217T031250/Express0011.lzma.bak
2022-02-17T03:38:43.854Z,1645069123.854 [DataOverHttps](INFO): SBD MOMSN=16504929
2022-02-17T03:38:45.674Z,1645069125.674 [Default:CheckIn:Read_Iridium] Stopped
2022-02-17T03:38:45.674Z,1645069125.674 [Default:CheckIn:C.Wait] Running Loop=1
2022-02-17T03:38:45.674Z,1645069125.674 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2022-02-17T03:39:09.489Z,1645069149.489 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2022-02-17T03:39:40.195Z,1645069180.195 [NAL9602](INFO): Not Powering down - fast GPS
2022-02-17T03:39:46.924Z,1645069186.924 [CommandExec](IMPORTANT): got command quit
2022-02-17T03:39:47.928Z,1645069187.928 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread.
2022-02-17T03:39:47.928Z,1645069187.928 [CommandExec](INFO): Uninitializing the command executive.
2022-02-17T03:39:47.928Z,1645069187.928 [CommandExec](INFO): Uninitializing the command scheduler.
2022-02-17T03:39:47.928Z,1645069187.928 [CommandExec ThreadHandler](INFO): Thread cancelled.
2022-02-17T03:39:47.960Z,1645069187.960 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2022-02-17T03:39:47.960Z,1645069187.960 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2022-02-17T03:39:47.960Z,1645069187.960 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2022-02-17T03:39:47.961Z,1645069187.961 [NavChartDb](INFO): Join timeout helper Thread ID is 8926
2022-02-17T03:39:48.058Z,1645069188.058 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2022-02-17T03:39:48.058Z,1645069188.058 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2022-02-17T03:39:48.060Z,1645069188.060 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler
2022-02-17T03:39:48.060Z,1645069188.060 [DAT ThreadHandler](INFO): Thread cancelled.
2022-02-17T03:39:48.060Z,1645069188.060 [DAT](INFO): Join timeout helper Thread ID is 8927
2022-02-17T03:39:48.064Z,1645069188.064 [DAT](INFO): Powering down
2022-02-17T03:39:48.136Z,1645069188.136 [DAT ThreadHandler](INFO): Uninitializing protected caller thread.
2022-02-17T03:39:48.137Z,1645069188.137 [DAT](INFO): Powering down
2022-02-17T03:39:48.137Z,1645069188.137 [DAT ThreadHandler](INFO): Thread cancelled.
2022-02-17T03:39:48.140Z,1645069188.140 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2022-02-17T03:39:48.140Z,1645069188.140 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2022-02-17T03:39:48.140Z,1645069188.140 [Radio_Surface](INFO): Join timeout helper Thread ID is 8928
2022-02-17T03:39:48.392Z,1645069188.392 [Radio_Surface](INFO): Powering down
2022-02-17T03:39:48.393Z,1645069188.393 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2022-02-17T03:39:48.393Z,1645069188.393 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2022-02-17T03:39:48.400Z,1645069188.400 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2022-02-17T03:39:48.400Z,1645069188.400 [Onboard ThreadHandler](INFO): Thread cancelled.
2022-02-17T03:39:48.401Z,1645069188.401 [Onboard](INFO): Join timeout helper Thread ID is 8929
2022-02-17T03:39:48.681Z,1645069188.681 [Power24vConverter](INFO): Powering down.
2022-02-17T03:39:48.948Z,1645069188.948 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2022-02-17T03:39:51.720Z,1645069191.720 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2022-02-17T03:39:51.720Z,1645069191.720 [Onboard ThreadHandler](INFO): Thread cancelled.
2022-02-17T03:39:51.724Z,1645069191.724 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2022-02-17T03:39:51.724Z,1645069191.724 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2022-02-17T03:39:51.724Z,1645069191.724 [DataOverHttps](INFO): Join timeout helper Thread ID is 8930
2022-02-17T03:39:51.976Z,1645069191.976 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2022-02-17T03:39:51.976Z,1645069191.976 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2022-02-17T03:39:51.985Z,1645069191.985 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler
2022-02-17T03:39:51.985Z,1645069191.985 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2022-02-17T03:39:51.985Z,1645069191.985 [BackseatComponent](INFO): Join timeout helper Thread ID is 8931
2022-02-17T03:39:51.989Z,1645069191.989 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread.
2022-02-17T03:39:51.989Z,1645069191.989 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2022-02-17T03:39:52.004Z,1645069192.004 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2022-02-17T03:39:52.005Z,1645069192.005 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2022-02-17T03:39:52.005Z,1645069192.005 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 8932
2022-02-17T03:39:52.088Z,1645069192.088 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2022-02-17T03:39:52.088Z,1645069192.088 [WetLabsBB2FL](INFO): Powering down
2022-02-17T03:39:52.089Z,1645069192.089 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2022-02-17T03:39:52.108Z,1645069192.108 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2022-02-17T03:39:52.109Z,1645069192.109 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2022-02-17T03:39:52.109Z,1645069192.109 [CTD_Seabird](INFO): Join timeout helper Thread ID is 8933
2022-02-17T03:39:52.176Z,1645069192.176 [CTD_Seabird](INFO): Powering down
2022-02-17T03:39:52.188Z,1645069192.188 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2022-02-17T03:39:52.188Z,1645069192.188 [CTD_Seabird](INFO): Powering down
2022-02-17T03:39:52.200Z,1645069192.200 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2022-02-17T03:39:52.212Z,1645069192.212 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2022-02-17T03:39:52.213Z,1645069192.213 [logger ThreadHandler](INFO): Thread cancelled.
2022-02-17T03:39:52.213Z,1645069192.213 [logger](INFO): Join timeout helper Thread ID is 8934
2022-02-17T03:39:52.220Z,1645069192.220 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2022-02-17T03:39:52.220Z,1645069192.220 [logger ThreadHandler](INFO): Thread cancelled.
2022-02-17T03:39:52.232Z,1645069192.232 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2022-02-17T03:39:52.233Z,1645069192.233 [CommandLine ThreadHandler](INFO): Thread cancelled.
2022-02-17T03:39:52.233Z,1645069192.233 [CommandLine](INFO): Join timeout helper Thread ID is 8935
2022-02-17T03:39:52.244Z,1645069192.244 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2022-02-17T03:39:52.244Z,1645069192.244 [CommandLine ThreadHandler](INFO): Thread cancelled.
2022-02-17T03:39:52.252Z,1645069192.252 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler
2022-02-17T03:39:52.253Z,1645069192.253 [CommandExec ThreadHandler](INFO): Thread cancelled.
2022-02-17T03:39:52.253Z,1645069192.253 [CommandExec](INFO): Join timeout helper Thread ID is 8936
2022-02-17T03:39:52.254Z,1645069192.254 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2022-02-17T03:39:52.254Z,1645069192.254 [controlThread ThreadHandler](INFO): Thread cancelled.
2022-02-17T03:39:52.254Z,1645069192.254 [controlThread](INFO): Join timeout helper Thread ID is 8937
2022-02-17T03:39:52.292Z,1645069192.292 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2022-02-17T03:39:52.292Z,1645069192.292 [controlThread](DEBUG): Uninitializing ControlThread
2022-02-17T03:39:52.293Z,1645069192.293 [AHRS_M2](INFO): Powering down
2022-02-17T03:39:52.364Z,1645069192.364 [NAL9602](INFO): Powering down
2022-02-17T03:39:52.366Z,1645069192.366 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2022-02-17T03:39:52.367Z,1645069192.367 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2022-02-17T03:39:52.368Z,1645069192.368 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2022-02-17T03:39:52.369Z,1645069192.369 [MissionManager](INFO): Uninitializing Mission Default
2022-02-17T03:39:52.369Z,1645069192.369 [Default] Stopped
2022-02-17T03:39:52.369Z,1645069192.369 [Default](DEBUG): Aggregate::uninitialize Default
2022-02-17T03:39:52.369Z,1645069192.369 [Default:B.GoToSurface] Stopped
2022-02-17T03:39:52.369Z,1645069192.369 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2022-02-17T03:39:52.369Z,1645069192.369 [Default:CheckIn] Stopped
2022-02-17T03:39:52.369Z,1645069192.369 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2022-02-17T03:39:52.369Z,1645069192.369 [Default:CheckIn:C.Wait] Stopped
2022-02-17T03:39:52.369Z,1645069192.369 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2022-02-17T03:39:52.372Z,1645069192.372 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2022-02-17T03:39:52.372Z,1645069192.372 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2022-02-17T03:39:52.373Z,1645069192.373 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2022-02-17T03:39:52.373Z,1645069192.373 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2022-02-17T03:39:52.373Z,1645069192.373 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2022-02-17T03:39:52.373Z,1645069192.373 [BuoyancyServo](INFO): Powering down
2022-02-17T03:39:52.388Z,1645069192.388 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2022-02-17T03:39:52.388Z,1645069192.388 [ElevatorServo](INFO): Powering down
2022-02-17T03:39:52.389Z,1645069192.389 [MassServo](DEBUG): Uninitialize Mass Servo.
2022-02-17T03:39:52.389Z,1645069192.389 [MassServo](INFO): Powering down
2022-02-17T03:39:52.390Z,1645069192.390 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2022-02-17T03:39:52.390Z,1645069192.390 [RudderServo](INFO): Powering down
2022-02-17T03:39:52.391Z,1645069192.391 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2022-02-17T03:39:52.391Z,1645069192.391 [ThrusterHE](INFO): Powering down
2022-02-17T03:39:52.392Z,1645069192.392 [SBIT](DEBUG): Uninitialize SBIT Component.
2022-02-17T03:39:52.392Z,1645069192.392 [IBIT](DEBUG): Uninitialize IBIT Component.
2022-02-17T03:39:52.392Z,1645069192.392 [CBIT](DEBUG): Uninitialize CBIT Component.
2022-02-17T03:39:52.392Z,1645069192.392 [CBIT](DEBUG): Powering off loads.
2022-02-17T03:39:52.404Z,1645069192.404 [CBIT](DEBUG): Disabling WDT.
2022-02-17T03:39:52.416Z,1645069192.416 [CBIT](DEBUG): Opening all GF detection circuits.
2022-02-17T03:39:52.417Z,1645069192.417 [controlThread ThreadHandler](INFO): Thread cancelled.
2022-02-17T03:39:52.454Z,1645069192.454 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2022-02-17T03:39:52.458Z,1645069192.458 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2022-02-17T03:39:52.501Z,1645069192.501 [DAT ThreadHandler](INFO): Thread cancelled.
2022-02-17T03:39:52.505Z,1645069192.505 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2022-02-17T03:39:52.507Z,1645069192.507 [Onboard ThreadHandler](INFO): Thread cancelled.
2022-02-17T03:39:52.513Z,1645069192.513 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2022-02-17T03:39:52.556Z,1645069192.556 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2022-02-17T03:39:52.596Z,1645069192.596 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2022-02-17T03:39:52.657Z,1645069192.657 [logger ThreadHandler](INFO): Thread cancelled.