2022-01-31T18:46:10.582Z,1643654770.582 [Supervisor](DEBUG): Initializing supervisor.
2022-01-31T18:46:10.587Z,1643654770.587 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2022-01-31T18:46:10.587Z,1643654770.587 [SyncHandler](INFO): Protected caller Thread ID is 6299
2022-01-31T18:46:10.587Z,1643654770.587 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2022-01-31T18:46:10.588Z,1643654770.588 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2022-01-31T18:46:10.589Z,1643654770.589 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 6300
2022-01-31T18:46:10.593Z,1643654770.593 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2022-01-31T18:46:10.611Z,1643654770.611 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2022-01-31T18:46:10.612Z,1643654770.612 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2022-01-31T18:46:10.612Z,1643654770.612 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 6301
2022-01-31T18:46:10.616Z,1643654770.616 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2022-01-31T18:46:10.617Z,1643654770.617 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2022-01-31T18:46:10.618Z,1643654770.618 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 6302
2022-01-31T18:46:10.620Z,1643654770.620 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2022-01-31T18:46:10.621Z,1643654770.621 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2022-01-31T18:46:10.621Z,1643654770.621 [logger ThreadHandler](INFO): Protected caller Thread ID is 6303
2022-01-31T18:46:10.625Z,1643654770.625 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2022-01-31T18:46:10.625Z,1643654770.625 [Supervisor](INFO): Looking for Config files in directory: Config/
2022-01-31T18:46:10.627Z,1643654770.627 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2022-01-31T18:46:11.041Z,1643654771.041 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2022-01-31T18:46:11.041Z,1643654771.041 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2022-01-31T18:46:11.120Z,1643654771.120 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2022-01-31T18:46:11.439Z,1643654771.439 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2022-01-31T18:46:11.440Z,1643654771.440 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2022-01-31T18:46:11.547Z,1643654771.547 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2022-01-31T18:46:11.547Z,1643654771.547 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2022-01-31T18:46:11.747Z,1643654771.747 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2022-01-31T18:46:11.748Z,1643654771.748 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2022-01-31T18:46:12.251Z,1643654772.251 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2022-01-31T18:46:12.252Z,1643654772.252 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2022-01-31T18:46:12.514Z,1643654772.514 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2022-01-31T18:46:12.514Z,1643654772.514 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2022-01-31T18:46:12.660Z,1643654772.660 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2022-01-31T18:46:12.661Z,1643654772.661 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2022-01-31T18:46:12.848Z,1643654772.848 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2022-01-31T18:46:12.848Z,1643654772.848 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2022-01-31T18:46:12.945Z,1643654772.945 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2022-01-31T18:46:12.946Z,1643654772.946 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2022-01-31T18:46:13.162Z,1643654773.162 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2022-01-31T18:46:13.163Z,1643654773.163 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2022-01-31T18:46:13.541Z,1643654773.541 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2022-01-31T18:46:13.542Z,1643654773.542 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2022-01-31T18:46:13.622Z,1643654773.622 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2022-01-31T18:46:13.747Z,1643654773.747 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2022-01-31T18:46:13.748Z,1643654773.748 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2022-01-31T18:46:14.428Z,1643654774.428 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2022-01-31T18:46:14.429Z,1643654774.429 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2022-01-31T18:46:14.810Z,1643654774.810 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2022-01-31T18:46:14.812Z,1643654774.812 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-polaris/
2022-01-31T18:46:14.813Z,1643654774.813 [Supervisor](INFO): Opening Config file at: Config/lrauv-polaris/vehicle.cfg
2022-01-31T18:46:15.272Z,1643654775.272 [Supervisor](INFO): Opening Config file at: Config/lrauv-polaris/Control.cfg
2022-01-31T18:46:15.520Z,1643654775.520 [Supervisor](INFO): Opening Config file at: Config/lrauv-polaris/Estimation.cfg
2022-01-31T18:46:15.671Z,1643654775.671 [Supervisor](INFO): Opening Config file at: Config/lrauv-polaris/BIT.cfg
2022-01-31T18:46:15.775Z,1643654775.775 [Supervisor](INFO): Opening Config file at: Config/lrauv-polaris/Battery.cfg
2022-01-31T18:46:16.176Z,1643654776.176 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2022-01-31T18:46:16.177Z,1643654776.177 [Supervisor](INFO): Opening Config file at: Config/lrauv-polaris/Simulator.cfg
2022-01-31T18:46:16.262Z,1643654776.262 [Supervisor](INFO): Opening Config file at: Config/lrauv-polaris/Navigation.cfg
2022-01-31T18:46:16.364Z,1643654776.364 [Supervisor](INFO): Opening Config file at: Config/lrauv-polaris/Derivation.cfg
2022-01-31T18:46:16.487Z,1643654776.487 [Supervisor](INFO): Opening Config file at: Config/lrauv-polaris/logger.cfg
2022-01-31T18:46:16.599Z,1643654776.599 [Supervisor](INFO): Opening Config file at: Config/lrauv-polaris/secure.cfg
2022-01-31T18:46:16.683Z,1643654776.683 [Supervisor](INFO): Opening Config file at: Config/lrauv-polaris/Dock.cfg
2022-01-31T18:46:16.769Z,1643654776.769 [Supervisor](INFO): Opening Config file at: Config/lrauv-polaris/Servo.cfg
2022-01-31T18:46:16.880Z,1643654776.880 [Supervisor](INFO): Opening Config file at: Config/lrauv-polaris/workSite.cfg
2022-01-31T18:46:16.978Z,1643654776.978 [Supervisor](INFO): Opening Config file at: Config/lrauv-polaris/Sensor.cfg
2022-01-31T18:46:17.181Z,1643654777.181 [Supervisor](INFO): Opening Config file at: Config/lrauv-polaris/Science.cfg
2022-01-31T18:46:17.340Z,1643654777.340 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2022-01-31T18:46:17.361Z,1643654777.361 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2022-01-31T18:46:17.773Z,1643654777.773 [AHRS_M2] Loaded
2022-01-31T18:46:17.773Z,1643654777.773 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2022-01-31T18:46:17.807Z,1643654777.807 [BackseatComponent] Loaded
2022-01-31T18:46:17.807Z,1643654777.807 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread.
2022-01-31T18:46:17.808Z,1643654777.808 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 407DF4E0
2022-01-31T18:46:17.808Z,1643654777.808 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 6397
2022-01-31T18:46:17.811Z,1643654777.811 [LcmUniversalReporter] Loaded
2022-01-31T18:46:17.811Z,1643654777.811 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread.
2022-01-31T18:46:18.558Z,1643654778.558 [BPC1] Loaded
2022-01-31T18:46:18.558Z,1643654778.558 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2022-01-31T18:46:18.629Z,1643654778.629 [DataOverHttps] Loaded
2022-01-31T18:46:18.629Z,1643654778.629 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2022-01-31T18:46:18.630Z,1643654778.630 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 4080F4E0
2022-01-31T18:46:18.630Z,1643654778.630 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 6398
2022-01-31T18:46:18.635Z,1643654778.635 [DropWeight] Loaded
2022-01-31T18:46:18.635Z,1643654778.635 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2022-01-31T18:46:18.692Z,1643654778.692 [NAL9602] Loaded
2022-01-31T18:46:18.692Z,1643654778.692 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2022-01-31T18:46:18.720Z,1643654778.720 [Onboard] Loaded
2022-01-31T18:46:18.720Z,1643654778.720 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2022-01-31T18:46:18.721Z,1643654778.721 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 4083F4E0
2022-01-31T18:46:18.721Z,1643654778.721 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 6399
2022-01-31T18:46:18.727Z,1643654778.727 [PowerOnly](INFO): Adding load control power supply at /dev/loadC1
2022-01-31T18:46:18.738Z,1643654778.738 [PowerOnly] Loaded
2022-01-31T18:46:18.738Z,1643654778.738 [ComponentRegistry](DEBUG): SyncComponent "PowerOnly" handled in the control thread.
2022-01-31T18:46:18.749Z,1643654778.749 [Power24vConverter] Loaded
2022-01-31T18:46:18.749Z,1643654778.749 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2022-01-31T18:46:18.762Z,1643654778.762 [Radio_Surface] Loaded
2022-01-31T18:46:18.762Z,1643654778.762 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2022-01-31T18:46:18.763Z,1643654778.763 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 4086F4E0
2022-01-31T18:46:18.764Z,1643654778.764 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 6400
2022-01-31T18:46:18.805Z,1643654778.805 [RDI_Pathfinder] Loaded
2022-01-31T18:46:18.806Z,1643654778.806 [ComponentRegistry](DEBUG): SyncComponent "RDI_Pathfinder" handled in the control thread.
2022-01-31T18:46:18.806Z,1643654778.806 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2022-01-31T18:46:18.807Z,1643654778.807 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2022-01-31T18:46:18.818Z,1643654778.818 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2022-01-31T18:46:18.818Z,1643654778.818 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2022-01-31T18:46:18.927Z,1643654778.927 [DeadReckonUsingMultipleVelocitySources] Loaded
2022-01-31T18:46:18.927Z,1643654778.927 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2022-01-31T18:46:18.955Z,1643654778.955 [LBLNavigation] Loaded
2022-01-31T18:46:18.956Z,1643654778.956 [ComponentRegistry](DEBUG): SyncComponent "LBLNavigation" handled in the control thread.
2022-01-31T18:46:18.968Z,1643654778.968 [NavChart] Loaded
2022-01-31T18:46:18.968Z,1643654778.968 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2022-01-31T18:46:18.974Z,1643654778.974 [UniversalFixResidualReporter] Loaded
2022-01-31T18:46:18.974Z,1643654778.974 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2022-01-31T18:46:18.984Z,1643654778.984 [WorkSite] Loaded
2022-01-31T18:46:18.984Z,1643654778.984 [ComponentRegistry](DEBUG): SyncComponent "WorkSite" handled in the control thread.
2022-01-31T18:46:18.984Z,1643654778.984 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2022-01-31T18:46:18.985Z,1643654778.985 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2022-01-31T18:46:19.078Z,1643654779.078 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2022-01-31T18:46:19.078Z,1643654779.078 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2022-01-31T18:46:19.204Z,1643654779.204 [BuoyancyServo] Loaded
2022-01-31T18:46:19.205Z,1643654779.205 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2022-01-31T18:46:19.226Z,1643654779.226 [ElevatorServo] Loaded
2022-01-31T18:46:19.226Z,1643654779.226 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2022-01-31T18:46:19.246Z,1643654779.246 [MassServo] Loaded
2022-01-31T18:46:19.246Z,1643654779.246 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2022-01-31T18:46:19.265Z,1643654779.265 [RudderServo] Loaded
2022-01-31T18:46:19.265Z,1643654779.265 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2022-01-31T18:46:19.281Z,1643654779.281 [ThrusterHE] Loaded
2022-01-31T18:46:19.281Z,1643654779.281 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread.
2022-01-31T18:46:19.282Z,1643654779.282 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2022-01-31T18:46:19.282Z,1643654779.282 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2022-01-31T18:46:19.452Z,1643654779.452 [CTD_Seabird] Loaded
2022-01-31T18:46:19.452Z,1643654779.452 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2022-01-31T18:46:19.453Z,1643654779.453 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 409AB4E0
2022-01-31T18:46:19.454Z,1643654779.454 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 6401
2022-01-31T18:46:19.473Z,1643654779.473 [PAR_Licor] Loaded
2022-01-31T18:46:19.473Z,1643654779.473 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2022-01-31T18:46:19.504Z,1643654779.504 [WetLabsSeaOWL_UV_A] Loaded
2022-01-31T18:46:19.504Z,1643654779.504 [ComponentRegistry](DEBUG): Component "WetLabsSeaOWL_UV_A" handled in its own thread.
2022-01-31T18:46:19.505Z,1643654779.505 [WetLabsSeaOWL_UV_A ThreadHandler](DEBUG): Created PCaller Thread at 409DB4E0
2022-01-31T18:46:19.506Z,1643654779.506 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Protected caller Thread ID is 6402
2022-01-31T18:46:19.506Z,1643654779.506 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2022-01-31T18:46:19.507Z,1643654779.507 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2022-01-31T18:46:19.822Z,1643654779.822 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2022-01-31T18:46:19.823Z,1643654779.823 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2022-01-31T18:46:19.998Z,1643654779.998 [DepthRateCalculator] Loaded
2022-01-31T18:46:19.998Z,1643654779.998 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2022-01-31T18:46:20.037Z,1643654780.037 [PitchRateCalculator] Loaded
2022-01-31T18:46:20.037Z,1643654780.037 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2022-01-31T18:46:20.077Z,1643654780.077 [SpeedCalculator] Loaded
2022-01-31T18:46:20.078Z,1643654780.078 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2022-01-31T18:46:20.143Z,1643654780.143 [TempGradientCalculator] Loaded
2022-01-31T18:46:20.143Z,1643654780.143 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2022-01-31T18:46:20.194Z,1643654780.194 [VerticalHomogeneityIndexCalculator] Loaded
2022-01-31T18:46:20.195Z,1643654780.195 [ComponentRegistry](DEBUG): SyncComponent "VerticalHomogeneityIndexCalculator" handled in the control thread.
2022-01-31T18:46:20.199Z,1643654780.199 [YawRateCalculator] Loaded
2022-01-31T18:46:20.199Z,1643654780.199 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2022-01-31T18:46:20.221Z,1643654780.221 [ElevatorOffsetCalculator] Loaded
2022-01-31T18:46:20.221Z,1643654780.221 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2022-01-31T18:46:20.222Z,1643654780.222 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2022-01-31T18:46:20.222Z,1643654780.222 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2022-01-31T18:46:20.543Z,1643654780.543 [SBIT](DEBUG): Construct Startup Built In Test.
2022-01-31T18:46:20.555Z,1643654780.555 [SBIT] Loaded
2022-01-31T18:46:20.555Z,1643654780.555 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2022-01-31T18:46:20.558Z,1643654780.558 [IBIT](DEBUG): Construct Initiated Built In Test.
2022-01-31T18:46:20.571Z,1643654780.571 [IBIT] Loaded
2022-01-31T18:46:20.571Z,1643654780.571 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2022-01-31T18:46:20.576Z,1643654780.576 [CBIT](DEBUG): Construct Continuous Built In Test.
2022-01-31T18:46:20.677Z,1643654780.677 [CBIT] Loaded
2022-01-31T18:46:20.677Z,1643654780.677 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2022-01-31T18:46:20.678Z,1643654780.678 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2022-01-31T18:46:20.678Z,1643654780.678 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2022-01-31T18:46:20.735Z,1643654780.735 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2022-01-31T18:46:20.735Z,1643654780.735 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2022-01-31T18:46:20.839Z,1643654780.839 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2022-01-31T18:46:20.840Z,1643654780.840 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2022-01-31T18:46:20.891Z,1643654780.891 [VerticalControl](DEBUG): Construct VerticalControl.
2022-01-31T18:46:20.942Z,1643654780.942 [VerticalControl] Loaded
2022-01-31T18:46:20.942Z,1643654780.942 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2022-01-31T18:46:20.945Z,1643654780.945 [HorizontalControl](DEBUG): Construct HorizontalControl.
2022-01-31T18:46:20.980Z,1643654780.980 [HorizontalControl] Loaded
2022-01-31T18:46:20.981Z,1643654780.981 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2022-01-31T18:46:20.983Z,1643654780.983 [SpeedControl](DEBUG): Construct SpeedControl.
2022-01-31T18:46:20.985Z,1643654780.985 [SpeedControl] Loaded
2022-01-31T18:46:20.985Z,1643654780.985 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2022-01-31T18:46:20.988Z,1643654780.988 [LoopControl](DEBUG): Construct LoopControl.
2022-01-31T18:46:20.988Z,1643654780.988 [LoopControl] Loaded
2022-01-31T18:46:20.989Z,1643654780.989 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2022-01-31T18:46:20.989Z,1643654780.989 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2022-01-31T18:46:20.990Z,1643654780.990 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2022-01-31T18:46:21.016Z,1643654781.016 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2022-01-31T18:46:21.022Z,1643654781.022 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2022-01-31T18:46:21.025Z,1643654781.025 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2022-01-31T18:46:21.035Z,1643654781.035 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2022-01-31T18:46:21.036Z,1643654781.036 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40B8D4E0
2022-01-31T18:46:21.037Z,1643654781.037 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 6403
2022-01-31T18:46:21.041Z,1643654781.041 [Supervisor](INFO): Main Thread ID is 829
2022-01-31T18:46:21.041Z,1643654781.041 [Supervisor](DEBUG): Running supervisor.
2022-01-31T18:46:21.042Z,1643654781.042 [CommandExec ThreadHandler](INFO): Handler Thread ID is 6404
2022-01-31T18:46:21.042Z,1643654781.042 [CommandExec](INFO): Initializing the command executive.
2022-01-31T18:46:21.044Z,1643654781.044 [CommandLine ThreadHandler](INFO): Handler Thread ID is 6405
2022-01-31T18:46:21.046Z,1643654781.046 [controlThread ThreadHandler](INFO): Handler Thread ID is 6406
2022-01-31T18:46:21.046Z,1643654781.046 [controlThread](DEBUG): Initializing ControlThread
2022-01-31T18:46:21.050Z,1643654781.050 [NavChart](DEBUG): Initialize NavChart Navigation.
2022-01-31T18:46:21.051Z,1643654781.051 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2022-01-31T18:46:21.051Z,1643654781.051 [WorkSite](DEBUG): Initializing WorkSite component.
2022-01-31T18:46:21.056Z,1643654781.056 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2022-01-31T18:46:21.056Z,1643654781.056 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2022-01-31T18:46:21.057Z,1643654781.057 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2022-01-31T18:46:21.057Z,1643654781.057 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2022-01-31T18:46:21.058Z,1643654781.058 [VerticalHomogeneityIndexCalculator](DEBUG): (re)initializing
2022-01-31T18:46:21.058Z,1643654781.058 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2022-01-31T18:46:21.059Z,1643654781.059 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2022-01-31T18:46:21.059Z,1643654781.059 [SBIT](INFO): Initialize SBIT Component.
2022-01-31T18:46:21.060Z,1643654781.060 [SBIT](IMPORTANT): git: 2022-01-19
2022-01-31T18:46:21.060Z,1643654781.060 [SBIT](INFO): git hash: 3c152841e44dce493716324b2ee7dcf988968060
2022-01-31T18:46:21.060Z,1643654781.060 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2022-01-31T18:46:21.061Z,1643654781.061 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018
Kernel Reported: #1 PREEMPT Thu Aug 6 12:04:53 PDT 2020
2022-01-31T18:46:21.062Z,1643654781.062 [SBIT](INFO): Beginning SBIT in 44.000000 seconds.
2022-01-31T18:46:21.063Z,1643654781.063 [IBIT](INFO): Initialize IBIT Component.
2022-01-31T18:46:21.064Z,1643654781.064 [CBIT](DEBUG): Initialize CBIT Component.
2022-01-31T18:46:21.065Z,1643654781.065 [logger ThreadHandler](INFO): Handler Thread ID is 6407
2022-01-31T18:46:21.076Z,1643654781.076 [CBIT](DEBUG): Initialized mux pins.
2022-01-31T18:46:21.076Z,1643654781.076 [CBIT](DEBUG): Initializing the watchdog timer.
2022-01-31T18:46:21.084Z,1643654781.084 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 6408
2022-01-31T18:46:21.097Z,1643654781.097 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 6409
2022-01-31T18:46:21.098Z,1643654781.098 [DataOverHttps](DEBUG): dashIP=128.128.181.226 starts with a digit so assuming it is a numeric IP
2022-01-31T18:46:21.100Z,1643654781.100 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2022-01-31T18:46:21.100Z,1643654781.100 [CBIT](DEBUG): Initializing heartbeat.
2022-01-31T18:46:21.108Z,1643654781.108 [Onboard ThreadHandler](INFO): Handler Thread ID is 6410
2022-01-31T18:46:21.124Z,1643654781.124 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 6411
2022-01-31T18:46:21.144Z,1643654781.144 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 6412
2022-01-31T18:46:21.145Z,1643654781.145 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2022-01-31T18:46:21.150Z,1643654781.150 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Handler Thread ID is 6414
2022-01-31T18:46:21.150Z,1643654781.150 [WetLabsSeaOWL_UV_A](INFO): Powering down
2022-01-31T18:46:21.161Z,1643654781.161 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 6415
2022-01-31T18:46:21.166Z,1643654781.166 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2022-01-31T18:46:21.166Z,1643654781.166 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2022-01-31T18:46:21.166Z,1643654781.166 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2022-01-31T18:46:21.166Z,1643654781.166 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2022-01-31T18:46:21.167Z,1643654781.167 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2022-01-31T18:46:21.167Z,1643654781.167 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2022-01-31T18:46:21.167Z,1643654781.167 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2022-01-31T18:46:21.167Z,1643654781.167 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2022-01-31T18:46:21.167Z,1643654781.167 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2022-01-31T18:46:21.167Z,1643654781.167 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2022-01-31T18:46:21.168Z,1643654781.168 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2022-01-31T18:46:21.168Z,1643654781.168 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2022-01-31T18:46:21.168Z,1643654781.168 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2022-01-31T18:46:21.168Z,1643654781.168 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2022-01-31T18:46:21.168Z,1643654781.168 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2022-01-31T18:46:21.168Z,1643654781.168 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2022-01-31T18:46:21.172Z,1643654781.172 [CBIT](DEBUG): Deactivating GF circuits.
2022-01-31T18:46:21.172Z,1643654781.172 [CBIT](DEBUG): Deactivating emergency mode.
2022-01-31T18:46:21.208Z,1643654781.208 [CBIT](DEBUG): Backplane powered.
2022-01-31T18:46:21.208Z,1643654781.208 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2022-01-31T18:46:21.210Z,1643654781.210 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2022-01-31T18:46:21.211Z,1643654781.211 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2022-01-31T18:46:21.211Z,1643654781.211 [LoopControl](DEBUG): Initialize LoopControlComponent.
2022-01-31T18:46:21.212Z,1643654781.212 [MissionManager](INFO): Loading Mission from file: Missions/Startup.xml
2022-01-31T18:46:21.224Z,1643654781.224 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2022-01-31T18:46:21.260Z,1643654781.260 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns="Tethys"
       xmlns:Control="Tethys/Control"
       xmlns:Guidance="Tethys/Guidance" 
       xmlns:Units="Tethys/Units"
       xmlns:Universal="Tethys/Universal"
       xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
       xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                           Tethys/Control http://okeanids.mbari.org/tethys/Xml/Control.xsd
                           Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                           Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                           Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
       Id="Startup">

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

    <Aggregate Id="StartupSatComms">

        <Sequence/>

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

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

    </Aggregate>

</Mission>


2022-01-31T18:46:21.261Z,1643654781.261 [MissionManager](INFO): Loading Mission from file: Missions/Default.xml
2022-01-31T18:46:21.317Z,1643654781.317 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2022-01-31T18:46:21.318Z,1643654781.318 [Default:A.Wait](DEBUG): Construct Wait.
2022-01-31T18:46:21.337Z,1643654781.337 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2022-01-31T18:46:21.368Z,1643654781.368 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2022-01-31T18:46:21.370Z,1643654781.370 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2022-01-31T18:46:21.400Z,1643654781.400 [Default:E.Execute](DEBUG): Construct Execute.
2022-01-31T18:46:21.403Z,1643654781.403 [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-01-31T18:46:21.424Z,1643654781.424 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,DropWeight,NAL9602,PowerOnly,Power24vConverter,RDI_Pathfinder,PAR_Licor,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,VerticalHomogeneityIndexCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,WorkSite,LBLNavigation,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter,
2022-01-31T18:46:21.436Z,1643654781.436 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2022-01-31T18:46:21.501Z,1643654781.501 [Power24vConverter](INFO): Powering up.
2022-01-31T18:46:21.540Z,1643654781.540 [Radio_Surface](INFO): Powering up
2022-01-31T18:46:21.541Z,1643654781.541 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-01-31T18:46:21.578Z,1643654781.578 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2022-01-31T18:46:21.584Z,1643654781.584 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2022-01-31T18:46:21.585Z,1643654781.585 [ElevatorServo](DEBUG): Initializing EZServoServo.
2022-01-31T18:46:21.592Z,1643654781.592 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2022-01-31T18:46:21.593Z,1643654781.593 [MassServo](DEBUG): Initializing EZServoServo.
2022-01-31T18:46:21.600Z,1643654781.600 [MassServo](DEBUG): Initializing MassServo.
2022-01-31T18:46:21.601Z,1643654781.601 [RudderServo](DEBUG): Initializing EZServoServo.
2022-01-31T18:46:21.612Z,1643654781.612 [RudderServo](DEBUG): Initializing RudderServo.
2022-01-31T18:46:21.613Z,1643654781.613 [ThrusterHE](DEBUG): Initializing EZServoServo.
2022-01-31T18:46:21.620Z,1643654781.620 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2022-01-31T18:46:21.868Z,1643654781.868 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-01-31T18:46:22.252Z,1643654782.252 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-01-31T18:46:22.572Z,1643654782.572 [RudderServo](ERROR): Rudder initialization uart error serial timeout
2022-01-31T18:46:22.572Z,1643654782.572 [RudderServo](FAULT): Rudder failed to initialize
2022-01-31T18:46:22.572Z,1643654782.572 [RudderServo] Communications Fault, FailCount= 1
2022-01-31T18:46:22.572Z,1643654782.572 [RudderServo](ERROR): Communications Fault
2022-01-31T18:46:22.576Z,1643654782.576 [CBIT](ERROR): Communications Fault in component: RudderServo
2022-01-31T18:46:22.645Z,1643654782.645 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-01-31T18:46:22.773Z,1643654782.773 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2022-01-31T18:46:22.773Z,1643654782.773 [RudderServo](INFO): Powering down
2022-01-31T18:46:23.052Z,1643654783.052 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-01-31T18:46:23.456Z,1643654783.456 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-01-31T18:46:23.464Z,1643654783.464 [RudderServo](DEBUG): Initializing EZServoServo.
2022-01-31T18:46:23.585Z,1643654783.585 [RudderServo](DEBUG): Initializing RudderServo.
2022-01-31T18:46:23.589Z,1643654783.589 [CBIT](INFO): Clearing failed state for component RudderServo
2022-01-31T18:46:23.589Z,1643654783.589 [RudderServo] No Fault, FailCount= 1
2022-01-31T18:46:23.860Z,1643654783.860 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-01-31T18:46:24.264Z,1643654784.264 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-01-31T18:46:24.736Z,1643654784.736 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-01-31T18:46:25.096Z,1643654785.096 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-01-31T18:46:25.500Z,1643654785.500 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-01-31T18:46:25.968Z,1643654785.968 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-01-31T18:46:26.320Z,1643654786.320 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-01-31T18:46:26.728Z,1643654786.728 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-01-31T18:46:27.128Z,1643654787.128 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-01-31T18:46:27.532Z,1643654787.532 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-01-31T18:46:27.920Z,1643654787.920 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-01-31T18:46:28.178Z,1643654788.178 [CTD_Seabird](ERROR): Device message queue exceeded the allowed limit.
2022-01-31T18:46:28.340Z,1643654788.340 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-01-31T18:46:28.744Z,1643654788.744 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-01-31T18:46:29.168Z,1643654789.168 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-01-31T18:46:29.540Z,1643654789.540 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-01-31T18:46:29.940Z,1643654789.940 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-01-31T18:46:48.904Z,1643654808.904 [NAL9602](INFO): Powering up NAL9602
2022-01-31T18:46:59.814Z,1643654819.814 [NAL9602](INFO): NAL9602 initialized
2022-01-31T18:47:05.517Z,1643654825.517 [SBIT](IMPORTANT): Beginning Startup BIT
2022-01-31T18:47:05.525Z,1643654825.525 [CBIT](IMPORTANT): Beginning ground fault scan
2022-01-31T18:47:06.342Z,1643654826.342 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T18:47:07.346Z,1643654827.346 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T18:47:08.350Z,1643654828.350 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T18:47:09.354Z,1643654829.354 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T18:47:10.358Z,1643654830.358 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T18:47:11.362Z,1643654831.362 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T18:47:12.365Z,1643654832.365 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T18:47:13.370Z,1643654833.370 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T18:47:14.374Z,1643654834.374 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T18:47:15.378Z,1643654835.378 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T18:47:16.377Z,1643654836.377 [NAL9602](INFO): SBD MO Status=0, MOMSN=35474, MT Status=0, MTMSN=0
2022-01-31T18:47:16.378Z,1643654836.378 [NAL9602](INFO): No messages in MT queue
2022-01-31T18:47:16.381Z,1643654836.381 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T18:47:16.461Z,1643654836.461 [CBIT](IMPORTANT): Ground fault detected
mA:
CHAN A0 (Batt): 0.038848
CHAN A1 (24V): 0.082388
CHAN A2 (12V): 0.029254
CHAN A3 (5V): 0.007992
CHAN B0 (3.3V): 0.004934
CHAN B1 (3.15aV): 0.004512
CHAN B2 (3.15bV): 0.003962
CHAN B3 (GND): -0.010560
OPEN: 0.005912
Full Scale: +/- 1 mA
2022-01-31T18:47:55.985Z,1643654875.985 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,184757.00,A,4128.91614,N,07053.34581,W,0.816,79.49,310122,,,A*45
2022-01-31T18:47:55.988Z,1643654875.988 [NAL9602](INFO): GPS fix at 20220131T184757: (41.481936, -70.889097)
2022-01-31T18:47:56.049Z,1643654876.049 [LBLNavigation](INFO): Reset ping filters
2022-01-31T18:47:56.049Z,1643654876.049 [LBLNavigation](INFO): Reset fix filter
2022-01-31T18:47:59.626Z,1643654879.626 [SBIT](IMPORTANT): SBIT PASSED
2022-01-31T18:47:59.626Z,1643654879.626 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2022-01-31T18:47:59.627Z,1643654879.627 [SBIT](IMPORTANT): BuoyancyServo.fastPumpCoefficient=2 none;

2022-01-31T18:47:59.627Z,1643654879.627 [SBIT](IMPORTANT): BuoyancyServo.velocity=800 none;

2022-01-31T18:47:59.628Z,1643654879.628 [SBIT](IMPORTANT): CBIT.gfScanTimeout=2 hour;

2022-01-31T18:47:59.628Z,1643654879.628 [SBIT](IMPORTANT): CTD_Seabird.loadAtStartup=1 bool;

2022-01-31T18:47:59.628Z,1643654879.628 [SBIT](IMPORTANT): DataOverHttps.loadAtStartup=1 bool;

2022-01-31T18:47:59.628Z,1643654879.628 [SBIT](IMPORTANT): Depth_Keller.loadAtStartup=0 bool;

2022-01-31T18:47:59.628Z,1643654879.628 [SBIT](IMPORTANT): Express linearApproximation CTD_Seabird.bin_median_sea_water_salinity 0.050000 practical_salinity_unit;

2022-01-31T18:47:59.628Z,1643654879.628 [SBIT](IMPORTANT): Express linearApproximation CTD_Seabird.bin_median_sea_water_temperature 0.500000 celsius;

2022-01-31T18:47:59.628Z,1643654879.628 [SBIT](IMPORTANT): Express none WetLabsSeaOWL_UV_A.Output700;

2022-01-31T18:47:59.629Z,1643654879.629 [SBIT](IMPORTANT): Express none WetLabsSeaOWL_UV_A.OutputFDOM;

2022-01-31T18:47:59.629Z,1643654879.629 [SBIT](IMPORTANT): Express none WetLabsSeaOWL_UV_A.concentration_of_colored_dissolved_organic_matter_in_sea_water;

2022-01-31T18:47:59.629Z,1643654879.629 [SBIT](IMPORTANT): Express none WetLabsSeaOWL_UV_A.mass_concentration_of_chlorophyll_in_sea_water;

2022-01-31T18:47:59.629Z,1643654879.629 [SBIT](IMPORTANT): Express none WetLabsSeaOWL_UV_A.mass_concentration_of_petroleum_hydrocarbons_in_sea_water;

2022-01-31T18:47:59.629Z,1643654879.629 [SBIT](IMPORTANT): Express none concentration_of_colored_dissolved_organic_matter_in_sea_water;

2022-01-31T18:47:59.629Z,1643654879.629 [SBIT](IMPORTANT): Express none mass_concentration_of_chlorophyll_in_sea_water;

2022-01-31T18:47:59.629Z,1643654879.629 [SBIT](IMPORTANT): Express linearApproximation platform_average_current 0.500000 ampere;

2022-01-31T18:47:59.629Z,1643654879.629 [SBIT](IMPORTANT): Micromodem.loadAtStartup=0 bool;

2022-01-31T18:47:59.630Z,1643654879.630 [SBIT](IMPORTANT): NAL9602.fastGPSFix=1 bool;

2022-01-31T18:47:59.630Z,1643654879.630 [SBIT](IMPORTANT): PAR_Licor.loadAtStartup=1 bool;

2022-01-31T18:47:59.630Z,1643654879.630 [SBIT](IMPORTANT): RDI_Pathfinder.loadAtStartup=1 bool;

2022-01-31T18:47:59.630Z,1643654879.630 [SBIT](IMPORTANT): RDI_PathfinderUp.loadAtStartup=0 bool;

2022-01-31T18:47:59.630Z,1643654879.630 [SBIT](IMPORTANT): Radio_Surface.loadAtStartup=1 bool;

2022-01-31T18:47:59.630Z,1643654879.630 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=154 cubic_centimeter;

2022-01-31T18:47:59.630Z,1643654879.630 [SBIT](IMPORTANT): VerticalControl.massDefault=6 millimeter;

2022-01-31T18:47:59.630Z,1643654879.630 [SBIT](IMPORTANT): WetLabsSeaOWL_UV_A.loadAtStartup=1 bool;

2022-01-31T18:48:00.053Z,1643654880.053 [WorkSite](INFO): Already have valid position. Ignoring workSite position from Data/workSite.cfg
2022-01-31T18:48:00.058Z,1643654880.058 [MissionManager](IMPORTANT): Started mission Startup
2022-01-31T18:48:00.058Z,1643654880.058 [Startup] Running Loop=1
2022-01-31T18:48:00.058Z,1643654880.058 [Startup](DEBUG): Aggregate::initialize Startup
2022-01-31T18:48:00.059Z,1643654880.059 [Startup:A.GoToSurface] Running Loop=1
2022-01-31T18:48:00.059Z,1643654880.059 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2022-01-31T18:48:00.059Z,1643654880.059 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2022-01-31T18:48:00.060Z,1643654880.060 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2022-01-31T18:48:00.060Z,1643654880.060 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2022-01-31T18:48:00.061Z,1643654880.061 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2022-01-31T18:48:00.061Z,1643654880.061 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2022-01-31T18:48:00.062Z,1643654880.062 [Startup:StartupSatComms] Running Loop=1
2022-01-31T18:48:00.062Z,1643654880.062 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2022-01-31T18:48:00.063Z,1643654880.063 [Startup:StartupSatComms:A] Running Loop=1
2022-01-31T18:48:00.441Z,1643654880.441 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2022-01-31T18:48:02.040Z,1643654882.040 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,184803.00,A,4128.91620,N,07053.33895,W,0.428,79.49,310122,,,A*42
2022-01-31T18:48:02.043Z,1643654882.043 [NAL9602](INFO): GPS fix at 20220131T184803: (41.481937, -70.888982)
2022-01-31T18:48:02.098Z,1643654882.098 [Startup:StartupSatComms:A] Stopped
2022-01-31T18:48:02.098Z,1643654882.098 [Startup:StartupSatComms:B] Running Loop=1
2022-01-31T18:48:02.473Z,1643654882.473 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2022-01-31T18:48:16.656Z,1643654896.656 [NAL9602](INFO): SBD MO Status=1, MOMSN=35475, MT Status=0, MTMSN=0
2022-01-31T18:48:16.704Z,1643654896.704 [NAL9602](INFO): Sent 53 bytes from file Logs/20220131T182606/Courier0013.lzma
2022-01-31T18:48:16.704Z,1643654896.704 [NAL9602](INFO): Packets left to send: 0
2022-01-31T18:48:28.043Z,1643654908.043 [NAL9602](INFO): SBD MO Status=1, MOMSN=35476, MT Status=0, MTMSN=0
2022-01-31T18:48:28.092Z,1643654908.092 [NAL9602](INFO): Sent 184 bytes from file Logs/20220131T184610/Courier0000.lzma
2022-01-31T18:48:28.092Z,1643654908.092 [NAL9602](INFO): Packets left to send: 1
2022-01-31T18:48:36.290Z,1643654916.290 [NAL9602](INFO): SBD MO Status=1, MOMSN=35477, MT Status=0, MTMSN=0
2022-01-31T18:48:36.340Z,1643654916.340 [NAL9602](INFO): Sent 69 bytes from file Logs/20220131T184610/Courier0000.lzma
2022-01-31T18:48:36.340Z,1643654916.340 [NAL9602](INFO): Packets left to send: 0
2022-01-31T18:48:45.704Z,1643654925.704 [NAL9602](INFO): SBD MO Status=1, MOMSN=35478, MT Status=0, MTMSN=0
2022-01-31T18:48:45.764Z,1643654925.764 [NAL9602](INFO): Sent 184 bytes from file Logs/20220131T182606/Express0014.lzma
2022-01-31T18:48:45.764Z,1643654925.764 [NAL9602](INFO): Packets left to send: 2
2022-01-31T18:48:55.162Z,1643654935.162 [NAL9602](INFO): SBD MO Status=1, MOMSN=35479, MT Status=0, MTMSN=0
2022-01-31T18:48:55.215Z,1643654935.215 [NAL9602](INFO): Sent 184 bytes from file Logs/20220131T182606/Express0014.lzma
2022-01-31T18:48:55.215Z,1643654935.215 [NAL9602](INFO): Packets left to send: 1
2022-01-31T18:49:02.256Z,1643654942.256 [NAL9602](INFO): SBD MO Status=1, MOMSN=35480, MT Status=0, MTMSN=0
2022-01-31T18:49:02.308Z,1643654942.308 [NAL9602](INFO): Sent 18 bytes from file Logs/20220131T182606/Express0014.lzma
2022-01-31T18:49:02.308Z,1643654942.308 [NAL9602](INFO): Packets left to send: 0
2022-01-31T18:49:02.332Z,1643654942.332 [Startup:StartupSatComms:B](INFO): Timed out from 2022-01-31T18:48:02.1Z
2022-01-31T18:49:02.333Z,1643654942.333 [Startup:StartupSatComms:B] Stopped
2022-01-31T18:49:02.333Z,1643654942.333 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2022-01-31T18:49:02.333Z,1643654942.333 [Startup:StartupSatComms] Stopped
2022-01-31T18:49:02.333Z,1643654942.333 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2022-01-31T18:49:02.334Z,1643654942.334 [Startup](INFO): Completed Startup
2022-01-31T18:49:02.334Z,1643654942.334 [MissionManager](INFO): Startup is completed.
2022-01-31T18:49:02.334Z,1643654942.334 [MissionManager](INFO): Uninitializing Mission Startup
2022-01-31T18:49:02.334Z,1643654942.334 [Startup] Stopped
2022-01-31T18:49:02.334Z,1643654942.334 [Startup](DEBUG): Aggregate::uninitialize Startup
2022-01-31T18:49:02.334Z,1643654942.334 [Startup:A.GoToSurface] Stopped
2022-01-31T18:49:02.334Z,1643654942.334 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2022-01-31T18:49:03.187Z,1643654943.187 [MissionManager](IMPORTANT): Started mission Default
2022-01-31T18:49:03.187Z,1643654943.187 [Default] Running Loop=1
2022-01-31T18:49:03.187Z,1643654943.187 [Default](DEBUG): Aggregate::initialize Default
2022-01-31T18:49:03.187Z,1643654943.187 [Default:B.GoToSurface] Running Loop=1
2022-01-31T18:49:03.188Z,1643654943.188 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2022-01-31T18:49:03.188Z,1643654943.188 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2022-01-31T18:49:03.188Z,1643654943.188 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2022-01-31T18:49:03.188Z,1643654943.188 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2022-01-31T18:49:03.189Z,1643654943.189 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2022-01-31T18:49:03.189Z,1643654943.189 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2022-01-31T18:49:03.189Z,1643654943.189 [Default:A.Wait] Running Loop=1
2022-01-31T18:49:03.189Z,1643654943.189 [Default:A.Wait](DEBUG): Initialize Wait Component.
2022-01-31T18:49:11.468Z,1643654951.468 [NAL9602](INFO): SBD MO Status=1, MOMSN=35481, MT Status=0, MTMSN=0
2022-01-31T18:49:11.516Z,1643654951.516 [NAL9602](INFO): Sent 184 bytes from file Logs/20220131T184610/Express0001.lzma
2022-01-31T18:49:11.516Z,1643654951.516 [NAL9602](INFO): Packets left to send: 6
2022-01-31T18:49:16.310Z,1643654956.310 [Default:A.Wait](INFO): Done Waiting.
2022-01-31T18:49:16.310Z,1643654956.310 [Default:A.Wait] Stopped
2022-01-31T18:49:16.310Z,1643654956.310 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2022-01-31T18:49:16.713Z,1643654956.713 [Default:CheckIn] Running Loop=1
2022-01-31T18:49:16.714Z,1643654956.714 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2022-01-31T18:49:16.714Z,1643654956.714 [Default:CheckIn:Read_GPS] Running Loop=1
2022-01-31T18:49:17.118Z,1643654957.118 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2022-01-31T18:49:18.742Z,1643654958.742 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,184919.00,A,4128.91363,N,07053.35331,W,0.603,79.49,310122,,,A*42
2022-01-31T18:49:18.748Z,1643654958.748 [NAL9602](INFO): GPS fix at 20220131T184919: (41.481894, -70.889222)
2022-01-31T18:49:18.772Z,1643654958.772 [Default:CheckIn:Read_GPS] Stopped
2022-01-31T18:49:18.772Z,1643654958.772 [Default:CheckIn:Read_Iridium] Running Loop=1
2022-01-31T18:49:19.158Z,1643654959.158 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2022-01-31T18:49:43.020Z,1643654983.020 [NAL9602](INFO): SBD MO Status=2, MOMSN=35482, MT Status=2, MTMSN=0
2022-01-31T18:49:43.020Z,1643654983.020 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2022-01-31T18:50:03.277Z,1643655003.277 [NAL9602](INFO): SBD MO Status=1, MOMSN=35482, MT Status=0, MTMSN=0
2022-01-31T18:50:03.324Z,1643655003.324 [NAL9602](INFO): Sent 73 bytes from file Logs/20220131T184610/Courier0004.lzma
2022-01-31T18:50:03.325Z,1643655003.325 [NAL9602](INFO): Packets left to send: 0
2022-01-31T18:50:13.239Z,1643655013.239 [NAL9602](INFO): SBD MO Status=1, MOMSN=35483, MT Status=0, MTMSN=0
2022-01-31T18:50:13.292Z,1643655013.292 [NAL9602](INFO): Sent 184 bytes from file Logs/20220131T184610/Express0001.lzma
2022-01-31T18:50:13.292Z,1643655013.292 [NAL9602](INFO): Packets left to send: 5
2022-01-31T18:50:20.747Z,1643655020.747 [NAL9602](INFO): SBD MO Status=1, MOMSN=35484, MT Status=0, MTMSN=0
2022-01-31T18:50:20.796Z,1643655020.796 [NAL9602](INFO): Sent 184 bytes from file Logs/20220131T184610/Express0001.lzma
2022-01-31T18:50:20.796Z,1643655020.796 [NAL9602](INFO): Packets left to send: 4
2022-01-31T18:50:29.653Z,1643655029.653 [NAL9602](INFO): SBD MO Status=1, MOMSN=35485, MT Status=0, MTMSN=0
2022-01-31T18:50:29.709Z,1643655029.709 [NAL9602](INFO): Sent 184 bytes from file Logs/20220131T184610/Express0001.lzma
2022-01-31T18:50:29.709Z,1643655029.709 [NAL9602](INFO): Packets left to send: 3
2022-01-31T18:50:38.714Z,1643655038.714 [NAL9602](INFO): SBD MO Status=1, MOMSN=35486, MT Status=0, MTMSN=0
2022-01-31T18:50:38.768Z,1643655038.768 [NAL9602](INFO): Sent 184 bytes from file Logs/20220131T184610/Express0001.lzma
2022-01-31T18:50:38.768Z,1643655038.768 [NAL9602](INFO): Packets left to send: 2
2022-01-31T18:50:47.377Z,1643655047.377 [NAL9602](INFO): SBD MO Status=1, MOMSN=35487, MT Status=0, MTMSN=0
2022-01-31T18:50:47.424Z,1643655047.424 [NAL9602](INFO): Sent 184 bytes from file Logs/20220131T184610/Express0001.lzma
2022-01-31T18:50:47.424Z,1643655047.424 [NAL9602](INFO): Packets left to send: 1
2022-01-31T18:50:54.443Z,1643655054.443 [NAL9602](INFO): SBD MO Status=1, MOMSN=35488, MT Status=0, MTMSN=0
2022-01-31T18:50:54.497Z,1643655054.497 [NAL9602](INFO): Sent 140 bytes from file Logs/20220131T184610/Express0001.lzma
2022-01-31T18:50:54.497Z,1643655054.497 [NAL9602](INFO): Packets left to send: 0
2022-01-31T18:51:03.100Z,1643655063.100 [NAL9602](INFO): SBD MO Status=1, MOMSN=35489, MT Status=0, MTMSN=0
2022-01-31T18:51:03.152Z,1643655063.152 [NAL9602](INFO): Sent 184 bytes from file Logs/20220131T184610/Express0005.lzma
2022-01-31T18:51:03.152Z,1643655063.152 [NAL9602](INFO): Packets left to send: 1
2022-01-31T18:51:11.386Z,1643655071.386 [NAL9602](INFO): SBD MO Status=1, MOMSN=35490, MT Status=0, MTMSN=0
2022-01-31T18:51:11.436Z,1643655071.436 [NAL9602](INFO): Sent 56 bytes from file Logs/20220131T184610/Express0005.lzma
2022-01-31T18:51:11.436Z,1643655071.436 [NAL9602](INFO): Packets left to send: 0
2022-01-31T18:51:19.513Z,1643655079.513 [NAL9602](INFO): SBD MO Status=0, MOMSN=35491, MT Status=0, MTMSN=0
2022-01-31T18:51:19.590Z,1643655079.590 [Default:CheckIn:Read_Iridium] Stopped
2022-01-31T18:51:19.590Z,1643655079.590 [Default:CheckIn:C.Wait] Running Loop=1
2022-01-31T18:51:19.590Z,1643655079.590 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2022-01-31T18:51:41.506Z,1643655101.506 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004746
2022-01-31T18:51:50.214Z,1643655110.214 [NAL9602](INFO): Not Powering down - fast GPS
2022-01-31T18:52:40.724Z,1643655160.724 [CommandExec](IMPORTANT): got command gfscan
2022-01-31T18:52:40.830Z,1643655160.830 [CBIT](IMPORTANT): Beginning ground fault scan
2022-01-31T18:52:41.728Z,1643655161.728 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T18:52:42.730Z,1643655162.730 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T18:52:43.736Z,1643655163.736 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T18:52:44.738Z,1643655164.738 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T18:52:45.744Z,1643655165.744 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T18:52:46.746Z,1643655166.746 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T18:52:47.750Z,1643655167.750 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T18:52:48.754Z,1643655168.754 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T18:52:49.757Z,1643655169.757 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T18:52:50.762Z,1643655170.762 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T18:52:51.651Z,1643655171.651 [CBIT](IMPORTANT): Ground fault detected
mA:
CHAN A0 (Batt): 0.035720
CHAN A1 (24V): 0.074551
CHAN A2 (12V): 0.023654
CHAN A3 (5V): 0.005159
CHAN B0 (3.3V): 0.003975
CHAN B1 (3.15aV): 0.002995
CHAN B2 (3.15bV): 0.003629
CHAN B3 (GND): -0.009567
OPEN: 0.005323
Full Scale: +/- 1 mA
2022-01-31T18:53:23.979Z,1643655203.979 [CommandExec](IMPORTANT): got command failComponent hardware AHRS_M2
2022-01-31T18:53:23.979Z,1643655203.979 [AHRS_M2] Hardware Fault, FailCount= 1
2022-01-31T18:53:23.979Z,1643655203.979 [AHRS_M2](ERROR): Hardware Fault
2022-01-31T18:53:23.979Z,1643655203.979 [CommandExec](IMPORTANT): AHRS_M2 failureMode is Hardware Fault
2022-01-31T18:53:24.058Z,1643655204.058 [CBIT](ERROR): Hardware Fault in component: AHRS_M2
2022-01-31T18:53:24.336Z,1643655204.336 [AHRS_M2](INFO): Powering down
2022-01-31T18:53:25.180Z,1643655205.180 [CBIT](INFO): Clearing failed state for component AHRS_M2
2022-01-31T18:53:25.180Z,1643655205.180 [AHRS_M2] No Fault, FailCount= 1
2022-01-31T18:53:25.548Z,1643655205.548 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2022-01-31T18:53:38.661Z,1643655218.661 [CommandExec](IMPORTANT): got command gfscan
2022-01-31T18:53:38.926Z,1643655218.926 [CBIT](IMPORTANT): Beginning ground fault scan
2022-01-31T18:53:38.954Z,1643655218.954 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T18:53:39.957Z,1643655219.957 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T18:53:40.979Z,1643655220.979 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T18:53:41.340Z,1643655221.340 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6.
2022-01-31T18:53:41.343Z,1643655221.343 [BPC1](INFO): Received data from all battery sticks.
2022-01-31T18:53:41.981Z,1643655221.981 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T18:53:42.990Z,1643655222.990 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T18:53:43.989Z,1643655223.989 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T18:53:44.153Z,1643655224.153 [AHRS_M2](FAULT): Failed to acquire valid data within timeout.
2022-01-31T18:53:44.153Z,1643655224.153 [AHRS_M2] Data Fault, FailCount= 1
2022-01-31T18:53:44.153Z,1643655224.153 [AHRS_M2](ERROR): Data Fault
2022-01-31T18:53:44.181Z,1643655224.181 [CBIT](ERROR): Data Fault in component: AHRS_M2
2022-01-31T18:53:44.536Z,1643655224.536 [AHRS_M2](INFO): Powering down
2022-01-31T18:53:45.002Z,1643655225.002 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T18:53:45.382Z,1643655225.382 [CBIT](INFO): Clearing failed state for component AHRS_M2
2022-01-31T18:53:45.382Z,1643655225.382 [AHRS_M2] No Fault, FailCount= 1
2022-01-31T18:53:45.749Z,1643655225.749 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2022-01-31T18:53:46.005Z,1643655226.005 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T18:53:47.010Z,1643655227.010 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T18:53:48.013Z,1643655228.013 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T18:53:49.061Z,1643655229.061 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T18:53:49.862Z,1643655229.862 [CBIT](IMPORTANT): Ground fault detected
mA:
CHAN A0 (Batt): 0.031435
CHAN A1 (24V): 0.068975
CHAN A2 (12V): 0.024838
CHAN A3 (5V): 0.005913
CHAN B0 (3.3V): 0.003957
CHAN B1 (3.15aV): 0.004109
CHAN B2 (3.15bV): 0.003998
CHAN B3 (GND): -0.009344
OPEN: 0.005638
Full Scale: +/- 1 mA
2022-01-31T18:56:20.122Z,1643655380.122 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2022-01-31T18:56:20.122Z,1643655380.122 [Default:CheckIn:C.Wait] Stopped
2022-01-31T18:56:20.122Z,1643655380.122 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2022-01-31T18:56:20.122Z,1643655380.122 [Default:CheckIn:D] Running Loop=1
2022-01-31T18:56:20.518Z,1643655380.518 [Default:CheckIn:D] Stopped
2022-01-31T18:56:20.518Z,1643655380.518 [Default:CheckIn:E] Running Loop=1
2022-01-31T18:56:20.917Z,1643655380.917 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 7.288846 min 
2022-01-31T18:56:20.917Z,1643655380.917 [Default:CheckIn:E] Stopped
2022-01-31T18:56:20.917Z,1643655380.917 [Default:CheckIn](INFO): Completed Default:CheckIn
2022-01-31T18:56:20.917Z,1643655380.917 [Default:CheckIn] Stopped
2022-01-31T18:56:20.917Z,1643655380.917 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2022-01-31T18:56:20.917Z,1643655380.917 [Default:CheckIn](INFO): Running loop #2
2022-01-31T18:56:20.917Z,1643655380.917 [Default:CheckIn] Running Loop=2
2022-01-31T18:56:20.918Z,1643655380.918 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2022-01-31T18:56:20.918Z,1643655380.918 [Default:CheckIn:Read_GPS] Running Loop=1
2022-01-31T18:56:22.920Z,1643655382.920 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,185625.00,A,4128.91255,N,07053.42195,W,0.583,183.35,310122,,,A*7F
2022-01-31T18:56:22.922Z,1643655382.922 [NAL9602](INFO): GPS fix at 20220131T185625: (41.481876, -70.890366)
2022-01-31T18:56:22.934Z,1643655382.934 [Default:CheckIn:Read_GPS] Stopped
2022-01-31T18:56:22.934Z,1643655382.934 [Default:CheckIn:Read_Iridium] Running Loop=1
2022-01-31T18:56:26.652Z,1643655386.652 [DataOverHttps](INFO): Sending 202 bytes from file Logs/20220131T184610/Courier0007.lzma
2022-01-31T18:56:27.654Z,1643655387.654 [DataOverHttps](INFO): Moved sent file to Logs/20220131T184610/Courier0007.lzma.bak
2022-01-31T18:56:27.654Z,1643655387.654 [DataOverHttps](INFO): SBD MOMSN=1375964
2022-01-31T18:56:36.697Z,1643655396.697 [DataOverHttps](INFO): Sending 554 bytes from file Logs/20220131T184610/Express0008.lzma
2022-01-31T18:56:37.697Z,1643655397.697 [DataOverHttps](INFO): Moved sent file to Logs/20220131T184610/Express0008.lzma.bak
2022-01-31T18:56:37.697Z,1643655397.697 [DataOverHttps](INFO): SBD MOMSN=1375967
2022-01-31T18:56:39.499Z,1643655399.499 [Default:CheckIn:Read_Iridium] Stopped
2022-01-31T18:56:39.499Z,1643655399.499 [Default:CheckIn:C.Wait] Running Loop=1
2022-01-31T18:56:39.499Z,1643655399.499 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2022-01-31T18:56:49.988Z,1643655409.988 [NAL9602](INFO): SBD MO Status=2, MOMSN=35492, MT Status=2, MTMSN=0
2022-01-31T18:56:49.989Z,1643655409.989 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2022-01-31T18:56:57.259Z,1643655417.259 [NAL9602](INFO): SBD MO Status=0, MOMSN=35492, MT Status=0, MTMSN=0
2022-01-31T18:56:57.259Z,1643655417.259 [NAL9602](INFO): No messages in MT queue
2022-01-31T18:57:27.961Z,1643655447.961 [NAL9602](INFO): Not Powering down - fast GPS
2022-01-31T18:57:41.125Z,1643655461.125 [CommandExec](IMPORTANT): got command get depth
2022-01-31T18:57:41.125Z,1643655461.125 [CommandExec](IMPORTANT): depth 0.198439 m
2022-01-31T19:01:19.764Z,1643655679.764 [CommandExec](IMPORTANT): got command failComponent hardware NAL9602
2022-01-31T19:01:19.764Z,1643655679.764 [NAL9602] Hardware Fault, FailCount= 1
2022-01-31T19:01:19.764Z,1643655679.764 [NAL9602](ERROR): Hardware Fault
2022-01-31T19:01:19.765Z,1643655679.765 [CommandExec](IMPORTANT): NAL9602 failureMode is Hardware Fault
2022-01-31T19:01:19.865Z,1643655679.865 [NAL9602](INFO): Powering down
2022-01-31T19:01:19.934Z,1643655679.934 [CBIT](ERROR): Hardware Fault in component: NAL9602
2022-01-31T19:01:20.702Z,1643655680.702 [CBIT](INFO): Clearing failed state for component NAL9602
2022-01-31T19:01:20.702Z,1643655680.702 [NAL9602] No Fault, FailCount= 1
2022-01-31T19:01:23.416Z,1643655683.416 [CommandExec](IMPORTANT): got command failComponent hardware NAL9602
2022-01-31T19:01:23.416Z,1643655683.416 [NAL9602] Hardware Fault, FailCount= 2
2022-01-31T19:01:23.416Z,1643655683.416 [NAL9602](ERROR): Hardware Fault
2022-01-31T19:01:23.417Z,1643655683.417 [CommandExec](IMPORTANT): NAL9602 failureMode is Hardware Fault
2022-01-31T19:01:23.504Z,1643655683.504 [NAL9602](INFO): Powering down
2022-01-31T19:01:23.527Z,1643655683.527 [CBIT](ERROR): Hardware Fault in component: NAL9602
2022-01-31T19:01:24.353Z,1643655684.353 [CBIT](INFO): Clearing failed state for component NAL9602
2022-01-31T19:01:24.353Z,1643655684.353 [NAL9602] No Fault, FailCount= 2
2022-01-31T19:01:26.285Z,1643655686.285 [CommandExec](IMPORTANT): got command failComponent hardware NAL9602
2022-01-31T19:01:26.285Z,1643655686.285 [NAL9602] Hardware Fault, FailCount= 3
2022-01-31T19:01:26.285Z,1643655686.285 [NAL9602](ERROR): Hardware Fault
2022-01-31T19:01:26.285Z,1643655686.285 [CommandExec](IMPORTANT): NAL9602 failureMode is Hardware Fault
2022-01-31T19:01:26.339Z,1643655686.339 [NAL9602](INFO): Powering down
2022-01-31T19:01:26.405Z,1643655686.405 [CBIT](ERROR): Hardware Fault in component: NAL9602
2022-01-31T19:01:27.162Z,1643655687.162 [CBIT](INFO): Clearing failed state for component NAL9602
2022-01-31T19:01:27.162Z,1643655687.162 [NAL9602] No Fault, FailCount= 3
2022-01-31T19:01:28.680Z,1643655688.680 [CommandExec](IMPORTANT): got command failComponent hardware NAL9602
2022-01-31T19:01:28.681Z,1643655688.681 [NAL9602] Hardware Fault, FailCount= 4
2022-01-31T19:01:28.681Z,1643655688.681 [NAL9602](ERROR): Hardware Fault
2022-01-31T19:01:28.681Z,1643655688.681 [CommandExec](IMPORTANT): NAL9602 failureMode is Hardware Fault
2022-01-31T19:01:28.753Z,1643655688.753 [NAL9602](INFO): Powering down
2022-01-31T19:01:28.810Z,1643655688.810 [CBIT](ERROR): Hardware Fault in component: NAL9602
2022-01-31T19:01:29.596Z,1643655689.596 [CBIT](INFO): Clearing failed state for component NAL9602
2022-01-31T19:01:29.596Z,1643655689.596 [NAL9602] No Fault, FailCount= 4
2022-01-31T19:01:30.868Z,1643655690.868 [CommandExec](IMPORTANT): got command failComponent hardware NAL9602
2022-01-31T19:01:30.868Z,1643655690.868 [NAL9602] Hardware Fault, FailCount= 5
2022-01-31T19:01:30.868Z,1643655690.868 [NAL9602](ERROR): Hardware Fault
2022-01-31T19:01:30.869Z,1643655690.869 [CommandExec](IMPORTANT): NAL9602 failureMode is Hardware Fault
2022-01-31T19:01:31.177Z,1643655691.177 [NAL9602](INFO): Powering down
2022-01-31T19:01:31.237Z,1643655691.237 [CBIT](ERROR): Hardware Fault in component: NAL9602
2022-01-31T19:01:31.237Z,1643655691.237 [CBIT](CRITICAL): Hardware Fault in component: NAL9602
2022-01-31T19:01:31.604Z,1643655691.604 [CommandExec](FAULT): Scheduling is paused
2022-01-31T19:01:31.604Z,1643655691.604 [CBIT](INFO): Critical error at 20220131T190131
2022-01-31T19:01:31.605Z,1643655691.605 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2022-01-31T19:01:40.115Z,1643655700.115 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2022-01-31T19:01:40.115Z,1643655700.115 [Default:CheckIn:C.Wait] Stopped
2022-01-31T19:01:40.115Z,1643655700.115 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2022-01-31T19:01:40.115Z,1643655700.115 [Default:CheckIn:D] Running Loop=1
2022-01-31T19:01:40.487Z,1643655700.487 [Default:CheckIn:D] Stopped
2022-01-31T19:01:40.487Z,1643655700.487 [Default:CheckIn:E] Running Loop=1
2022-01-31T19:01:40.900Z,1643655700.900 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 12.621658 min 
2022-01-31T19:01:40.900Z,1643655700.900 [Default:CheckIn:E] Stopped
2022-01-31T19:01:40.900Z,1643655700.900 [Default:CheckIn](INFO): Completed Default:CheckIn
2022-01-31T19:01:40.900Z,1643655700.900 [Default:CheckIn] Stopped
2022-01-31T19:01:40.900Z,1643655700.900 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2022-01-31T19:01:40.900Z,1643655700.900 [Default:CheckIn](INFO): Running loop #3
2022-01-31T19:01:40.901Z,1643655700.901 [Default:CheckIn] Running Loop=3
2022-01-31T19:01:40.901Z,1643655700.901 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2022-01-31T19:01:40.901Z,1643655700.901 [Default:CheckIn:Read_GPS] Running Loop=1
2022-01-31T19:01:50.817Z,1643655710.817 [CommandExec](IMPORTANT): got command gfscan
2022-01-31T19:01:51.027Z,1643655711.027 [CBIT](IMPORTANT): Beginning ground fault scan
2022-01-31T19:01:51.082Z,1643655711.082 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T19:01:52.085Z,1643655712.085 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T19:01:53.090Z,1643655713.090 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T19:01:54.093Z,1643655714.093 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T19:01:55.098Z,1643655715.098 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T19:01:56.101Z,1643655716.101 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T19:01:57.106Z,1643655717.106 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T19:01:58.110Z,1643655718.110 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T19:01:59.114Z,1643655719.114 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T19:02:00.118Z,1643655720.118 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T19:02:01.122Z,1643655721.122 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T19:02:01.966Z,1643655721.966 [CBIT](IMPORTANT): Ground fault detected
mA:
CHAN A0 (Batt): 0.040660
CHAN A1 (24V): 0.079370
CHAN A2 (12V): 0.026277
CHAN A3 (5V): 0.006553
CHAN B0 (3.3V): 0.003540
CHAN B1 (3.15aV): 0.003972
CHAN B2 (3.15bV): 0.003936
CHAN B3 (GND): -0.010635
OPEN: 0.005632
Full Scale: +/- 1 mA
2022-01-31T19:02:14.481Z,1643655734.481 [CommandExec](IMPORTANT): got command failComponent hardware AHRS_M2
2022-01-31T19:02:14.481Z,1643655734.481 [AHRS_M2] Hardware Fault, FailCount= 1
2022-01-31T19:02:14.481Z,1643655734.481 [AHRS_M2](ERROR): Hardware Fault
2022-01-31T19:02:14.481Z,1643655734.481 [CommandExec](IMPORTANT): AHRS_M2 failureMode is Hardware Fault
2022-01-31T19:02:14.800Z,1643655734.800 [AHRS_M2](INFO): Powering down
2022-01-31T19:02:14.897Z,1643655734.897 [CBIT](ERROR): Hardware Fault in component: AHRS_M2
2022-01-31T19:02:15.650Z,1643655735.650 [CBIT](INFO): Clearing failed state for component AHRS_M2
2022-01-31T19:02:15.650Z,1643655735.650 [AHRS_M2] No Fault, FailCount= 1
2022-01-31T19:02:16.022Z,1643655736.022 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2022-01-31T19:02:16.041Z,1643655736.041 [CommandExec](IMPORTANT): got command failComponent hardware AHRS_M2
2022-01-31T19:02:16.042Z,1643655736.042 [AHRS_M2] Hardware Fault, FailCount= 2
2022-01-31T19:02:16.042Z,1643655736.042 [AHRS_M2](ERROR): Hardware Fault
2022-01-31T19:02:16.042Z,1643655736.042 [CommandExec](IMPORTANT): AHRS_M2 failureMode is Hardware Fault
2022-01-31T19:02:16.124Z,1643655736.124 [CBIT](ERROR): Hardware Fault in component: AHRS_M2
2022-01-31T19:02:16.416Z,1643655736.416 [AHRS_M2](INFO): Powering down
2022-01-31T19:02:17.240Z,1643655737.240 [CommandExec](IMPORTANT): got command failComponent hardware AHRS_M2
2022-01-31T19:02:17.240Z,1643655737.240 [CommandExec](IMPORTANT): AHRS_M2 failureMode is Hardware Fault
2022-01-31T19:02:17.288Z,1643655737.288 [CBIT](INFO): Clearing failed state for component AHRS_M2
2022-01-31T19:02:17.288Z,1643655737.288 [AHRS_M2] No Fault, FailCount= 2
2022-01-31T19:02:17.628Z,1643655737.628 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2022-01-31T19:02:18.488Z,1643655738.488 [CommandExec](IMPORTANT): got command failComponent hardware AHRS_M2
2022-01-31T19:02:18.488Z,1643655738.488 [AHRS_M2] Hardware Fault, FailCount= 3
2022-01-31T19:02:18.488Z,1643655738.488 [AHRS_M2](ERROR): Hardware Fault
2022-01-31T19:02:18.489Z,1643655738.489 [CommandExec](IMPORTANT): AHRS_M2 failureMode is Hardware Fault
2022-01-31T19:02:18.840Z,1643655738.840 [AHRS_M2](INFO): Powering down
2022-01-31T19:02:18.936Z,1643655738.936 [CBIT](ERROR): Hardware Fault in component: AHRS_M2
2022-01-31T19:02:19.679Z,1643655739.679 [CBIT](INFO): Clearing failed state for component AHRS_M2
2022-01-31T19:02:19.679Z,1643655739.679 [AHRS_M2] No Fault, FailCount= 3
2022-01-31T19:02:20.052Z,1643655740.052 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2022-01-31T19:02:20.054Z,1643655740.054 [CommandExec](IMPORTANT): got command failComponent hardware AHRS_M2
2022-01-31T19:02:20.054Z,1643655740.054 [AHRS_M2] Hardware Fault, FailCount= 4
2022-01-31T19:02:20.054Z,1643655740.054 [AHRS_M2](ERROR): Hardware Fault
2022-01-31T19:02:20.054Z,1643655740.054 [CommandExec](IMPORTANT): AHRS_M2 failureMode is Hardware Fault
2022-01-31T19:02:20.141Z,1643655740.141 [CBIT](ERROR): Hardware Fault in component: AHRS_M2
2022-01-31T19:02:20.456Z,1643655740.456 [AHRS_M2](INFO): Powering down
2022-01-31T19:02:21.300Z,1643655741.300 [CBIT](INFO): Clearing failed state for component AHRS_M2
2022-01-31T19:02:21.300Z,1643655741.300 [AHRS_M2] No Fault, FailCount= 4
2022-01-31T19:02:21.668Z,1643655741.668 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2022-01-31T19:02:25.746Z,1643655745.746 [CommandExec](IMPORTANT): got command failComponent hardware AHRS_M2
2022-01-31T19:02:25.746Z,1643655745.746 [AHRS_M2] Hardware Fault, FailCount= 1
2022-01-31T19:02:25.746Z,1643655745.746 [AHRS_M2](ERROR): Hardware Fault
2022-01-31T19:02:25.747Z,1643655745.747 [CommandExec](IMPORTANT): AHRS_M2 failureMode is Hardware Fault
2022-01-31T19:02:25.748Z,1643655745.748 [AHRS_M2](INFO): Powering down
2022-01-31T19:02:25.867Z,1643655745.867 [CBIT](ERROR): Hardware Fault in component: AHRS_M2
2022-01-31T19:02:26.540Z,1643655746.540 [CBIT](INFO): Clearing failed state for component AHRS_M2
2022-01-31T19:02:26.540Z,1643655746.540 [AHRS_M2] No Fault, FailCount= 1
2022-01-31T19:02:26.921Z,1643655746.921 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2022-01-31T19:02:37.236Z,1643655757.236 [CommandExec](IMPORTANT): got command failComponent hardware AHRS_M2
2022-01-31T19:02:37.237Z,1643655757.237 [AHRS_M2] Hardware Fault, FailCount= 1
2022-01-31T19:02:37.237Z,1643655757.237 [AHRS_M2](ERROR): Hardware Fault
2022-01-31T19:02:37.237Z,1643655757.237 [CommandExec](IMPORTANT): AHRS_M2 failureMode is Hardware Fault
2022-01-31T19:02:37.428Z,1643655757.428 [AHRS_M2](INFO): Powering down
2022-01-31T19:02:37.543Z,1643655757.543 [CBIT](ERROR): Hardware Fault in component: AHRS_M2
2022-01-31T19:02:38.280Z,1643655758.280 [CBIT](INFO): Clearing failed state for component AHRS_M2
2022-01-31T19:02:38.280Z,1643655758.280 [AHRS_M2] No Fault, FailCount= 1
2022-01-31T19:02:38.640Z,1643655758.640 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2022-01-31T19:03:01.360Z,1643655781.360 [CommandExec](IMPORTANT): got command failComponent
2022-01-31T19:03:01.361Z,1643655781.361 [CommandExec](IMPORTANT): Failed components:
2022-01-31T19:03:01.361Z,1643655781.361 [CommandExec](IMPORTANT): NAL9602: Hardware Fault
2022-01-31T19:03:12.184Z,1643655792.184 [CommandExec](IMPORTANT): got command failComponent hardware AHRS_M2
2022-01-31T19:03:12.184Z,1643655792.184 [AHRS_M2] Hardware Fault, FailCount= 1
2022-01-31T19:03:12.185Z,1643655792.185 [AHRS_M2](ERROR): Hardware Fault
2022-01-31T19:03:12.185Z,1643655792.185 [CommandExec](IMPORTANT): AHRS_M2 failureMode is Hardware Fault
2022-01-31T19:03:12.259Z,1643655792.259 [CBIT](ERROR): Hardware Fault in component: AHRS_M2
2022-01-31T19:03:12.576Z,1643655792.576 [AHRS_M2](INFO): Powering down
2022-01-31T19:03:13.424Z,1643655793.424 [CBIT](INFO): Clearing failed state for component AHRS_M2
2022-01-31T19:03:13.424Z,1643655793.424 [AHRS_M2] No Fault, FailCount= 0
2022-01-31T19:03:13.529Z,1643655793.529 [CommandExec](IMPORTANT): got command failComponent hardware AHRS_M2
2022-01-31T19:03:13.529Z,1643655793.529 [AHRS_M2] Hardware Fault, FailCount= 1
2022-01-31T19:03:13.529Z,1643655793.529 [AHRS_M2](ERROR): Hardware Fault
2022-01-31T19:03:13.529Z,1643655793.529 [CommandExec](IMPORTANT): AHRS_M2 failureMode is Hardware Fault
2022-01-31T19:03:13.847Z,1643655793.847 [CBIT](ERROR): Hardware Fault in component: AHRS_M2
2022-01-31T19:03:13.847Z,1643655793.847 [CBIT](INFO): Clearing failed state for component AHRS_M2
2022-01-31T19:03:13.848Z,1643655793.848 [AHRS_M2] No Fault, FailCount= 1
2022-01-31T19:03:14.192Z,1643655794.192 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2022-01-31T19:03:14.469Z,1643655794.469 [CommandExec](IMPORTANT): got command failComponent hardware AHRS_M2
2022-01-31T19:03:14.469Z,1643655794.469 [AHRS_M2] Hardware Fault, FailCount= 2
2022-01-31T19:03:14.469Z,1643655794.469 [AHRS_M2](ERROR): Hardware Fault
2022-01-31T19:03:14.469Z,1643655794.469 [CommandExec](IMPORTANT): AHRS_M2 failureMode is Hardware Fault
2022-01-31T19:03:14.596Z,1643655794.596 [AHRS_M2](INFO): Powering down
2022-01-31T19:03:14.694Z,1643655794.694 [CBIT](ERROR): Hardware Fault in component: AHRS_M2
2022-01-31T19:03:15.431Z,1643655795.431 [CBIT](INFO): Clearing failed state for component AHRS_M2
2022-01-31T19:03:15.431Z,1643655795.431 [AHRS_M2] No Fault, FailCount= 2
2022-01-31T19:03:15.808Z,1643655795.808 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2022-01-31T19:03:16.604Z,1643655796.604 [CommandExec](IMPORTANT): got command failComponent hardware AHRS_M2
2022-01-31T19:03:16.604Z,1643655796.604 [AHRS_M2] Hardware Fault, FailCount= 3
2022-01-31T19:03:16.604Z,1643655796.604 [AHRS_M2](ERROR): Hardware Fault
2022-01-31T19:03:16.605Z,1643655796.605 [CommandExec](IMPORTANT): AHRS_M2 failureMode is Hardware Fault
2022-01-31T19:03:16.616Z,1643655796.616 [AHRS_M2](INFO): Powering down
2022-01-31T19:03:16.708Z,1643655796.708 [CBIT](ERROR): Hardware Fault in component: AHRS_M2
2022-01-31T19:03:17.449Z,1643655797.449 [CBIT](INFO): Clearing failed state for component AHRS_M2
2022-01-31T19:03:17.449Z,1643655797.449 [AHRS_M2] No Fault, FailCount= 3
2022-01-31T19:03:17.828Z,1643655797.828 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2022-01-31T19:03:18.532Z,1643655798.532 [CommandExec](IMPORTANT): got command failComponent hardware AHRS_M2
2022-01-31T19:03:18.532Z,1643655798.532 [AHRS_M2] Hardware Fault, FailCount= 4
2022-01-31T19:03:18.532Z,1643655798.532 [AHRS_M2](ERROR): Hardware Fault
2022-01-31T19:03:18.533Z,1643655798.533 [CommandExec](IMPORTANT): AHRS_M2 failureMode is Hardware Fault
2022-01-31T19:03:18.636Z,1643655798.636 [AHRS_M2](INFO): Powering down
2022-01-31T19:03:18.737Z,1643655798.737 [CBIT](ERROR): Hardware Fault in component: AHRS_M2
2022-01-31T19:03:19.472Z,1643655799.472 [CBIT](INFO): Clearing failed state for component AHRS_M2
2022-01-31T19:03:19.472Z,1643655799.472 [AHRS_M2] No Fault, FailCount= 4
2022-01-31T19:03:19.848Z,1643655799.848 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2022-01-31T19:03:20.825Z,1643655800.825 [CommandExec](IMPORTANT): got command failComponent hardware AHRS_M2
2022-01-31T19:03:20.825Z,1643655800.825 [AHRS_M2] Hardware Fault, FailCount= 5
2022-01-31T19:03:20.825Z,1643655800.825 [AHRS_M2](ERROR): Hardware Fault
2022-01-31T19:03:20.825Z,1643655800.825 [CommandExec](IMPORTANT): AHRS_M2 failureMode is Hardware Fault
2022-01-31T19:03:21.060Z,1643655801.060 [AHRS_M2](INFO): Powering down
2022-01-31T19:03:21.181Z,1643655801.181 [CBIT](ERROR): Hardware Fault in component: AHRS_M2
2022-01-31T19:03:21.181Z,1643655801.181 [CBIT](CRITICAL): Hardware Fault in component: AHRS_M2
2022-01-31T19:03:21.494Z,1643655801.494 [CBIT](INFO): Critical error at 20220131T190321
2022-01-31T19:03:22.124Z,1643655802.124 [CommandExec](IMPORTANT): got command failComponent hardware AHRS_M2
2022-01-31T19:03:22.124Z,1643655802.124 [CommandExec](IMPORTANT): AHRS_M2 failureMode is Hardware Fault
2022-01-31T19:03:25.569Z,1643655805.569 [CommandExec](IMPORTANT): got command failComponent
2022-01-31T19:03:25.569Z,1643655805.569 [CommandExec](IMPORTANT): Failed components:
2022-01-31T19:03:25.569Z,1643655805.569 [CommandExec](IMPORTANT): AHRS_M2: Hardware Fault
2022-01-31T19:03:25.569Z,1643655805.569 [CommandExec](IMPORTANT): NAL9602: Hardware Fault
2022-01-31T19:03:31.184Z,1643655811.184 [CBIT](INFO): Clearing failed state for component NAL9602
2022-01-31T19:03:31.184Z,1643655811.184 [NAL9602] No Fault, FailCount= 5
2022-01-31T19:03:31.569Z,1643655811.569 [NAL9602](INFO): Powering up NAL9602
2022-01-31T19:03:42.113Z,1643655822.113 [CommandExec](IMPORTANT): got command gfscan
2022-01-31T19:03:42.129Z,1643655822.129 [CBIT](IMPORTANT): Beginning ground fault scan
2022-01-31T19:03:42.473Z,1643655822.473 [NAL9602](INFO): NAL9602 initialized
2022-01-31T19:03:42.569Z,1643655822.569 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T19:03:43.574Z,1643655823.574 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T19:03:44.577Z,1643655824.577 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T19:03:45.583Z,1643655825.583 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T19:03:46.586Z,1643655826.586 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T19:03:47.590Z,1643655827.590 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T19:03:48.593Z,1643655828.593 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T19:03:49.598Z,1643655829.598 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T19:03:50.601Z,1643655830.601 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T19:03:51.606Z,1643655831.606 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T19:03:52.609Z,1643655832.609 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T19:03:53.004Z,1643655833.004 [CBIT](IMPORTANT): Ground fault detected
mA:
CHAN A0 (Batt): 0.037353
CHAN A1 (24V): 0.072367
CHAN A2 (12V): 0.025311
CHAN A3 (5V): 0.006798
CHAN B0 (3.3V): 0.004418
CHAN B1 (3.15aV): 0.004071
CHAN B2 (3.15bV): 0.005165
CHAN B3 (GND): -0.010657
OPEN: 0.006091
Full Scale: +/- 1 mA
2022-01-31T19:03:59.039Z,1643655839.039 [NAL9602](INFO): SBD MO Status=0, MOMSN=35493, MT Status=0, MTMSN=0
2022-01-31T19:03:59.039Z,1643655839.039 [NAL9602](INFO): No messages in MT queue
2022-01-31T19:03:59.039Z,1643655839.039 [NAL9602](INFO): Failure count cleared after critical for NAL9602
2022-01-31T19:04:32.167Z,1643655872.167 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,190433.00,A,4128.90815,N,07053.49947,W,0.428,0.00,310122,,,A*71
2022-01-31T19:04:32.169Z,1643655872.169 [NAL9602](INFO): GPS fix at 20220131T190433: (41.481803, -70.891658)
2022-01-31T19:04:32.239Z,1643655872.239 [Default:CheckIn:Read_GPS] Stopped
2022-01-31T19:04:32.239Z,1643655872.239 [Default:CheckIn:Read_Iridium] Running Loop=1
2022-01-31T19:04:35.631Z,1643655875.631 [DataOverHttps](INFO): Sending 155 bytes from file Logs/20220131T184610/Courier0010.lzma
2022-01-31T19:04:36.633Z,1643655876.633 [DataOverHttps](INFO): Moved sent file to Logs/20220131T184610/Courier0010.lzma.bak
2022-01-31T19:04:36.634Z,1643655876.634 [DataOverHttps](INFO): SBD MOMSN=1376090
2022-01-31T19:04:46.319Z,1643655886.319 [DataOverHttps](INFO): Sending 694 bytes from file Logs/20220131T184610/Express0011.lzma
2022-01-31T19:04:46.674Z,1643655886.674 [DataOverHttps](INFO): Moved sent file to Logs/20220131T184610/Express0011.lzma.bak
2022-01-31T19:04:46.674Z,1643655886.674 [DataOverHttps](INFO): SBD MOMSN=1376095
2022-01-31T19:04:48.391Z,1643655888.391 [Default:CheckIn:Read_Iridium] Stopped
2022-01-31T19:04:48.391Z,1643655888.391 [Default:CheckIn:C.Wait] Running Loop=1
2022-01-31T19:04:48.391Z,1643655888.391 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2022-01-31T19:05:04.536Z,1643655904.536 [NAL9602](INFO): Not Powering down - fast GPS
2022-01-31T19:05:11.837Z,1643655911.837 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2022-01-31T19:05:11.837Z,1643655911.837 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2022-01-31T19:05:11.837Z,1643655911.837 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2022-01-31T19:05:11.849Z,1643655911.849 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2022-01-31T19:05:12.239Z,1643655912.239 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2022-01-31T19:05:12.239Z,1643655912.239 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2022-01-31T19:07:13.023Z,1643656033.023 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2022-01-31T19:07:13.024Z,1643656033.024 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2022-01-31T19:07:13.024Z,1643656033.024 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2022-01-31T19:07:13.037Z,1643656033.037 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2022-01-31T19:07:13.449Z,1643656033.449 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2022-01-31T19:07:13.449Z,1643656033.449 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2022-01-31T19:08:20.904Z,1643656100.904 [CBIT](INFO): Clearing failed state for component AHRS_M2
2022-01-31T19:08:20.904Z,1643656100.904 [AHRS_M2] No Fault, FailCount= 5
2022-01-31T19:08:21.284Z,1643656101.284 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2022-01-31T19:08:24.942Z,1643656104.942 [AHRS_M2](INFO): Failure count cleared after critical for AHRS_M2
2022-01-31T19:09:48.977Z,1643656188.977 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2022-01-31T19:09:48.977Z,1643656188.977 [Default:CheckIn:C.Wait] Stopped
2022-01-31T19:09:48.977Z,1643656188.977 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2022-01-31T19:09:48.977Z,1643656188.977 [Default:CheckIn:D] Running Loop=1
2022-01-31T19:09:49.377Z,1643656189.377 [Default:CheckIn:D] Stopped
2022-01-31T19:09:49.377Z,1643656189.377 [Default:CheckIn:E] Running Loop=1
2022-01-31T19:09:49.802Z,1643656189.802 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 20.769832 min 
2022-01-31T19:09:49.802Z,1643656189.802 [Default:CheckIn:E] Stopped
2022-01-31T19:09:49.803Z,1643656189.803 [Default:CheckIn](INFO): Completed Default:CheckIn
2022-01-31T19:09:49.803Z,1643656189.803 [Default:CheckIn] Stopped
2022-01-31T19:09:49.803Z,1643656189.803 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2022-01-31T19:09:49.803Z,1643656189.803 [Default:CheckIn](INFO): Running loop #4
2022-01-31T19:09:49.803Z,1643656189.803 [Default:CheckIn] Running Loop=4
2022-01-31T19:09:49.803Z,1643656189.803 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2022-01-31T19:09:49.803Z,1643656189.803 [Default:CheckIn:Read_GPS] Running Loop=1
2022-01-31T19:09:51.791Z,1643656191.791 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,190952.00,A,4128.91117,N,07053.54536,W,1.166,252.37,310122,,,A*78
2022-01-31T19:09:51.794Z,1643656191.794 [NAL9602](INFO): GPS fix at 20220131T190952: (41.481853, -70.892423)
2022-01-31T19:09:51.838Z,1643656191.838 [Default:CheckIn:Read_GPS] Stopped
2022-01-31T19:09:51.838Z,1643656191.838 [Default:CheckIn:Read_Iridium] Running Loop=1
2022-01-31T19:09:55.920Z,1643656195.920 [DataOverHttps](INFO): Sending 71 bytes from file Logs/20220131T184610/Courier0013.lzma
2022-01-31T19:09:56.921Z,1643656196.921 [DataOverHttps](INFO): Moved sent file to Logs/20220131T184610/Courier0013.lzma.bak
2022-01-31T19:09:56.922Z,1643656196.922 [DataOverHttps](INFO): SBD MOMSN=1376178
2022-01-31T19:10:03.508Z,1643656203.508 [NAL9602](INFO): SBD MO Status=0, MOMSN=35494, MT Status=0, MTMSN=0
2022-01-31T19:10:03.508Z,1643656203.508 [NAL9602](INFO): No messages in MT queue
2022-01-31T19:10:05.960Z,1643656205.960 [DataOverHttps](INFO): Sending 276 bytes from file Logs/20220131T184610/Express0014.lzma
2022-01-31T19:10:06.962Z,1643656206.962 [DataOverHttps](INFO): Moved sent file to Logs/20220131T184610/Express0014.lzma.bak
2022-01-31T19:10:06.962Z,1643656206.962 [DataOverHttps](INFO): SBD MOMSN=1376181
2022-01-31T19:10:08.780Z,1643656208.780 [Default:CheckIn:Read_Iridium] Stopped
2022-01-31T19:10:08.780Z,1643656208.780 [Default:CheckIn:C.Wait] Running Loop=1
2022-01-31T19:10:08.780Z,1643656208.780 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2022-01-31T19:10:34.210Z,1643656234.210 [NAL9602](INFO): Not Powering down - fast GPS
2022-01-31T19:11:22.473Z,1643656282.473 [CommandExec](IMPORTANT): got command gfscan
2022-01-31T19:11:22.724Z,1643656282.724 [CBIT](IMPORTANT): Beginning ground fault scan
2022-01-31T19:11:23.490Z,1643656283.490 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T19:11:24.493Z,1643656284.493 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T19:11:25.498Z,1643656285.498 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T19:11:26.501Z,1643656286.501 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T19:11:27.506Z,1643656287.506 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T19:11:28.509Z,1643656288.509 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T19:11:29.514Z,1643656289.514 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T19:11:30.517Z,1643656290.517 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T19:11:31.522Z,1643656291.522 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T19:11:32.525Z,1643656292.525 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T19:11:33.530Z,1643656293.530 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T19:11:33.635Z,1643656293.635 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.008099
CHAN A1 (24V): -0.028840
CHAN A2 (12V): -0.007465
CHAN A3 (5V): -0.001562
CHAN B0 (3.3V): -0.000099
CHAN B1 (3.15aV): -0.000443
CHAN B2 (3.15bV): -0.000226
CHAN B3 (GND): 0.002412
OPEN: 0.002298
Full Scale: +/- 1 mA
2022-01-31T19:11:57.889Z,1643656317.889 [CommandExec](IMPORTANT): got command gfscan
2022-01-31T19:11:57.891Z,1643656317.891 [CBIT](IMPORTANT): Beginning ground fault scan
2022-01-31T19:11:58.630Z,1643656318.630 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T19:11:59.634Z,1643656319.634 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T19:12:00.637Z,1643656320.637 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T19:12:01.642Z,1643656321.642 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T19:12:02.645Z,1643656322.645 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T19:12:03.653Z,1643656323.653 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T19:12:04.653Z,1643656324.653 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T19:12:05.658Z,1643656325.658 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T19:12:06.661Z,1643656326.661 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T19:12:07.666Z,1643656327.666 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T19:12:08.669Z,1643656328.669 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T19:12:08.785Z,1643656328.785 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.008834
CHAN A1 (24V): -0.029471
CHAN A2 (12V): -0.006970
CHAN A3 (5V): -0.002143
CHAN B0 (3.3V): -0.000090
CHAN B1 (3.15aV): 0.000526
CHAN B2 (3.15bV): 0.000217
CHAN B3 (GND): 0.002518
OPEN: 0.002716
Full Scale: +/- 1 mA
2022-01-31T19:12:19.877Z,1643656339.877 [CommandExec](IMPORTANT): got command gfscan
2022-01-31T19:12:20.104Z,1643656340.104 [CBIT](IMPORTANT): Beginning ground fault scan
2022-01-31T19:12:20.717Z,1643656340.717 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T19:12:21.725Z,1643656341.725 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T19:12:22.726Z,1643656342.726 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T19:12:23.734Z,1643656343.734 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T19:12:24.733Z,1643656344.733 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T19:12:25.744Z,1643656345.744 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T19:12:26.745Z,1643656346.745 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T19:12:27.750Z,1643656347.750 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T19:12:28.753Z,1643656348.753 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T19:12:29.758Z,1643656349.758 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T19:12:30.761Z,1643656350.761 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T19:12:30.989Z,1643656350.989 [CBIT](IMPORTANT): Ground fault detected
mA:
CHAN A0 (Batt): 0.074174
CHAN A1 (24V): 0.103663
CHAN A2 (12V): 0.035991
CHAN A3 (5V): 0.008117
CHAN B0 (3.3V): 0.004277
CHAN B1 (3.15aV): 0.003912
CHAN B2 (3.15bV): 0.004225
CHAN B3 (GND): -0.022697
OPEN: 0.006041
Full Scale: +/- 1 mA
2022-01-31T19:13:04.457Z,1643656384.457 [CommandExec](IMPORTANT): got command gfscan
2022-01-31T19:13:04.530Z,1643656384.530 [CBIT](IMPORTANT): Beginning ground fault scan
2022-01-31T19:13:04.909Z,1643656384.909 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T19:13:05.914Z,1643656385.914 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T19:13:06.917Z,1643656386.917 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T19:13:07.922Z,1643656387.922 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T19:13:08.925Z,1643656388.925 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T19:13:09.930Z,1643656389.930 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T19:13:10.933Z,1643656390.933 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T19:13:11.938Z,1643656391.938 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T19:13:12.941Z,1643656392.941 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T19:13:13.946Z,1643656393.946 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T19:13:14.949Z,1643656394.949 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T19:13:15.439Z,1643656395.439 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.008264
CHAN A1 (24V): -0.028470
CHAN A2 (12V): -0.007185
CHAN A3 (5V): -0.002154
CHAN B0 (3.3V): 0.000379
CHAN B1 (3.15aV): -0.000069
CHAN B2 (3.15bV): -0.000578
CHAN B3 (GND): 0.002259
OPEN: 0.004162
Full Scale: +/- 1 mA
2022-01-31T19:13:32.625Z,1643656412.625 [CommandExec](IMPORTANT): got command gfscan
2022-01-31T19:13:32.811Z,1643656412.811 [CBIT](IMPORTANT): Beginning ground fault scan
2022-01-31T19:13:33.052Z,1643656413.052 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T19:13:34.044Z,1643656414.044 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T19:13:35.048Z,1643656415.048 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T19:13:36.042Z,1643656416.042 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T19:13:37.046Z,1643656417.046 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T19:13:38.050Z,1643656418.050 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T19:13:39.054Z,1643656419.054 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T19:13:40.058Z,1643656420.058 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T19:13:41.061Z,1643656421.061 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T19:13:42.086Z,1643656422.086 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T19:13:43.089Z,1643656423.089 [CTD_Seabird](INFO): Ground Fault scan is active; will mark data as invalid.
2022-01-31T19:13:43.785Z,1643656423.785 [CBIT](IMPORTANT): Ground fault detected
mA:
CHAN A0 (Batt): 0.063833
CHAN A1 (24V): 0.092932
CHAN A2 (12V): 0.034170
CHAN A3 (5V): 0.008872
CHAN B0 (3.3V): 0.005010
CHAN B1 (3.15aV): 0.004328
CHAN B2 (3.15bV): 0.005037
CHAN B3 (GND): -0.021198
OPEN: 0.006463
Full Scale: +/- 1 mA
2022-01-31T19:15:09.365Z,1643656509.365 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2022-01-31T19:15:09.366Z,1643656509.366 [Default:CheckIn:C.Wait] Stopped
2022-01-31T19:15:09.366Z,1643656509.366 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2022-01-31T19:15:09.366Z,1643656509.366 [Default:CheckIn:D] Running Loop=1
2022-01-31T19:15:09.787Z,1643656509.787 [Default:CheckIn:D] Stopped
2022-01-31T19:15:09.787Z,1643656509.787 [Default:CheckIn:E] Running Loop=1
2022-01-31T19:15:10.165Z,1643656510.165 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 26.109998 min 
2022-01-31T19:15:10.165Z,1643656510.165 [Default:CheckIn:E] Stopped
2022-01-31T19:15:10.166Z,1643656510.166 [Default:CheckIn](INFO): Completed Default:CheckIn
2022-01-31T19:15:10.166Z,1643656510.166 [Default:CheckIn] Stopped
2022-01-31T19:15:10.166Z,1643656510.166 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2022-01-31T19:15:10.166Z,1643656510.166 [Default:CheckIn](INFO): Running loop #5
2022-01-31T19:15:10.166Z,1643656510.166 [Default:CheckIn] Running Loop=5
2022-01-31T19:15:10.166Z,1643656510.166 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2022-01-31T19:15:10.166Z,1643656510.166 [Default:CheckIn:Read_GPS] Running Loop=1
2022-01-31T19:15:12.173Z,1643656512.173 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,191513.00,A,4128.91186,N,07053.58544,W,0.214,271.64,310122,,,D*74
2022-01-31T19:15:12.176Z,1643656512.176 [NAL9602](INFO): GPS fix at 20220131T191513: (41.481864, -70.893091)
2022-01-31T19:15:12.191Z,1643656512.191 [Default:CheckIn:Read_GPS] Stopped
2022-01-31T19:15:12.191Z,1643656512.191 [Default:CheckIn:Read_Iridium] Running Loop=1
2022-01-31T19:15:16.219Z,1643656516.219 [DataOverHttps](INFO): Sending 79 bytes from file Logs/20220131T184610/Courier0016.lzma
2022-01-31T19:15:17.222Z,1643656517.222 [DataOverHttps](INFO): Moved sent file to Logs/20220131T184610/Courier0016.lzma.bak
2022-01-31T19:15:17.222Z,1643656517.222 [DataOverHttps](INFO): SBD MOMSN=1376230
2022-01-31T19:15:26.260Z,1643656526.260 [DataOverHttps](INFO): Sending 570 bytes from file Logs/20220131T184610/Express0017.lzma
2022-01-31T19:15:27.262Z,1643656527.262 [DataOverHttps](INFO): Moved sent file to Logs/20220131T184610/Express0017.lzma.bak
2022-01-31T19:15:27.262Z,1643656527.262 [DataOverHttps](INFO): SBD MOMSN=1376233
2022-01-31T19:15:28.764Z,1643656528.764 [Default:CheckIn:Read_Iridium] Stopped
2022-01-31T19:15:28.764Z,1643656528.764 [Default:CheckIn:C.Wait] Running Loop=1
2022-01-31T19:15:28.764Z,1643656528.764 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2022-01-31T19:15:29.954Z,1643656529.954 [NAL9602](INFO): SBD MO Status=0, MOMSN=35495, MT Status=0, MTMSN=0
2022-01-31T19:15:29.954Z,1643656529.954 [NAL9602](INFO): No messages in MT queue
2022-01-31T19:16:00.657Z,1643656560.657 [NAL9602](INFO): Not Powering down - fast GPS
2022-01-31T19:20:29.332Z,1643656829.332 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2022-01-31T19:20:29.333Z,1643656829.333 [Default:CheckIn:C.Wait] Stopped
2022-01-31T19:20:29.333Z,1643656829.333 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2022-01-31T19:20:29.333Z,1643656829.333 [Default:CheckIn:D] Running Loop=1
2022-01-31T19:20:29.777Z,1643656829.777 [Default:CheckIn:D] Stopped
2022-01-31T19:20:29.777Z,1643656829.777 [Default:CheckIn:E] Running Loop=1
2022-01-31T19:20:30.142Z,1643656830.142 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 31.443168 min 
2022-01-31T19:20:30.142Z,1643656830.142 [Default:CheckIn:E] Stopped
2022-01-31T19:20:30.142Z,1643656830.142 [Default:CheckIn](INFO): Completed Default:CheckIn
2022-01-31T19:20:30.142Z,1643656830.142 [Default:CheckIn] Stopped
2022-01-31T19:20:30.142Z,1643656830.142 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2022-01-31T19:20:30.142Z,1643656830.142 [Default:CheckIn](INFO): Running loop #6
2022-01-31T19:20:30.143Z,1643656830.143 [Default:CheckIn] Running Loop=6
2022-01-31T19:20:30.143Z,1643656830.143 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2022-01-31T19:20:30.143Z,1643656830.143 [Default:CheckIn:Read_GPS] Running Loop=1
2022-01-31T19:20:32.148Z,1643656832.148 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,192034.00,A,4128.91338,N,07053.62351,W,0.447,303.79,310122,,,D*73
2022-01-31T19:20:32.150Z,1643656832.150 [NAL9602](INFO): GPS fix at 20220131T192034: (41.481890, -70.893725)
2022-01-31T19:20:32.182Z,1643656832.182 [Default:CheckIn:Read_GPS] Stopped
2022-01-31T19:20:32.182Z,1643656832.182 [Default:CheckIn:Read_Iridium] Running Loop=1
2022-01-31T19:20:36.551Z,1643656836.551 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20220131T184610/Courier0019.lzma
2022-01-31T19:20:37.554Z,1643656837.554 [DataOverHttps](INFO): Moved sent file to Logs/20220131T184610/Courier0019.lzma.bak
2022-01-31T19:20:37.554Z,1643656837.554 [DataOverHttps](INFO): SBD MOMSN=1376320
2022-01-31T19:20:46.591Z,1643656846.591 [DataOverHttps](INFO): Sending 145 bytes from file Logs/20220131T184610/Express0020.lzma
2022-01-31T19:20:47.594Z,1643656847.594 [DataOverHttps](INFO): Moved sent file to Logs/20220131T184610/Express0020.lzma.bak
2022-01-31T19:20:47.594Z,1643656847.594 [DataOverHttps](INFO): SBD MOMSN=1376323
2022-01-31T19:20:49.137Z,1643656849.137 [Default:CheckIn:Read_Iridium] Stopped
2022-01-31T19:20:49.137Z,1643656849.137 [Default:CheckIn:C.Wait] Running Loop=1
2022-01-31T19:20:49.137Z,1643656849.137 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2022-01-31T19:20:52.354Z,1643656852.354 [NAL9602](INFO): SBD MO Status=0, MOMSN=35496, MT Status=0, MTMSN=0
2022-01-31T19:20:52.354Z,1643656852.354 [NAL9602](INFO): No messages in MT queue
2022-01-31T19:21:23.113Z,1643656883.113 [NAL9602](INFO): Not Powering down - fast GPS
2022-01-31T19:25:49.769Z,1643657149.769 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2022-01-31T19:25:49.770Z,1643657149.770 [Default:CheckIn:C.Wait] Stopped
2022-01-31T19:25:49.770Z,1643657149.770 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2022-01-31T19:25:49.770Z,1643657149.770 [Default:CheckIn:D] Running Loop=1
2022-01-31T19:25:50.173Z,1643657150.173 [Default:CheckIn:D] Stopped
2022-01-31T19:25:50.173Z,1643657150.173 [Default:CheckIn:E] Running Loop=1
2022-01-31T19:25:50.561Z,1643657150.561 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 36.783089 min 
2022-01-31T19:25:50.561Z,1643657150.561 [Default:CheckIn:E] Stopped
2022-01-31T19:25:50.562Z,1643657150.562 [Default:CheckIn](INFO): Completed Default:CheckIn
2022-01-31T19:25:50.562Z,1643657150.562 [Default:CheckIn] Stopped
2022-01-31T19:25:50.562Z,1643657150.562 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2022-01-31T19:25:50.562Z,1643657150.562 [Default:CheckIn](INFO): Running loop #7
2022-01-31T19:25:50.562Z,1643657150.562 [Default:CheckIn] Running Loop=7
2022-01-31T19:25:50.562Z,1643657150.562 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2022-01-31T19:25:50.562Z,1643657150.562 [Default:CheckIn:Read_GPS] Running Loop=1
2022-01-31T19:25:52.568Z,1643657152.568 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,192554.00,A,4128.91311,N,07053.65985,W,0.175,303.79,310122,,,D*7B
2022-01-31T19:25:52.571Z,1643657152.571 [NAL9602](INFO): GPS fix at 20220131T192554: (41.481885, -70.894331)
2022-01-31T19:25:52.582Z,1643657152.582 [Default:CheckIn:Read_GPS] Stopped
2022-01-31T19:25:52.582Z,1643657152.582 [Default:CheckIn:Read_Iridium] Running Loop=1
2022-01-31T19:25:56.875Z,1643657156.875 [DataOverHttps](INFO): Sending 80 bytes from file Logs/20220131T184610/Courier0022.lzma
2022-01-31T19:25:57.878Z,1643657157.878 [DataOverHttps](INFO): Moved sent file to Logs/20220131T184610/Courier0022.lzma.bak
2022-01-31T19:25:57.878Z,1643657157.878 [DataOverHttps](INFO): SBD MOMSN=1376370
2022-01-31T19:26:06.916Z,1643657166.916 [DataOverHttps](INFO): Sending 144 bytes from file Logs/20220131T184610/Express0023.lzma
2022-01-31T19:26:07.918Z,1643657167.918 [DataOverHttps](INFO): Moved sent file to Logs/20220131T184610/Express0023.lzma.bak
2022-01-31T19:26:07.918Z,1643657167.918 [DataOverHttps](INFO): SBD MOMSN=1376373
2022-01-31T19:26:09.552Z,1643657169.552 [Default:CheckIn:Read_Iridium] Stopped
2022-01-31T19:26:09.552Z,1643657169.552 [Default:CheckIn:C.Wait] Running Loop=1
2022-01-31T19:26:09.552Z,1643657169.552 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2022-01-31T19:26:10.344Z,1643657170.344 [NAL9602](INFO): SBD MO Status=0, MOMSN=35497, MT Status=0, MTMSN=0
2022-01-31T19:26:10.344Z,1643657170.344 [NAL9602](INFO): No messages in MT queue
2022-01-31T19:26:41.046Z,1643657201.046 [NAL9602](INFO): Not Powering down - fast GPS
2022-01-31T19:27:59.426Z,1643657279.426 [DataOverHttps](IMPORTANT): SBD MTMSN=20220131T192801
2022-01-31T19:28:03.456Z,1643657283.456 [DataOverHttps](INFO): Received command: sched asap "load Science/sci2.xml;set sci2.MissionTimeout 30 min;set sci2.NeedCommsTime 30 min;set sci2.Lat1 41.501148 degree;set sci2.Lon1 -70.811485 degree;set sci2.Speed .8 m/s;set sci2.YoYoMinDepth 3 m;set sci2.YoYoMaxDepth 7 m" 183e2 1 2
2022-01-31T19:28:03.505Z,1643657283.505 [CommandExec](IMPORTANT): got command schedule asap "load Science/sci2.xml;set sci2.MissionTimeout 30 min;set sci2.NeedCommsTime 30 min;set sci2.Lat1 41.501148 degree;set sci2.Lon1 -70.811485 degree;set sci2.Speed .8 m/s;set sci2.YoYoMinDepth 3 m;set sci2.YoYoMaxDepth 7 m" 183e2 1 2.000000
2022-01-31T19:28:03.506Z,1643657283.506 [CommandExec](IMPORTANT): Scheduling command #1 of 2 with id=183e2
2022-01-31T19:28:03.506Z,1643657283.506 [CommandExec](IMPORTANT): Scheduled #1 (#1 of 2 with id='183e2'): "load Science/sci2.xml;set sci2.MissionTimeout 30 min;set sci2.NeedCommsTime 30 min;set sci2.Lat1 41.501148 degree;set sci2.Lon1 -70.811485 degree;set sci2.Speed .8 m/s;set sci2.YoYoMinDepth 3 m;set sci2.YoYoMaxDepth 7 m", ASAP
2022-01-31T19:28:04.458Z,1643657284.458 [DataOverHttps](IMPORTANT): SBD MTMSN=20220131T192806
2022-01-31T19:28:08.475Z,1643657288.475 [DataOverHttps](INFO): Received command: sched asap "set sci2.YoYoMinAltitude 3 m;set sci2.MinAltitude 3 m;set sci2.MaxDepth 9 m;set sci2:NeedComms.CommsTimeout 30 min;run" 183e2 2 2
2022-01-31T19:28:08.488Z,1643657288.488 [CommandExec](IMPORTANT): got command schedule asap "set sci2.YoYoMinAltitude 3 m;set sci2.MinAltitude 3 m;set sci2.MaxDepth 9 m;set sci2:NeedComms.CommsTimeout 30 min;run" 183e2 2 2.000000
2022-01-31T19:28:08.489Z,1643657288.489 [CommandExec](IMPORTANT): Scheduling command #2 of 2 with id=183e2
2022-01-31T19:28:08.490Z,1643657288.490 [CommandExec](IMPORTANT): Scheduled #2 (#2 of 2 with id='183e2'): "set sci2.YoYoMinAltitude 3 m;set sci2.MinAltitude 3 m;set sci2.MaxDepth 9 m;set sci2:NeedComms.CommsTimeout 30 min;run", ASAP
2022-01-31T19:28:08.558Z,1643657288.558 [CommandExec](IMPORTANT): got command load ./Missions/Science/sci2.xml
2022-01-31T19:28:08.558Z,1643657288.558 [MissionManager](INFO): Loading Mission from file: ./Missions/Science/sci2.xml
2022-01-31T19:28:08.679Z,1643657288.679 [MissionManager](INFO): DefineArg sci2.MissionTimeout = 2.000000 h
2022-01-31T19:28:08.682Z,1643657288.682 [MissionManager](INFO): DefineArg sci2.NeedCommsTime = 60.000000 min
2022-01-31T19:28:08.685Z,1643657288.685 [MissionManager](INFO): DefineArg sci2.Repeat = 1.000000 count
2022-01-31T19:28:08.687Z,1643657288.687 [MissionManager](INFO): DefineArg sci2.Lat1 = nan arcdeg
2022-01-31T19:28:08.690Z,1643657288.690 [MissionManager](INFO): DefineArg sci2.Lon1 = nan arcdeg
2022-01-31T19:28:08.693Z,1643657288.693 [MissionManager](INFO): DefineArg sci2.Lat2 = nan arcdeg
2022-01-31T19:28:08.696Z,1643657288.696 [MissionManager](INFO): DefineArg sci2.Lon2 = nan arcdeg
2022-01-31T19:28:08.698Z,1643657288.698 [MissionManager](INFO): DefineArg sci2.Lat3 = nan arcdeg
2022-01-31T19:28:08.701Z,1643657288.701 [MissionManager](INFO): DefineArg sci2.Lon3 = nan arcdeg
2022-01-31T19:28:08.780Z,1643657288.780 [MissionManager](INFO): DefineArg sci2.Lat4 = nan arcdeg
2022-01-31T19:28:08.783Z,1643657288.783 [MissionManager](INFO): DefineArg sci2.Lon4 = nan arcdeg
2022-01-31T19:28:08.790Z,1643657288.790 [MissionManager](INFO): DefineArg sci2.Lat5 = nan arcdeg
2022-01-31T19:28:08.793Z,1643657288.793 [MissionManager](INFO): DefineArg sci2.Lon5 = nan arcdeg
2022-01-31T19:28:08.804Z,1643657288.804 [MissionManager](INFO): DefineArg sci2.Lat6 = nan arcdeg
2022-01-31T19:28:08.807Z,1643657288.807 [MissionManager](INFO): DefineArg sci2.Lon6 = nan arcdeg
2022-01-31T19:28:08.814Z,1643657288.814 [MissionManager](INFO): DefineArg sci2.Lat7 = nan arcdeg
2022-01-31T19:28:08.825Z,1643657288.825 [MissionManager](INFO): DefineArg sci2.Lon7 = nan arcdeg
2022-01-31T19:28:08.832Z,1643657288.832 [MissionManager](INFO): DefineArg sci2.Speed = 1.000000 m/s
2022-01-31T19:28:08.835Z,1643657288.835 [MissionManager](INFO): DefineArg sci2.CaptureRadius = nan m
2022-01-31T19:28:08.842Z,1643657288.842 [MissionManager](INFO): DefineArg sci2.YoYoMinDepth = 2.000000 m
2022-01-31T19:28:08.845Z,1643657288.845 [MissionManager](INFO): DefineArg sci2.YoYoMaxDepth = 200.000000 m
2022-01-31T19:28:08.860Z,1643657288.860 [MissionManager](INFO): DefineArg sci2.YoYoMinAltitude = 9.000000 m
2022-01-31T19:28:08.863Z,1643657288.863 [MissionManager](INFO): DefineArg sci2.YoYoUpPitch = 20.000000 arcdeg
2022-01-31T19:28:08.867Z,1643657288.867 [MissionManager](INFO): DefineArg sci2.YoYoDownPitch = -20.000000 arcdeg
2022-01-31T19:28:08.878Z,1643657288.878 [MissionManager](INFO): DefineArg sci2.BuoyancyNeutral = 154.000000 cc
2022-01-31T19:28:08.882Z,1643657288.882 [MissionManager](INFO): DefineArg sci2.MassDefault = 0.600000 cm
2022-01-31T19:28:08.894Z,1643657288.894 [MissionManager](INFO): DefineArg sci2.MinAltitude = 5.000000 m
2022-01-31T19:28:08.899Z,1643657288.899 [MissionManager](INFO): DefineArg sci2.MaxDepth = 205.000000 m
2022-01-31T19:28:08.917Z,1643657288.917 [MissionManager](INFO): DefineArg sci2.MinOffshore = 2.000000 km
2022-01-31T19:28:08.917Z,1643657288.917 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/Science.xml
2022-01-31T19:28:09.399Z,1643657289.399 [MissionManager](INFO): DefineArg sci2:Science.PeakDetectChlActive = 0 bool
2022-01-31T19:28:09.402Z,1643657289.402 [MissionManager](INFO): DefineArg sci2:Science.TimeWindowPeakReport = nan min
2022-01-31T19:28:09.404Z,1643657289.404 [MissionManager](INFO): DefineArg sci2:Science.HighestChlPeakReportActive = 0 bool
2022-01-31T19:28:09.407Z,1643657289.407 [MissionManager](INFO): DefineArg sci2:Science.HighestSaltPeakReportActive = 0 bool
2022-01-31T19:28:09.410Z,1643657289.410 [MissionManager](INFO): DefineArg sci2:Science.HighestOilPeakReportActive = 0 bool
2022-01-31T19:28:09.412Z,1643657289.412 [MissionManager](INFO): DefineArg sci2:Science.PatchTracking = 0 bool
2022-01-31T19:28:09.415Z,1643657289.415 [MissionManager](INFO): DefineArg sci2:Science.DetectTrough = 0 bool
2022-01-31T19:28:09.418Z,1643657289.418 [MissionManager](INFO): DefineArg sci2:Science.FilterWidthHorizontal = 3.000000 count
2022-01-31T19:28:09.421Z,1643657289.421 [MissionManager](INFO): DefineArg sci2:Science.NumProfilesSlidingwindow = 100.000000 count
2022-01-31T19:28:09.424Z,1643657289.424 [MissionManager](INFO): DefineArg sci2:Science.OffPeakFractionHorizontal = 80.000000 %
2022-01-31T19:28:09.427Z,1643657289.427 [MissionManager](INFO): DefineArg sci2:Science.PeakDetectNO3Active = 0 bool
2022-01-31T19:28:09.446Z,1643657289.446 [MissionManager](INFO): DefineArg sci2:Science.PeakDetectOilActive = 0 bool
2022-01-31T19:28:09.452Z,1643657289.452 [MissionManager](INFO): DefineArg sci2:Science.PeakDetectFDOMActive = 0 bool
2022-01-31T19:28:09.458Z,1643657289.458 [MissionManager](INFO): DefineArg sci2:Science.PeakDetectSalinityActive = 0 bool
2022-01-31T19:28:09.461Z,1643657289.461 [MissionManager](INFO): DefineArg sci2:Science.UpwardDerivativeOfTemperatureActive = 0 bool
2022-01-31T19:28:09.468Z,1643657289.468 [MissionManager](INFO): DefineArg sci2:Science.EnabledAanderaaO2 = 0 bool
2022-01-31T19:28:09.471Z,1643657289.471 [MissionManager](INFO): DefineArg sci2:Science.EnabledNeilBrown = 0 bool
2022-01-31T19:28:09.483Z,1643657289.483 [MissionManager](INFO): DefineArg sci2:Science.EnabledSeabird = 1 bool
2022-01-31T19:28:09.491Z,1643657289.491 [MissionManager](INFO): DefineArg sci2:Science.EnabledWetLabsBB2FL = 0 bool
2022-01-31T19:28:09.502Z,1643657289.502 [MissionManager](INFO): DefineArg sci2:Science.EnabledWetLabsSeaOWL_UV_A = 1 bool
2022-01-31T19:28:09.509Z,1643657289.509 [MissionManager](INFO): DefineArg sci2:Science.EnabledWetLabsUBAT = 0 bool
2022-01-31T19:28:09.512Z,1643657289.512 [MissionManager](INFO): DefineArg sci2:Science.LowPassWindowLength = 20.000000 count
2022-01-31T19:28:09.515Z,1643657289.515 [MissionManager](INFO): DefineArg sci2:Science.MedianFilterLen = 5.000000 count
2022-01-31T19:28:09.553Z,1643657289.553 [MissionManager](INFO): DefineArg sci2:Science.PeakShallowBound = nan m
2022-01-31T19:28:09.568Z,1643657289.568 [MissionManager](INFO): DefineArg sci2:Science.PeakDeepBound = nan m
2022-01-31T19:28:09.577Z,1643657289.577 [MissionManager](INFO): DefineArg sci2:Science.DepChangeThreshForAttitudeFlip = 2.000000 m
2022-01-31T19:28:09.584Z,1643657289.584 [MissionManager](INFO): DefineOutput sci2:Science.PeakChl = 0.000000 ug/l
2022-01-31T19:28:09.587Z,1643657289.587 [MissionManager](INFO): DefineOutput sci2:Science.PeakChlDepth = 0.000000 m
2022-01-31T19:28:09.602Z,1643657289.602 [MissionManager](INFO): DefineOutput sci2:Science.PeakChlTemperature = 0.000000 degC
2022-01-31T19:28:09.605Z,1643657289.605 [MissionManager](INFO): DefineOutput sci2:Science.PeakChlLatitude = nan arcdeg
2022-01-31T19:28:09.625Z,1643657289.625 [MissionManager](INFO): DefineOutput sci2:Science.PeakChlLongitude = nan arcdeg
2022-01-31T19:28:09.627Z,1643657289.627 [MissionManager](INFO): DefineOutput sci2:Science.PeakNO3 = 0.000000 umol/l
2022-01-31T19:28:09.635Z,1643657289.635 [MissionManager](INFO): DefineOutput sci2:Science.PeakNO3Depth = 0.000000 m
2022-01-31T19:28:09.643Z,1643657289.643 [MissionManager](INFO): DefineOutput sci2:Science.PeakNO3Latitude = nan arcdeg
2022-01-31T19:28:09.655Z,1643657289.655 [MissionManager](INFO): DefineOutput sci2:Science.PeakNO3Longitude = nan arcdeg
2022-01-31T19:28:09.671Z,1643657289.671 [MissionManager](INFO): DefineOutput sci2:Science.PeakOil = 0.000000 kg/m3
2022-01-31T19:28:09.687Z,1643657289.687 [MissionManager](INFO): DefineOutput sci2:Science.PeakOilDepth = 0.000000 m
2022-01-31T19:28:09.709Z,1643657289.709 [MissionManager](INFO): DefineOutput sci2:Science.PeakOilLatitude = nan arcdeg
2022-01-31T19:28:09.718Z,1643657289.718 [MissionManager](INFO): DefineOutput sci2:Science.PeakOilLongitude = nan arcdeg
2022-01-31T19:28:09.742Z,1643657289.742 [MissionManager](INFO): DefineOutput sci2:Science.PeakFDOM = 0.000000 ppb
2022-01-31T19:28:09.745Z,1643657289.745 [MissionManager](INFO): DefineOutput sci2:Science.PeakFDOMDepth = 0.000000 m
2022-01-31T19:28:09.748Z,1643657289.748 [MissionManager](INFO): DefineOutput sci2:Science.PeakFDOMTemperature = nan degC
2022-01-31T19:28:09.751Z,1643657289.751 [MissionManager](INFO): DefineOutput sci2:Science.PeakFDOMLatitude = nan arcdeg
2022-01-31T19:28:09.766Z,1643657289.766 [MissionManager](INFO): DefineOutput sci2:Science.PeakFDOMLongitude = nan arcdeg
2022-01-31T19:28:09.769Z,1643657289.769 [MissionManager](INFO): DefineOutput sci2:Science.PatchFDOMDistance = nan m
2022-01-31T19:28:09.772Z,1643657289.772 [MissionManager](INFO): DefineOutput sci2:Science.PeakSalt = 0.000000 psu
2022-01-31T19:28:09.775Z,1643657289.775 [MissionManager](INFO): DefineOutput sci2:Science.PeakSaltDepth = 0.000000 m
2022-01-31T19:28:09.802Z,1643657289.802 [MissionManager](INFO): DefineOutput sci2:Science.PeakSaltTemperature = 0.000000 degC
2022-01-31T19:28:09.805Z,1643657289.805 [MissionManager](INFO): DefineOutput sci2:Science.PeakSaltLatitude = nan arcdeg
2022-01-31T19:28:09.824Z,1643657289.824 [MissionManager](INFO): DefineOutput sci2:Science.PeakSaltLongitude = nan arcdeg
2022-01-31T19:28:09.827Z,1643657289.827 [MissionManager](INFO): DefineOutput sci2:Science.PatchChl = 0.000000 ug/l
2022-01-31T19:28:09.830Z,1643657289.830 [MissionManager](INFO): DefineOutput sci2:Science.PatchChlDepth = 0.000000 m
2022-01-31T19:28:09.833Z,1643657289.833 [MissionManager](INFO): DefineOutput sci2:Science.PatchChlLatitude = nan arcdeg
2022-01-31T19:28:09.854Z,1643657289.854 [MissionManager](INFO): DefineOutput sci2:Science.PatchChlLongitude = nan arcdeg
2022-01-31T19:28:09.857Z,1643657289.857 [MissionManager](INFO): DefineOutput sci2:Science.PatchChlDistance = nan m
2022-01-31T19:28:09.860Z,1643657289.860 [MissionManager](INFO): DefineOutput sci2:Science.PatchSalt = 0.000000 psu
2022-01-31T19:28:09.863Z,1643657289.863 [MissionManager](INFO): DefineOutput sci2:Science.PatchSaltDepth = 0.000000 m
2022-01-31T19:28:09.887Z,1643657289.887 [MissionManager](INFO): DefineOutput sci2:Science.PatchSaltLatitude = nan arcdeg
2022-01-31T19:28:09.890Z,1643657289.890 [MissionManager](INFO): DefineOutput sci2:Science.PatchSaltLongitude = nan arcdeg
2022-01-31T19:28:09.893Z,1643657289.893 [MissionManager](INFO): DefineOutput sci2:Science.PatchSaltDistance = nan m
2022-01-31T19:28:09.907Z,1643657289.907 [MissionManager](INFO): DefineOutput sci2:Science.PatchOil = 0.000000 psu
2022-01-31T19:28:09.910Z,1643657289.910 [MissionManager](INFO): DefineOutput sci2:Science.PatchOilDepth = 0.000000 m
2022-01-31T19:28:09.970Z,1643657289.970 [MissionManager](INFO): DefineOutput sci2:Science.PatchOilLatitude = nan arcdeg
2022-01-31T19:28:09.973Z,1643657289.973 [MissionManager](INFO): DefineOutput sci2:Science.PatchOilLongitude = nan arcdeg
2022-01-31T19:28:09.975Z,1643657289.975 [MissionManager](INFO): DefineOutput sci2:Science.PatchOilDistance = nan m
2022-01-31T19:28:10.073Z,1643657290.073 [sci2:Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2022-01-31T19:28:10.097Z,1643657290.097 [sci2:Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal.
2022-01-31T19:28:10.130Z,1643657290.130 [sci2:Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2022-01-31T19:28:10.152Z,1643657290.152 [sci2:Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2022-01-31T19:28:10.171Z,1643657290.171 [sci2:Science:HighestOilPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal.
2022-01-31T19:28:10.203Z,1643657290.203 [sci2:Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2022-01-31T19:28:10.231Z,1643657290.231 [sci2:Science:PeakDetectSalinity:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2022-01-31T19:28:10.255Z,1643657290.255 [sci2:Science:HighestSaltPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal.
2022-01-31T19:28:10.279Z,1643657290.279 [MissionManager](INFO): RedefineArg sci2:Science.PeakDetectChlActive = value:1 bool
2022-01-31T19:28:10.284Z,1643657290.284 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/NeedComms.xml
2022-01-31T19:28:10.418Z,1643657290.418 [MissionManager](INFO): DefineArg sci2:NeedComms.DiveInterval = 3.000000 h
2022-01-31T19:28:10.425Z,1643657290.425 [MissionManager](INFO): DefineArg sci2:NeedComms.WaitForPitchUp = 10.000000 min
2022-01-31T19:28:10.433Z,1643657290.433 [MissionManager](INFO): DefineArg sci2:NeedComms.SurfacePitch = 20.000000 arcdeg
2022-01-31T19:28:10.440Z,1643657290.440 [MissionManager](INFO): DefineArg sci2:NeedComms.SurfaceDepthRate = nan m/s
2022-01-31T19:28:10.443Z,1643657290.443 [MissionManager](INFO): DefineArg sci2:NeedComms.SurfaceSpeed = 1.000000 m/s
2022-01-31T19:28:10.450Z,1643657290.450 [MissionManager](INFO): DefineArg sci2:NeedComms.GPSTimeout = 7.000000 min
2022-01-31T19:28:10.469Z,1643657290.469 [MissionManager](INFO): DefineArg sci2:NeedComms.CommsTimeout = 30.000000 min
2022-01-31T19:28:10.484Z,1643657290.484 [sci2:NeedComms:B.GoToSurface](DEBUG): Construct GoToSurface.
2022-01-31T19:28:10.533Z,1643657290.533 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/StandardEnvelopes.xml
2022-01-31T19:28:10.571Z,1643657290.571 [MissionManager](INFO): DefineArg sci2:StandardEnvelopes.MinAltitude = 5.000000 m
2022-01-31T19:28:10.578Z,1643657290.578 [MissionManager](INFO): DefineArg sci2:StandardEnvelopes.MaxDepth = 200.000000 m
2022-01-31T19:28:10.582Z,1643657290.582 [MissionManager](INFO): DefineArg sci2:StandardEnvelopes.MinOffshore = 2000.000000 m
2022-01-31T19:28:10.596Z,1643657290.596 [sci2:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Construct AltitudeEnvelope.
2022-01-31T19:28:10.615Z,1643657290.615 [sci2:StandardEnvelopes:B.DepthEnvelope](DEBUG): Construct DepthEnvelope.
2022-01-31T19:28:10.650Z,1643657290.650 [sci2:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Construct OffshoreEnvelope.
2022-01-31T19:28:10.684Z,1643657290.684 [sci2:I.Pitch](DEBUG): Construct.
2022-01-31T19:28:10.690Z,1643657290.690 [sci2:J.Buoyancy](DEBUG): Construct Buoyancy.
2022-01-31T19:28:10.701Z,1643657290.701 [sci2:K.SetSpeed](DEBUG): Construct.
2022-01-31T19:28:10.710Z,1643657290.710 [sci2:L.DepthEnvelope](DEBUG): Construct DepthEnvelope.
2022-01-31T19:28:10.719Z,1643657290.719 [sci2:M.AltitudeEnvelope](DEBUG): Construct AltitudeEnvelope.
2022-01-31T19:28:10.800Z,1643657290.800 [sci2:N.YoYo](DEBUG): Construct YoYo.
2022-01-31T19:28:10.826Z,1643657290.826 [sci2:Lap:Wpt1:A.Waypoint](DEBUG): Construct Waypoint.
2022-01-31T19:28:10.841Z,1643657290.841 [sci2:Lap:Wpt2:A.Waypoint](DEBUG): Construct Waypoint.
2022-01-31T19:28:10.857Z,1643657290.857 [sci2:Lap:Wpt3:A.Waypoint](DEBUG): Construct Waypoint.
2022-01-31T19:28:10.872Z,1643657290.872 [sci2:Lap:Wpt4:A.Waypoint](DEBUG): Construct Waypoint.
2022-01-31T19:28:10.889Z,1643657290.889 [sci2:Lap:Wpt5:A.Waypoint](DEBUG): Construct Waypoint.
2022-01-31T19:28:10.913Z,1643657290.913 [sci2:Lap:Wpt6:A.Waypoint](DEBUG): Construct Waypoint.
2022-01-31T19:28:10.928Z,1643657290.928 [sci2:Lap:Wpt7:A.Waypoint](DEBUG): Construct Waypoint.
2022-01-31T19:28:10.994Z,1643657290.994 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<!-- ====================
     Generated by TethysL
     ==================== -->
<Mission xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
         xmlns="Tethys"
         xmlns:Units="Tethys/Units"
         xmlns:Control="Tethys/Control"
         xmlns:Guidance="Tethys/Guidance"
         xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                             Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                             Tethys/Control http://okeanids.mbari.org/tethys/Xml/Control.xsd
                             Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd"
       Id="sci2">

    <Description>
        Vehicle yo-yo's to the specified waypoints, with science turned on.
    </Description>

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

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

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

    <DefineArg Name="Lat1"><Description>
        Latitude of waypoint 1. If nan, waypoint is skipped.
    </Description><Units:degree/><Value>NaN</Value></DefineArg>

    <DefineArg Name="Lon1"><Description>
        Longitude of waypoint 1. If nan, waypoint is skipped.
    </Description><Units:degree/><Value>NaN</Value></DefineArg>

    <DefineArg Name="Lat2"><Description>
        Latitude of waypoint 2. If nan, waypoint is skipped.
    </Description><Units:degree/><Value>NaN</Value></DefineArg>

    <DefineArg Name="Lon2"><Description>
        Longitude of waypoint 2. If nan, waypoint is skipped.
    </Description><Units:degree/><Value>NaN</Value></DefineArg>

    <DefineArg Name="Lat3"><Description>
        Latitude of waypoint 3. If nan, waypoint is skipped.
    </Description><Units:degree/><Value>NaN</Value></DefineArg>

    <DefineArg Name="Lon3"><Description>
        Longitude of waypoint 3. If nan, waypoint is skipped.
    </Description><Units:degree/><Value>NaN</Value></DefineArg>

    <DefineArg Name="Lat4"><Description>
        Latitude of waypoint 4. If nan, waypoint is skipped.
    </Description><Units:degree/><Value>NaN</Value></DefineArg>

    <DefineArg Name="Lon4"><Description>
        Longitude of waypoint 4. If nan, waypoint is skipped.
    </Description><Units:degree/><Value>NaN</Value></DefineArg>

    <DefineArg Name="Lat5"><Description>
        Latitude of waypoint 5. If nan, waypoint is skipped.
    </Description><Units:degree/><Value>NaN</Value></DefineArg>

    <DefineArg Name="Lon5"><Description>
        Longitude of waypoint 5. If nan, waypoint is skipped.
    </Description><Units:degree/><Value>NaN</Value></DefineArg>

    <DefineArg Name="Lat6"><Description>
        Latitude of waypoint 6. If nan, waypoint is skipped.
    </Description><Units:degree/><Value>NaN</Value></DefineArg>

    <DefineArg Name="Lon6"><Description>
        Longitude of waypoint 6. If nan, waypoint is skipped.
    </Description><Units:degree/><Value>NaN</Value></DefineArg>

    <DefineArg Name="Lat7"><Description>
        Latitude of waypoint 7. If nan, waypoint is skipped.
    </Description><Units:degree/><Value>NaN</Value></DefineArg>

    <DefineArg Name="Lon7"><Description>
        Longitude of waypoint 7. If nan, waypoint is skipped.
    </Description><Units:degree/><Value>NaN</Value></DefineArg>

    <DefineArg Name="Speed"><Description>
        Speed while performing the YoYo behavior.
    </Description><Units:meter_per_second/><Value>1</Value></DefineArg>

    <DefineArg Name="CaptureRadius"><Description>
        Speed while performing the YoYo behavior.
    </Description><Units:meter/><Value>NaN</Value></DefineArg>

    <DefineArg Name="YoYoMinDepth"><Description>
        Minimum depth while performing the YoYo behavior.
    </Description><Units:meter/><Value>2</Value></DefineArg>

    <DefineArg Name="YoYoMaxDepth"><Description>
        Maximum depth while performing the YoYo behavior.
    </Description><Units:meter/><Value>200</Value></DefineArg>

    <DefineArg Name="YoYoMinAltitude"><Description>
        Minimum altitude while performing the YoYo behavior (for
        bottom-terminated YoYos).
    </Description><Units:meter/><Value>9</Value></DefineArg>

    <DefineArg Name="YoYoUpPitch"><Description>
        Vehicle up pitch while performing the YoYo behavior.
    </Description><Units:degree/><Value>20</Value></DefineArg>

    <DefineArg Name="YoYoDownPitch"><Description>
        Vehicle down pitch while performing the YoYo behavior.
    </Description><Units:degree/><Value>-20</Value></DefineArg>

    <DefineArg Name="BuoyancyNeutral"><Description>
        Buoyancy bladder position while performing the YoYo behavior. Defaults
        to buoyancyNeutral setting in the Config/Control.cfg file. Set to NaN cc
        for active buoyancy
    </Description><Control:VerticalControl.buoyancyNeutral/></DefineArg>

    <DefineArg Name="MassDefault"><Description>
        Static setting for mass during the mission. Set to NaN mm for active
        mass position
    </Description><Control:VerticalControl.massDefault/></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>

    <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>
        <RedefineArg Name="PeakDetectChlActive"><True/></RedefineArg>
    </Insert>

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

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

    <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>

    <Call Id="StartingMission" RefId="NeedComms"/>

    <Guidance:Pitch>
        <Parallel/>
        <Setting><Guidance:Pitch.massPosition/><Arg Name="MassDefault"/></Setting>
    </Guidance:Pitch>

    <Guidance:Buoyancy>
        <Parallel/>
        <Setting><Guidance:Buoyancy.position/><Arg Name="BuoyancyNeutral"/></Setting>
    </Guidance:Buoyancy>

    <Guidance:SetSpeed>
        <Parallel/>
        <Setting><Guidance:SetSpeed.speed/><Arg Name="Speed"/></Setting>
    </Guidance:SetSpeed>

    <Guidance:DepthEnvelope>
        <Description>
            Another depth envelope for the YoYo behavior. This envelope should
            fall within the limits of the standard safety envelopes in
            Insert/StandardEnvelopes.xml in order to avoid commanding high pitch
            angles for depth-terminated YoYos.
        </Description>
        <Parallel/>
        <Setting><Guidance:DepthEnvelope.minDepth/><Arg Name="YoYoMinDepth"/></Setting>
        <Setting><Guidance:DepthEnvelope.maxDepth/><Arg Name="YoYoMaxDepth"/></Setting>
        <Setting><Guidance:DepthEnvelope.downPitch/><Arg Name="YoYoDownPitch"/></Setting>
        <Setting><Guidance:DepthEnvelope.upPitch/><Arg Name="YoYoUpPitch"/></Setting>
    </Guidance:DepthEnvelope>

    <Guidance:AltitudeEnvelope>
        <Description>
            Another altitude envelope for the YoYo behavior. This envelope
            should fall within the limits of the standard safety envelopes in
            Insert/StandardEnvelopes.xml in order to avoid commanding high pitch
            angles for bottom-terminated YoYos.
        </Description>
        <Parallel/>
        <Setting><Guidance:AltitudeEnvelope.minAltitude/><Arg Name="YoYoMinAltitude"/></Setting>
        <Setting><Guidance:AltitudeEnvelope.upPitch/><Arg Name="YoYoUpPitch"/></Setting>
    </Guidance:AltitudeEnvelope>

    <Guidance:YoYo>
        <Parallel/>
        <Setting><Guidance:YoYo.downPitch/><Arg Name="YoYoDownPitch"/></Setting>
        <Setting><Guidance:YoYo.upPitch/><Arg Name="YoYoUpPitch"/></Setting>
    </Guidance:YoYo>

    <Aggregate Id="Lap">

        <Sequence Repeat="Repeat"/>

        <Aggregate Id="Wpt1">

            <Sequence/>

            <Guidance:Waypoint>
                <Sequence/>
                <Setting><Guidance:Waypoint.latitude/><Arg Name="Lat1"/></Setting>
                <Setting><Guidance:Waypoint.longitude/><Arg Name="Lon1"/></Setting>
                <Setting><Guidance:Waypoint.captureRadius/><Arg Name="CaptureRadius"/></Setting>
            </Guidance:Waypoint>

        </Aggregate>

        <Aggregate Id="Wpt2">

            <Sequence/>

            <Guidance:Waypoint>
                <Sequence/>
                <Setting><Guidance:Waypoint.latitude/><Arg Name="Lat2"/></Setting>
                <Setting><Guidance:Waypoint.longitude/><Arg Name="Lon2"/></Setting>
            </Guidance:Waypoint>

        </Aggregate>

        <Aggregate Id="Wpt3">

            <Sequence/>

            <Guidance:Waypoint>
                <Sequence/>
                <Setting><Guidance:Waypoint.latitude/><Arg Name="Lat3"/></Setting>
                <Setting><Guidance:Waypoint.longitude/><Arg Name="Lon3"/></Setting>
            </Guidance:Waypoint>

        </Aggregate>

        <Aggregate Id="Wpt4">

            <Sequence/>

            <Guidance:Waypoint>
                <Sequence/>
                <Setting><Guidance:Waypoint.latitude/><Arg Name="Lat4"/></Setting>
                <Setting><Guidance:Waypoint.longitude/><Arg Name="Lon4"/></Setting>
            </Guidance:Waypoint>

        </Aggregate>

        <Aggregate Id="Wpt5">

            <Sequence/>

            <Guidance:Waypoint>
                <Sequence/>
                <Setting><Guidance:Waypoint.latitude/><Arg Name="Lat5"/></Setting>
                <Setting><Guidance:Waypoint.longitude/><Arg Name="Lon5"/></Setting>
            </Guidance:Waypoint>

        </Aggregate>

        <Aggregate Id="Wpt6">

            <Sequence/>

            <Guidance:Waypoint>
                <Sequence/>
                <Setting><Guidance:Waypoint.latitude/><Arg Name="Lat6"/></Setting>
                <Setting><Guidance:Waypoint.longitude/><Arg Name="Lon6"/></Setting>
            </Guidance:Waypoint>

        </Aggregate>

        <Aggregate Id="Wpt7">

            <Sequence/>

            <Guidance:Waypoint>
                <Sequence/>
                <Setting><Guidance:Waypoint.latitude/><Arg Name="Lat7"/></Setting>
                <Setting><Guidance:Waypoint.longitude/><Arg Name="Lon7"/></Setting>
            </Guidance:Waypoint>

        </Aggregate>

    </Aggregate>

</Mission>


2022-01-31T19:28:10.995Z,1643657290.995 [CommandExec](IMPORTANT): Loaded ./Missions/Science/sci2.xml
2022-01-31T19:28:19.377Z,1643657299.377 [CommandExec](IMPORTANT): got command set sci2.MissionTimeout 30 minute
2022-01-31T19:28:19.378Z,1643657299.378 [CommandExec](IMPORTANT): got command set sci2.NeedCommsTime 30 minute
2022-01-31T19:28:19.379Z,1643657299.379 [CommandExec](IMPORTANT): got command set sci2.Lat1 41.501148 degree
2022-01-31T19:28:19.379Z,1643657299.379 [CommandExec](IMPORTANT): got command set sci2.Lon1 -70.811485 degree
2022-01-31T19:28:19.380Z,1643657299.380 [CommandExec](IMPORTANT): got command set sci2.Speed .8 meter_per_second
2022-01-31T19:28:19.381Z,1643657299.381 [CommandExec](IMPORTANT): got command set sci2.YoYoMinDepth 3 meter
2022-01-31T19:28:19.382Z,1643657299.382 [CommandExec](IMPORTANT): got command set sci2.YoYoMaxDepth 7 meter
2022-01-31T19:28:25.129Z,1643657305.129 [CommandExec](IMPORTANT): got command set sci2.YoYoMinAltitude 3 meter
2022-01-31T19:28:25.129Z,1643657305.129 [CommandExec](IMPORTANT): got command set sci2.MinAltitude 3 meter
2022-01-31T19:28:25.130Z,1643657305.130 [CommandExec](IMPORTANT): got command set sci2.MaxDepth 9 meter
2022-01-31T19:28:25.131Z,1643657305.131 [CommandExec](IMPORTANT): got command set sci2:NeedComms.CommsTimeout 30 minute
2022-01-31T19:28:25.131Z,1643657305.131 [CommandExec](IMPORTANT): got command run
2022-01-31T19:28:25.143Z,1643657305.143 [CommandExec](IMPORTANT): Running 
2022-01-31T19:28:25.308Z,1643657305.308 [Default] Stopped
2022-01-31T19:28:25.308Z,1643657305.308 [Default](DEBUG): Aggregate::uninitialize Default
2022-01-31T19:28:25.309Z,1643657305.309 [Default:B.GoToSurface] Stopped
2022-01-31T19:28:25.309Z,1643657305.309 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2022-01-31T19:28:25.309Z,1643657305.309 [Default:CheckIn] Stopped
2022-01-31T19:28:25.309Z,1643657305.309 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2022-01-31T19:28:25.309Z,1643657305.309 [Default:CheckIn:C.Wait] Stopped
2022-01-31T19:28:25.309Z,1643657305.309 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2022-01-31T19:28:25.309Z,1643657305.309 [MissionManager](IMPORTANT): Started mission sci2
2022-01-31T19:28:25.309Z,1643657305.309 [sci2] Running Loop=1
2022-01-31T19:28:25.309Z,1643657305.309 [sci2](DEBUG): Aggregate::initialize sci2
2022-01-31T19:28:25.309Z,1643657305.309 [sci2:Science] Running Loop=1
2022-01-31T19:28:25.310Z,1643657305.310 [sci2:Science](DEBUG): Aggregate::initialize sci2:Science
2022-01-31T19:28:25.310Z,1643657305.310 [sci2:Science:A] Running Loop=1
2022-01-31T19:28:25.310Z,1643657305.310 [sci2:Science:B] Running Loop=1
2022-01-31T19:28:25.310Z,1643657305.310 [sci2:Science:C] Running Loop=1
2022-01-31T19:28:25.310Z,1643657305.310 [sci2:Science:D] Running Loop=1
2022-01-31T19:28:25.310Z,1643657305.310 [sci2:Science:E] Running Loop=1
2022-01-31T19:28:25.310Z,1643657305.310 [sci2:Science:F] Running Loop=1
2022-01-31T19:28:25.310Z,1643657305.310 [sci2:Science:Read_Oil] Running Loop=1
2022-01-31T19:28:25.310Z,1643657305.310 [sci2:Science:PeakDetectChl] Running Loop=1
2022-01-31T19:28:25.310Z,1643657305.310 [sci2:Science:PeakDetectChl](DEBUG): Aggregate::initialize sci2:Science:PeakDetectChl
2022-01-31T19:28:25.310Z,1643657305.310 [sci2:Science:PeakDetectChl:A.PeakDetectVsDepth] Running Loop=1
2022-01-31T19:28:25.310Z,1643657305.310 [sci2:Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Initialize.
2022-01-31T19:28:25.313Z,1643657305.313 [sci2:Science:HighestChlPeakReport] Running Loop=1
2022-01-31T19:28:25.313Z,1643657305.313 [sci2:Science:HighestChlPeakReport](DEBUG): Aggregate::initialize sci2:Science:HighestChlPeakReport
2022-01-31T19:28:25.313Z,1643657305.313 [sci2:Science:HighestChlPeakReport:A.PeakDetectHorizontal] Running Loop=1
2022-01-31T19:28:25.313Z,1643657305.313 [sci2:Science:HighestChlPeakReport:A.PeakDetectHorizontal](INFO): Initialize.
2022-01-31T19:28:25.313Z,1643657305.313 [sci2:Science:PeakDetectNO3] Running Loop=1
2022-01-31T19:28:25.314Z,1643657305.314 [sci2:Science:PeakDetectNO3](DEBUG): Aggregate::initialize sci2:Science:PeakDetectNO3
2022-01-31T19:28:25.314Z,1643657305.314 [sci2:Science:PeakDetectNO3:A.PeakDetectVsDepth] Running Loop=1
2022-01-31T19:28:25.314Z,1643657305.314 [sci2:Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Initialize.
2022-01-31T19:28:25.332Z,1643657305.332 [sci2:Science:PeakDetectOil] Running Loop=1
2022-01-31T19:28:25.332Z,1643657305.332 [sci2:Science:PeakDetectOil](DEBUG): Aggregate::initialize sci2:Science:PeakDetectOil
2022-01-31T19:28:25.332Z,1643657305.332 [sci2:Science:PeakDetectOil:A.PeakDetectVsDepth] Running Loop=1
2022-01-31T19:28:25.332Z,1643657305.332 [sci2:Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Initialize.
2022-01-31T19:28:25.334Z,1643657305.334 [sci2:Science:HighestOilPeakReport] Running Loop=1
2022-01-31T19:28:25.334Z,1643657305.334 [sci2:Science:HighestOilPeakReport](DEBUG): Aggregate::initialize sci2:Science:HighestOilPeakReport
2022-01-31T19:28:25.334Z,1643657305.334 [sci2:Science:HighestOilPeakReport:A.PeakDetectHorizontal] Running Loop=1
2022-01-31T19:28:25.334Z,1643657305.334 [sci2:Science:HighestOilPeakReport:A.PeakDetectHorizontal](INFO): Initialize.
2022-01-31T19:28:25.334Z,1643657305.334 [sci2:Science:PeakDetectFDOM] Running Loop=1
2022-01-31T19:28:25.335Z,1643657305.335 [sci2:Science:PeakDetectFDOM](DEBUG): Aggregate::initialize sci2:Science:PeakDetectFDOM
2022-01-31T19:28:25.335Z,1643657305.335 [sci2:Science:PeakDetectFDOM:A.PeakDetectVsDepth] Running Loop=1
2022-01-31T19:28:25.335Z,1643657305.335 [sci2:Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Initialize.
2022-01-31T19:28:25.338Z,1643657305.338 [sci2:Science:PeakDetectSalinity] Running Loop=1
2022-01-31T19:28:25.338Z,1643657305.338 [sci2:Science:PeakDetectSalinity](DEBUG): Aggregate::initialize sci2:Science:PeakDetectSalinity
2022-01-31T19:28:25.339Z,1643657305.339 [sci2:Science:PeakDetectSalinity:A.PeakDetectVsDepth] Running Loop=1
2022-01-31T19:28:25.339Z,1643657305.339 [sci2:Science:PeakDetectSalinity:A.PeakDetectVsDepth](DEBUG): Initialize.
2022-01-31T19:28:25.349Z,1643657305.349 [sci2:Science:HighestSaltPeakReport] Running Loop=1
2022-01-31T19:28:25.349Z,1643657305.349 [sci2:Science:HighestSaltPeakReport](DEBUG): Aggregate::initialize sci2:Science:HighestSaltPeakReport
2022-01-31T19:28:25.349Z,1643657305.349 [sci2:Science:HighestSaltPeakReport:A.PeakDetectHorizontal] Running Loop=1
2022-01-31T19:28:25.349Z,1643657305.349 [sci2:Science:HighestSaltPeakReport:A.PeakDetectHorizontal](INFO): Initialize.
2022-01-31T19:28:25.350Z,1643657305.350 [sci2:Science:OceanCurrent] Running Loop=1
2022-01-31T19:28:25.350Z,1643657305.350 [sci2:Science:OceanCurrent](DEBUG): Aggregate::initialize sci2:Science:OceanCurrent
2022-01-31T19:28:25.350Z,1643657305.350 [sci2:Science:OceanCurrent:A.] Running Loop=1
2022-01-31T19:28:25.350Z,1643657305.350 [sci2:Science:OceanCurrent:A.](INFO): Initializing CurrentEstimator.
2022-01-31T19:28:25.350Z,1643657305.350 [sci2:StandardEnvelopes] Running Loop=1
2022-01-31T19:28:25.350Z,1643657305.350 [sci2:StandardEnvelopes](DEBUG): Aggregate::initialize sci2:StandardEnvelopes
2022-01-31T19:28:25.350Z,1643657305.350 [sci2:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1
2022-01-31T19:28:25.350Z,1643657305.350 [sci2:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Initialize AltitudeEnvelopeComponent.
2022-01-31T19:28:25.351Z,1643657305.351 [sci2:StandardEnvelopes:B.DepthEnvelope] Running Loop=1
2022-01-31T19:28:25.351Z,1643657305.351 [sci2:StandardEnvelopes:B.DepthEnvelope](DEBUG): Initialize DepthEnvelopeComponent.
2022-01-31T19:28:25.351Z,1643657305.351 [sci2:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1
2022-01-31T19:28:25.351Z,1643657305.351 [sci2:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Initialize OffshoreEnvelopeComponent.
2022-01-31T19:28:25.351Z,1643657305.351 [sci2:I.Pitch] Running Loop=1
2022-01-31T19:28:25.351Z,1643657305.351 [sci2:I.Pitch](DEBUG): Initialize.
2022-01-31T19:28:25.351Z,1643657305.351 [sci2:J.Buoyancy] Running Loop=1
2022-01-31T19:28:25.351Z,1643657305.351 [sci2:J.Buoyancy](DEBUG): Initialize Buoyancy Component.
2022-01-31T19:28:25.351Z,1643657305.351 [sci2:K.SetSpeed] Running Loop=1
2022-01-31T19:28:25.356Z,1643657305.356 [sci2:K.SetSpeed](DEBUG): Initialize.
2022-01-31T19:28:25.356Z,1643657305.356 [sci2:L.DepthEnvelope] Running Loop=1
2022-01-31T19:28:25.356Z,1643657305.356 [sci2:L.DepthEnvelope](DEBUG): Initialize DepthEnvelopeComponent.
2022-01-31T19:28:25.356Z,1643657305.356 [sci2:M.AltitudeEnvelope] Running Loop=1
2022-01-31T19:28:25.357Z,1643657305.357 [sci2:M.AltitudeEnvelope](DEBUG): Initialize AltitudeEnvelopeComponent.
2022-01-31T19:28:25.357Z,1643657305.357 [sci2:N.YoYo] Running Loop=1
2022-01-31T19:28:25.357Z,1643657305.357 [sci2:N.YoYo](DEBUG): Initialize YoYoComponent.
2022-01-31T19:28:25.357Z,1643657305.357 [sci2:C] Running Loop=1
2022-01-31T19:28:25.358Z,1643657305.358 [sci2:N.YoYo] Running Loop=1
2022-01-31T19:28:25.358Z,1643657305.358 [sci2:M.AltitudeEnvelope] Running Loop=1
2022-01-31T19:28:25.359Z,1643657305.359 [sci2:L.DepthEnvelope] Running Loop=1
2022-01-31T19:28:25.369Z,1643657305.369 [sci2:K.SetSpeed] Running Loop=1
2022-01-31T19:28:25.369Z,1643657305.369 [sci2:J.Buoyancy] Running Loop=1
2022-01-31T19:28:25.369Z,1643657305.369 [sci2:I.Pitch] Running Loop=1
2022-01-31T19:28:25.370Z,1643657305.370 [sci2:StandardEnvelopes] Running Loop=1
2022-01-31T19:28:25.370Z,1643657305.370 [sci2:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1
2022-01-31T19:28:25.370Z,1643657305.370 [sci2:StandardEnvelopes:B.DepthEnvelope] Running Loop=1
2022-01-31T19:28:25.370Z,1643657305.370 [sci2:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1
2022-01-31T19:28:25.371Z,1643657305.371 [sci2:C] Stopped
2022-01-31T19:28:25.371Z,1643657305.371 [sci2:E] Running Loop=1
2022-01-31T19:28:25.371Z,1643657305.371 [sci2:Science] Running Loop=1
2022-01-31T19:28:25.376Z,1643657305.376 [sci2:Science:HighestSaltPeakReport] Stopped
2022-01-31T19:28:25.377Z,1643657305.377 [sci2:Science:HighestSaltPeakReport](DEBUG): Aggregate::uninitialize sci2:Science:HighestSaltPeakReport
2022-01-31T19:28:25.377Z,1643657305.377 [sci2:Science:HighestSaltPeakReport:A.PeakDetectHorizontal] Stopped
2022-01-31T19:28:25.377Z,1643657305.377 [sci2:Science:HighestSaltPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize.
2022-01-31T19:28:25.377Z,1643657305.377 [sci2:Science:PeakDetectSalinity] Stopped
2022-01-31T19:28:25.377Z,1643657305.377 [sci2:Science:PeakDetectSalinity](DEBUG): Aggregate::uninitialize sci2:Science:PeakDetectSalinity
2022-01-31T19:28:25.377Z,1643657305.377 [sci2:Science:PeakDetectSalinity:A.PeakDetectVsDepth] Stopped
2022-01-31T19:28:25.377Z,1643657305.377 [sci2:Science:PeakDetectSalinity:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2022-01-31T19:28:25.377Z,1643657305.377 [sci2:Science:PeakDetectFDOM] Stopped
2022-01-31T19:28:25.377Z,1643657305.377 [sci2:Science:PeakDetectFDOM](DEBUG): Aggregate::uninitialize sci2:Science:PeakDetectFDOM
2022-01-31T19:28:25.377Z,1643657305.377 [sci2:Science:PeakDetectFDOM:A.PeakDetectVsDepth] Stopped
2022-01-31T19:28:25.377Z,1643657305.377 [sci2:Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2022-01-31T19:28:25.377Z,1643657305.377 [sci2:Science:HighestOilPeakReport] Stopped
2022-01-31T19:28:25.377Z,1643657305.377 [sci2:Science:HighestOilPeakReport](DEBUG): Aggregate::uninitialize sci2:Science:HighestOilPeakReport
2022-01-31T19:28:25.378Z,1643657305.378 [sci2:Science:HighestOilPeakReport:A.PeakDetectHorizontal] Stopped
2022-01-31T19:28:25.378Z,1643657305.378 [sci2:Science:HighestOilPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize.
2022-01-31T19:28:25.378Z,1643657305.378 [sci2:Science:PeakDetectOil] Stopped
2022-01-31T19:28:25.378Z,1643657305.378 [sci2:Science:PeakDetectOil](DEBUG): Aggregate::uninitialize sci2:Science:PeakDetectOil
2022-01-31T19:28:25.378Z,1643657305.378 [sci2:Science:PeakDetectOil:A.PeakDetectVsDepth] Stopped
2022-01-31T19:28:25.378Z,1643657305.378 [sci2:Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2022-01-31T19:28:25.378Z,1643657305.378 [sci2:Science:PeakDetectNO3] Stopped
2022-01-31T19:28:25.378Z,1643657305.378 [sci2:Science:PeakDetectNO3](DEBUG): Aggregate::uninitialize sci2:Science:PeakDetectNO3
2022-01-31T19:28:25.378Z,1643657305.378 [sci2:Science:PeakDetectNO3:A.PeakDetectVsDepth] Stopped
2022-01-31T19:28:25.378Z,1643657305.378 [sci2:Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2022-01-31T19:28:25.378Z,1643657305.378 [sci2:Science:HighestChlPeakReport] Stopped
2022-01-31T19:28:25.378Z,1643657305.378 [sci2:Science:HighestChlPeakReport](DEBUG): Aggregate::uninitialize sci2:Science:HighestChlPeakReport
2022-01-31T19:28:25.378Z,1643657305.378 [sci2:Science:HighestChlPeakReport:A.PeakDetectHorizontal] Stopped
2022-01-31T19:28:25.378Z,1643657305.378 [sci2:Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize.
2022-01-31T19:28:25.379Z,1643657305.379 [sci2:Science:PeakDetectChl] Running Loop=1
2022-01-31T19:28:25.379Z,1643657305.379 [sci2:Science:OceanCurrent:A.] Running Loop=1
2022-01-31T19:28:25.385Z,1643657305.385 [sci2:Science:Read_Oil] Running Loop=1
2022-01-31T19:28:25.386Z,1643657305.386 [sci2:Science:Read_Oil](DEBUG): Initialize ReadDataComponent to sense mass_concentration_of_petroleum_hydrocarbons_in_sea_water
2022-01-31T19:28:25.386Z,1643657305.386 [sci2:Science:F] Stopped
2022-01-31T19:28:25.386Z,1643657305.386 [sci2:Science:E] Running Loop=1
2022-01-31T19:28:25.387Z,1643657305.387 [sci2:Science:E](DEBUG): Initialize ReadDataComponent to sense mass_concentration_of_chlorophyll_in_sea_water
2022-01-31T19:28:25.387Z,1643657305.387 [sci2:Science:D] Stopped
2022-01-31T19:28:25.387Z,1643657305.387 [sci2:Science:C] Running Loop=1
2022-01-31T19:28:25.387Z,1643657305.387 [sci2:Science:C](DEBUG): Initialize ReadDataComponent to sense CTD_Seabird.sea_water_temperature
2022-01-31T19:28:25.392Z,1643657305.392 [sci2:Science:C](DEBUG): Initialize ReadDataComponent to sense CTD_Seabird.sea_water_salinity
2022-01-31T19:28:25.393Z,1643657305.393 [sci2:Science:B] Running Loop=1
2022-01-31T19:28:25.393Z,1643657305.393 [sci2:Science:B](DEBUG): Initialize ReadDataComponent to sense sea_water_temperature
2022-01-31T19:28:25.394Z,1643657305.394 [sci2:Science:B](DEBUG): Initialize ReadDataComponent to sense sea_water_salinity
2022-01-31T19:28:25.394Z,1643657305.394 [sci2:Science:A] Stopped
2022-01-31T19:28:25.584Z,1643657305.584 [WetLabsSeaOWL_UV_A](INFO): Powering up
2022-01-31T19:28:25.834Z,1643657305.834 [sci2:E] Stopped
2022-01-31T19:28:25.834Z,1643657305.834 [sci2:F] Running Loop=1
2022-01-31T19:28:26.119Z,1643657306.119 [sci2:F] Stopped
2022-01-31T19:28:26.119Z,1643657306.119 [sci2:G] Running Loop=1
2022-01-31T19:28:26.516Z,1643657306.516 [sci2:G] Stopped
2022-01-31T19:28:26.516Z,1643657306.516 [sci2:StartingMission] Running Loop=1
2022-01-31T19:28:26.516Z,1643657306.516 [sci2:StartingMission](DEBUG): Aggregate::initialize sci2:StartingMission
2022-01-31T19:28:26.923Z,1643657306.923 [sci2:NeedComms] Running Loop=1
2022-01-31T19:28:26.923Z,1643657306.923 [sci2:NeedComms](DEBUG): Aggregate::initialize sci2:NeedComms
2022-01-31T19:28:26.924Z,1643657306.924 [sci2:NeedComms:B.GoToSurface] Running Loop=1
2022-01-31T19:28:26.924Z,1643657306.924 [sci2:NeedComms:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2022-01-31T19:28:26.924Z,1643657306.924 [sci2:NeedComms:B.GoToSurface](INFO): Received depth rate setting nan m/s.
2022-01-31T19:28:26.925Z,1643657306.925 [sci2:NeedComms:B.GoToSurface](INFO): Received pitch setting 19.999999 degrees.
2022-01-31T19:28:26.925Z,1643657306.925 [sci2:NeedComms:B.GoToSurface](INFO): Received speed setting 1.000000 m/s.
2022-01-31T19:28:26.925Z,1643657306.925 [sci2:NeedComms:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2022-01-31T19:28:26.926Z,1643657306.926 [sci2:NeedComms:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2022-01-31T19:28:26.926Z,1643657306.926 [sci2:NeedComms:A] Running Loop=1
2022-01-31T19:28:26.927Z,1643657306.927 [sci2:NeedComms:A](INFO): last time_fix was: 1643657154.000000 second since 1970/01/01T00:00:00Z 
2022-01-31T19:28:26.927Z,1643657306.927 [sci2:NeedComms:A] Stopped
2022-01-31T19:28:27.343Z,1643657307.343 [sci2:NeedComms:C] Running Loop=1
2022-01-31T19:28:27.767Z,1643657307.767 [sci2:NeedComms:C](DEBUG): Initialize ReadDataComponent to sense time_fix
2022-01-31T19:28:29.332Z,1643657309.332 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,192831.00,A,4128.91244,N,07053.67685,W,0.389,278.91,310122,,,D*73
2022-01-31T19:28:29.335Z,1643657309.335 [NAL9602](INFO): GPS fix at 20220131T192831: (41.481874, -70.894614)
2022-01-31T19:28:29.350Z,1643657309.350 [sci2:NeedComms:C] Stopped
2022-01-31T19:28:29.350Z,1643657309.350 [sci2:NeedComms:D] Running Loop=1
2022-01-31T19:28:29.798Z,1643657309.798 [sci2:NeedComms:D](DEBUG): Initialize ReadDataComponent to sense platform_communications
2022-01-31T19:28:33.600Z,1643657313.600 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20220131T184610/Courier0025.lzma
2022-01-31T19:28:34.602Z,1643657314.602 [DataOverHttps](INFO): Moved sent file to Logs/20220131T184610/Courier0025.lzma.bak
2022-01-31T19:28:34.602Z,1643657314.602 [DataOverHttps](INFO): SBD MOMSN=1376380
2022-01-31T19:28:43.643Z,1643657323.643 [DataOverHttps](INFO): Sending 52 bytes from file Logs/20220131T184610/Courier0028.lzma
2022-01-31T19:28:44.642Z,1643657324.642 [DataOverHttps](INFO): Moved sent file to Logs/20220131T184610/Courier0028.lzma.bak
2022-01-31T19:28:44.642Z,1643657324.642 [DataOverHttps](INFO): SBD MOMSN=1376383
2022-01-31T19:28:48.724Z,1643657328.724 [NAL9602](INFO): SBD MO Status=2, MOMSN=35498, MT Status=2, MTMSN=0
2022-01-31T19:28:48.724Z,1643657328.724 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2022-01-31T19:28:53.691Z,1643657333.691 [DataOverHttps](INFO): Sending 628 bytes from file Logs/20220131T184610/Express0026.lzma
2022-01-31T19:28:54.682Z,1643657334.682 [DataOverHttps](INFO): Moved sent file to Logs/20220131T184610/Express0026.lzma.bak
2022-01-31T19:28:54.682Z,1643657334.682 [DataOverHttps](INFO): SBD MOMSN=1376385
2022-01-31T19:29:03.723Z,1643657343.723 [DataOverHttps](INFO): Sending 79 bytes from file Logs/20220131T184610/Express0029.lzma
2022-01-31T19:29:04.479Z,1643657344.479 [NAL9602](INFO): SBD MO Status=0, MOMSN=35498, MT Status=0, MTMSN=0
2022-01-31T19:29:04.479Z,1643657344.479 [NAL9602](INFO): No messages in MT queue
2022-01-31T19:29:04.722Z,1643657344.722 [DataOverHttps](INFO): Moved sent file to Logs/20220131T184610/Express0029.lzma.bak
2022-01-31T19:29:04.722Z,1643657344.722 [DataOverHttps](INFO): SBD MOMSN=1376411
2022-01-31T19:29:06.513Z,1643657346.513 [sci2:NeedComms:D] Stopped
2022-01-31T19:29:06.513Z,1643657346.513 [sci2:NeedComms:E] Running Loop=1
2022-01-31T19:29:06.921Z,1643657346.921 [sci2:NeedComms:E](DEBUG): Initialize ReadDataComponent to sense time_fix
2022-01-31T19:29:08.531Z,1643657348.531 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,192910.00,A,4128.91225,N,07053.68084,W,0.233,278.91,310122,,,D*7E
2022-01-31T19:29:08.533Z,1643657348.533 [NAL9602](INFO): GPS fix at 20220131T192910: (41.481871, -70.894681)
2022-01-31T19:29:08.575Z,1643657348.575 [sci2:NeedComms:E] Stopped
2022-01-31T19:29:08.580Z,1643657348.580 [sci2:NeedComms](INFO): Completed sci2:NeedComms
2022-01-31T19:29:08.580Z,1643657348.580 [sci2:NeedComms] Stopped
2022-01-31T19:29:08.580Z,1643657348.580 [sci2:NeedComms](DEBUG): Aggregate::uninitialize sci2:NeedComms
2022-01-31T19:29:08.581Z,1643657348.581 [sci2:NeedComms:B.GoToSurface] Stopped
2022-01-31T19:29:08.581Z,1643657348.581 [sci2:NeedComms:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2022-01-31T19:29:08.956Z,1643657348.956 [sci2:StartingMission](INFO): Completed sci2:StartingMission
2022-01-31T19:29:08.956Z,1643657348.956 [sci2:StartingMission] Stopped
2022-01-31T19:29:08.956Z,1643657348.956 [sci2:StartingMission](DEBUG): Aggregate::uninitialize sci2:StartingMission
2022-01-31T19:29:08.957Z,1643657348.957 [sci2:Lap] Running Loop=1
2022-01-31T19:29:08.957Z,1643657348.957 [sci2:Lap](DEBUG): Aggregate::initialize sci2:Lap
2022-01-31T19:29:08.957Z,1643657348.957 [sci2:Lap:Wpt1] Running Loop=1
2022-01-31T19:29:08.957Z,1643657348.957 [sci2:Lap:Wpt1](DEBUG): Aggregate::initialize sci2:Lap:Wpt1
2022-01-31T19:29:08.957Z,1643657348.957 [sci2:Lap:Wpt1:A.Waypoint] Running Loop=1
2022-01-31T19:29:08.957Z,1643657348.957 [sci2:Lap:Wpt1:A.Waypoint](DEBUG): Initialize WaypointComponent.
2022-01-31T19:29:34.753Z,1643657374.753 [CommandExec](IMPORTANT): got command stop
2022-01-31T19:29:34.753Z,1643657374.753 [CommandExec](IMPORTANT): Scheduling is paused
2022-01-31T19:29:34.753Z,1643657374.753 [Supervisor](INFO): Stop Mission called by CommandExec::commandStop
2022-01-31T19:29:34.826Z,1643657374.826 [MissionManager](INFO): MissionManager is completed.
2022-01-31T19:29:34.826Z,1643657374.826 [MissionManager](INFO): Uninitializing Mission sci2
2022-01-31T19:29:34.826Z,1643657374.826 [sci2] Stopped
2022-01-31T19:29:34.827Z,1643657374.827 [sci2](DEBUG): Aggregate::uninitialize sci2
2022-01-31T19:29:34.827Z,1643657374.827 [sci2:Science] Stopped
2022-01-31T19:29:34.827Z,1643657374.827 [sci2:Science](DEBUG): Aggregate::uninitialize sci2:Science
2022-01-31T19:29:34.827Z,1643657374.827 [sci2:Science:B] Stopped
2022-01-31T19:29:34.827Z,1643657374.827 [sci2:Science:C] Stopped
2022-01-31T19:29:34.827Z,1643657374.827 [sci2:Science:E] Stopped
2022-01-31T19:29:34.827Z,1643657374.827 [sci2:Science:Read_Oil] Stopped
2022-01-31T19:29:34.827Z,1643657374.827 [sci2:Science:OceanCurrent] Stopped
2022-01-31T19:29:34.827Z,1643657374.827 [sci2:Science:OceanCurrent](DEBUG): Aggregate::uninitialize sci2:Science:OceanCurrent
2022-01-31T19:29:34.827Z,1643657374.827 [sci2:Science:OceanCurrent:A.] Stopped
2022-01-31T19:29:34.827Z,1643657374.827 [sci2:Science:PeakDetectChl] Stopped
2022-01-31T19:29:34.827Z,1643657374.827 [sci2:Science:PeakDetectChl](DEBUG): Aggregate::uninitialize sci2:Science:PeakDetectChl
2022-01-31T19:29:34.827Z,1643657374.827 [sci2:Science:PeakDetectChl:A.PeakDetectVsDepth] Stopped
2022-01-31T19:29:34.827Z,1643657374.827 [sci2:Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2022-01-31T19:29:34.840Z,1643657374.840 [sci2:StandardEnvelopes] Stopped
2022-01-31T19:29:34.840Z,1643657374.840 [sci2:StandardEnvelopes](DEBUG): Aggregate::uninitialize sci2:StandardEnvelopes
2022-01-31T19:29:34.840Z,1643657374.840 [sci2:StandardEnvelopes:A.AltitudeEnvelope] Stopped
2022-01-31T19:29:34.840Z,1643657374.840 [sci2:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Uninitialize AltitudeEnvelopeComponent.
2022-01-31T19:29:34.840Z,1643657374.840 [sci2:StandardEnvelopes:B.DepthEnvelope] Stopped
2022-01-31T19:29:34.840Z,1643657374.840 [sci2:StandardEnvelopes:B.DepthEnvelope](DEBUG): Uninitialize.
2022-01-31T19:29:34.840Z,1643657374.840 [sci2:StandardEnvelopes:C.OffshoreEnvelope] Stopped
2022-01-31T19:29:34.840Z,1643657374.840 [sci2:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Uninitialize OffshoreEnvelopeComponent.
2022-01-31T19:29:34.840Z,1643657374.840 [sci2:I.Pitch] Stopped
2022-01-31T19:29:34.840Z,1643657374.840 [sci2:J.Buoyancy] Stopped
2022-01-31T19:29:34.841Z,1643657374.841 [sci2:J.Buoyancy](DEBUG): Uninitialize Buoyancy Component.
2022-01-31T19:29:34.841Z,1643657374.841 [sci2:K.SetSpeed] Stopped
2022-01-31T19:29:34.841Z,1643657374.841 [sci2:K.SetSpeed](DEBUG): Uninitialize.
2022-01-31T19:29:34.841Z,1643657374.841 [sci2:L.DepthEnvelope] Stopped
2022-01-31T19:29:34.841Z,1643657374.841 [sci2:L.DepthEnvelope](DEBUG): Uninitialize.
2022-01-31T19:29:34.841Z,1643657374.841 [sci2:M.AltitudeEnvelope] Stopped
2022-01-31T19:29:34.841Z,1643657374.841 [sci2:M.AltitudeEnvelope](DEBUG): Uninitialize AltitudeEnvelopeComponent.
2022-01-31T19:29:34.841Z,1643657374.841 [sci2:N.YoYo] Stopped
2022-01-31T19:29:34.841Z,1643657374.841 [sci2:N.YoYo](DEBUG): Uninitialize YoYoComponent.
2022-01-31T19:29:34.841Z,1643657374.841 [sci2:Lap] Stopped
2022-01-31T19:29:34.841Z,1643657374.841 [sci2:Lap](DEBUG): Aggregate::uninitialize sci2:Lap
2022-01-31T19:29:34.841Z,1643657374.841 [sci2:Lap:Wpt1] Stopped
2022-01-31T19:29:34.841Z,1643657374.841 [sci2:Lap:Wpt1](DEBUG): Aggregate::uninitialize sci2:Lap:Wpt1
2022-01-31T19:29:34.841Z,1643657374.841 [sci2:Lap:Wpt1:A.Waypoint] Stopped
2022-01-31T19:29:34.842Z,1643657374.842 [sci2:Lap:Wpt1:A.Waypoint](DEBUG): Uninitialize WaypointComponent.
2022-01-31T19:29:35.028Z,1643657375.028 [WetLabsSeaOWL_UV_A](INFO): Powering down
2022-01-31T19:29:35.201Z,1643657375.201 [MissionManager](IMPORTANT): Started mission Default
2022-01-31T19:29:35.201Z,1643657375.201 [Default] Running Loop=1
2022-01-31T19:29:35.201Z,1643657375.201 [Default](DEBUG): Aggregate::initialize Default
2022-01-31T19:29:35.201Z,1643657375.201 [Default:B.GoToSurface] Running Loop=1
2022-01-31T19:29:35.202Z,1643657375.202 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2022-01-31T19:29:35.202Z,1643657375.202 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2022-01-31T19:29:35.202Z,1643657375.202 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2022-01-31T19:29:35.202Z,1643657375.202 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2022-01-31T19:29:35.203Z,1643657375.203 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2022-01-31T19:29:35.203Z,1643657375.203 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2022-01-31T19:29:35.203Z,1643657375.203 [Default:A.Wait] Running Loop=1
2022-01-31T19:29:35.203Z,1643657375.203 [Default:A.Wait](DEBUG): Initialize Wait Component.
2022-01-31T19:29:38.839Z,1643657378.839 [ElevatorOffsetCalculator](INFO): New estimator for commanded vars: speed 1.00 m/s, pitch 30.00 deg, mass-position -25.00 mm (1 active estimators).
2022-01-31T19:29:40.434Z,1643657380.434 [NAL9602](INFO): Not Powering down - fast GPS
2022-01-31T19:29:48.537Z,1643657388.537 [Default:A.Wait](INFO): Done Waiting.
2022-01-31T19:29:48.537Z,1643657388.537 [Default:A.Wait] Stopped
2022-01-31T19:29:48.537Z,1643657388.537 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2022-01-31T19:30:09.534Z,1643657409.534 [Default:CheckIn] Running Loop=1
2022-01-31T19:30:09.534Z,1643657409.534 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2022-01-31T19:30:09.534Z,1643657409.534 [Default:CheckIn:Read_GPS] Running Loop=1
2022-01-31T19:30:10.009Z,1643657410.009 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.267826
2022-01-31T19:30:12.250Z,1643657412.250 [CTD_Seabird](ERROR): Salinity reading out of range: 23.829645 psu
2022-01-31T19:30:13.254Z,1643657413.254 [CTD_Seabird](ERROR): Salinity reading out of range: 25.251007 psu
2022-01-31T19:30:26.080Z,1643657426.080 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003136
2022-01-31T19:30:41.843Z,1643657441.843 [NAL9602](INFO): SBD MO Status=0, MOMSN=35499, MT Status=0, MTMSN=0
2022-01-31T19:30:41.843Z,1643657441.843 [NAL9602](INFO): No messages in MT queue
2022-01-31T19:30:43.058Z,1643657443.058 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,193045.00,A,4128.93031,N,07053.69297,W,0.447,326.91,310122,,,D*7D
2022-01-31T19:30:43.061Z,1643657443.061 [NAL9602](INFO): GPS fix at 20220131T193045: (41.482172, -70.894883)
2022-01-31T19:30:43.072Z,1643657443.072 [Default:CheckIn:Read_GPS] Stopped
2022-01-31T19:30:43.072Z,1643657443.072 [Default:CheckIn:Read_Iridium] Running Loop=1
2022-01-31T19:30:56.195Z,1643657456.195 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20220131T184610/Courier0031.lzma
2022-01-31T19:30:57.198Z,1643657457.198 [DataOverHttps](INFO): Moved sent file to Logs/20220131T184610/Courier0031.lzma.bak
2022-01-31T19:30:57.198Z,1643657457.198 [DataOverHttps](INFO): SBD MOMSN=1376436
2022-01-31T19:31:06.236Z,1643657466.236 [DataOverHttps](INFO): Sending 189 bytes from file Logs/20220131T184610/Express0032.lzma
2022-01-31T19:31:07.238Z,1643657467.238 [DataOverHttps](INFO): Moved sent file to Logs/20220131T184610/Express0032.lzma.bak
2022-01-31T19:31:07.238Z,1643657467.238 [DataOverHttps](INFO): SBD MOMSN=1376439
2022-01-31T19:31:08.938Z,1643657468.938 [Default:CheckIn:Read_Iridium] Stopped
2022-01-31T19:31:08.938Z,1643657468.938 [Default:CheckIn:C.Wait] Running Loop=1
2022-01-31T19:31:08.939Z,1643657468.939 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2022-01-31T19:31:15.778Z,1643657475.778 [NAL9602](INFO): Not Powering down - fast GPS
2022-01-31T19:31:32.796Z,1643657492.796 [CommandExec](IMPORTANT): got command configSet Depth_Keller.loadAtStartup 1.000000 bool persist
2022-01-31T19:31:32.797Z,1643657492.797 [CommandExec](IMPORTANT): configSet Depth_Keller.loadAtStartup requires a restart to take effect.
2022-01-31T19:31:38.113Z,1643657498.113 [CommandExec](IMPORTANT): got command restart application
2022-01-31T19:31:39.200Z,1643657499.200 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread.
2022-01-31T19:31:39.200Z,1643657499.200 [CommandExec](INFO): Uninitializing the command executive.
2022-01-31T19:31:39.200Z,1643657499.200 [CommandExec](INFO): Uninitializing the command scheduler.
2022-01-31T19:31:39.200Z,1643657499.200 [CommandExec ThreadHandler](INFO): Thread cancelled.
2022-01-31T19:31:39.228Z,1643657499.228 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2022-01-31T19:31:39.228Z,1643657499.228 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2022-01-31T19:31:39.229Z,1643657499.229 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2022-01-31T19:31:39.229Z,1643657499.229 [NavChartDb](INFO): Join timeout helper Thread ID is 6512
2022-01-31T19:31:39.433Z,1643657499.433 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2022-01-31T19:31:39.434Z,1643657499.434 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2022-01-31T19:31:39.436Z,1643657499.436 [ComponentRegistry](INFO): Shutting down WetLabsSeaOWL_UV_A ThreadHandler
2022-01-31T19:31:39.436Z,1643657499.436 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled.
2022-01-31T19:31:39.436Z,1643657499.436 [WetLabsSeaOWL_UV_A](INFO): Join timeout helper Thread ID is 6513
2022-01-31T19:31:39.472Z,1643657499.472 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Uninitializing protected caller thread.
2022-01-31T19:31:39.472Z,1643657499.472 [WetLabsSeaOWL_UV_A](INFO): Powering down
2022-01-31T19:31:39.473Z,1643657499.473 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled.
2022-01-31T19:31:39.476Z,1643657499.476 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2022-01-31T19:31:39.476Z,1643657499.476 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2022-01-31T19:31:39.476Z,1643657499.476 [CTD_Seabird](INFO): Join timeout helper Thread ID is 6514
2022-01-31T19:31:39.625Z,1643657499.625 [CTD_Seabird](INFO): Powering down
2022-01-31T19:31:39.756Z,1643657499.756 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2022-01-31T19:31:39.756Z,1643657499.756 [CTD_Seabird](INFO): Powering down
2022-01-31T19:31:39.768Z,1643657499.768 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2022-01-31T19:31:39.776Z,1643657499.776 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2022-01-31T19:31:39.776Z,1643657499.776 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2022-01-31T19:31:39.776Z,1643657499.776 [Radio_Surface](INFO): Join timeout helper Thread ID is 6515
2022-01-31T19:31:39.784Z,1643657499.784 [Radio_Surface](INFO): Powering down
2022-01-31T19:31:39.785Z,1643657499.785 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2022-01-31T19:31:39.785Z,1643657499.785 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2022-01-31T19:31:39.796Z,1643657499.796 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2022-01-31T19:31:39.796Z,1643657499.796 [Onboard ThreadHandler](INFO): Thread cancelled.
2022-01-31T19:31:39.796Z,1643657499.796 [Onboard](INFO): Join timeout helper Thread ID is 6516
2022-01-31T19:31:40.369Z,1643657500.369 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2022-01-31T19:31:43.360Z,1643657503.360 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2022-01-31T19:31:43.360Z,1643657503.360 [Onboard ThreadHandler](INFO): Thread cancelled.
2022-01-31T19:31:43.369Z,1643657503.369 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2022-01-31T19:31:43.369Z,1643657503.369 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2022-01-31T19:31:43.369Z,1643657503.369 [DataOverHttps](INFO): Join timeout helper Thread ID is 6517
2022-01-31T19:31:43.380Z,1643657503.380 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2022-01-31T19:31:43.380Z,1643657503.380 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2022-01-31T19:31:43.388Z,1643657503.388 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler
2022-01-31T19:31:43.389Z,1643657503.389 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2022-01-31T19:31:43.389Z,1643657503.389 [BackseatComponent](INFO): Join timeout helper Thread ID is 6518
2022-01-31T19:31:43.432Z,1643657503.432 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread.
2022-01-31T19:31:43.432Z,1643657503.432 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2022-01-31T19:31:43.449Z,1643657503.449 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2022-01-31T19:31:43.449Z,1643657503.449 [logger ThreadHandler](INFO): Thread cancelled.
2022-01-31T19:31:43.449Z,1643657503.449 [logger](INFO): Join timeout helper Thread ID is 6519
2022-01-31T19:31:43.467Z,1643657503.467 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2022-01-31T19:31:43.468Z,1643657503.468 [logger ThreadHandler](INFO): Thread cancelled.
2022-01-31T19:31:43.469Z,1643657503.469 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2022-01-31T19:31:43.469Z,1643657503.469 [CommandLine ThreadHandler](INFO): Thread cancelled.
2022-01-31T19:31:43.469Z,1643657503.469 [CommandLine](INFO): Join timeout helper Thread ID is 6520
2022-01-31T19:31:43.549Z,1643657503.549 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2022-01-31T19:31:43.550Z,1643657503.550 [CommandLine ThreadHandler](INFO): Thread cancelled.
2022-01-31T19:31:43.568Z,1643657503.568 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler
2022-01-31T19:31:43.569Z,1643657503.569 [CommandExec ThreadHandler](INFO): Thread cancelled.
2022-01-31T19:31:43.569Z,1643657503.569 [CommandExec](INFO): Join timeout helper Thread ID is 6521
2022-01-31T19:31:43.570Z,1643657503.570 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2022-01-31T19:31:43.570Z,1643657503.570 [controlThread ThreadHandler](INFO): Thread cancelled.
2022-01-31T19:31:43.571Z,1643657503.571 [controlThread](INFO): Join timeout helper Thread ID is 6522
2022-01-31T19:31:43.640Z,1643657503.640 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2022-01-31T19:31:43.640Z,1643657503.640 [controlThread](DEBUG): Uninitializing ControlThread
2022-01-31T19:31:43.641Z,1643657503.641 [AHRS_M2](INFO): Powering down
2022-01-31T19:31:43.713Z,1643657503.713 [NAL9602](INFO): Powering down
2022-01-31T19:31:43.784Z,1643657503.784 [RDI_Pathfinder](INFO): Powering down
2022-01-31T19:31:43.785Z,1643657503.785 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2022-01-31T19:31:43.786Z,1643657503.786 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2022-01-31T19:31:43.787Z,1643657503.787 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2022-01-31T19:31:43.788Z,1643657503.788 [MissionManager](INFO): Uninitializing Mission Default
2022-01-31T19:31:43.788Z,1643657503.788 [Default] Stopped
2022-01-31T19:31:43.788Z,1643657503.788 [Default](DEBUG): Aggregate::uninitialize Default
2022-01-31T19:31:43.788Z,1643657503.788 [Default:B.GoToSurface] Stopped
2022-01-31T19:31:43.788Z,1643657503.788 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2022-01-31T19:31:43.788Z,1643657503.788 [Default:CheckIn] Stopped
2022-01-31T19:31:43.788Z,1643657503.788 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2022-01-31T19:31:43.788Z,1643657503.788 [Default:CheckIn:C.Wait] Stopped
2022-01-31T19:31:43.788Z,1643657503.788 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2022-01-31T19:31:43.791Z,1643657503.791 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2022-01-31T19:31:43.791Z,1643657503.791 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2022-01-31T19:31:43.792Z,1643657503.792 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2022-01-31T19:31:43.792Z,1643657503.792 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2022-01-31T19:31:43.792Z,1643657503.792 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2022-01-31T19:31:43.792Z,1643657503.792 [BuoyancyServo](INFO): Powering down
2022-01-31T19:31:43.804Z,1643657503.804 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2022-01-31T19:31:43.804Z,1643657503.804 [ElevatorServo](INFO): Powering down
2022-01-31T19:31:43.805Z,1643657503.805 [MassServo](DEBUG): Uninitialize Mass Servo.
2022-01-31T19:31:43.805Z,1643657503.805 [MassServo](INFO): Powering down
2022-01-31T19:31:43.806Z,1643657503.806 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2022-01-31T19:31:43.806Z,1643657503.806 [RudderServo](INFO): Powering down
2022-01-31T19:31:43.806Z,1643657503.806 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2022-01-31T19:31:43.807Z,1643657503.807 [ThrusterHE](INFO): Powering down
2022-01-31T19:31:43.807Z,1643657503.807 [SBIT](DEBUG): Uninitialize SBIT Component.
2022-01-31T19:31:43.808Z,1643657503.808 [IBIT](DEBUG): Uninitialize IBIT Component.
2022-01-31T19:31:43.808Z,1643657503.808 [CBIT](DEBUG): Uninitialize CBIT Component.
2022-01-31T19:31:43.808Z,1643657503.808 [CBIT](DEBUG): Powering off loads.
2022-01-31T19:31:43.820Z,1643657503.820 [CBIT](DEBUG): Disabling WDT.
2022-01-31T19:31:43.832Z,1643657503.832 [CBIT](DEBUG): Opening all GF detection circuits.
2022-01-31T19:31:43.833Z,1643657503.833 [controlThread ThreadHandler](INFO): Thread cancelled.
2022-01-31T19:31:43.852Z,1643657503.852 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2022-01-31T19:31:43.855Z,1643657503.855 [Onboard ThreadHandler](INFO): Thread cancelled.
2022-01-31T19:31:43.860Z,1643657503.860 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2022-01-31T19:31:43.903Z,1643657503.903 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2022-01-31T19:31:43.950Z,1643657503.950 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled.
2022-01-31T19:31:43.953Z,1643657503.953 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2022-01-31T19:31:44.011Z,1643657504.011 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2022-01-31T19:31:44.082Z,1643657504.082 [logger ThreadHandler](INFO): Thread cancelled.