2022-05-25T19:44:03.465Z,1653507843.465 [Supervisor](DEBUG): Initializing supervisor.
2022-05-25T19:44:03.469Z,1653507843.469 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2022-05-25T19:44:03.469Z,1653507843.469 [SyncHandler](INFO): Protected caller Thread ID is 689
2022-05-25T19:44:03.470Z,1653507843.470 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2022-05-25T19:44:03.471Z,1653507843.471 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2022-05-25T19:44:03.471Z,1653507843.471 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 690
2022-05-25T19:44:03.475Z,1653507843.475 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2022-05-25T19:44:03.493Z,1653507843.493 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2022-05-25T19:44:03.494Z,1653507843.494 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2022-05-25T19:44:03.494Z,1653507843.494 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 691
2022-05-25T19:44:03.499Z,1653507843.499 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2022-05-25T19:44:03.500Z,1653507843.500 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2022-05-25T19:44:03.500Z,1653507843.500 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 692
2022-05-25T19:44:03.502Z,1653507843.502 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2022-05-25T19:44:03.503Z,1653507843.503 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2022-05-25T19:44:03.503Z,1653507843.503 [logger ThreadHandler](INFO): Protected caller Thread ID is 693
2022-05-25T19:44:03.507Z,1653507843.507 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2022-05-25T19:44:03.507Z,1653507843.507 [Supervisor](INFO): Looking for Config files in directory: Config/
2022-05-25T19:44:03.509Z,1653507843.509 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2022-05-25T19:44:03.602Z,1653507843.602 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2022-05-25T19:44:03.603Z,1653507843.603 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2022-05-25T19:44:03.814Z,1653507843.814 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2022-05-25T19:44:03.814Z,1653507843.814 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2022-05-25T19:44:04.070Z,1653507844.070 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2022-05-25T19:44:04.070Z,1653507844.070 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2022-05-25T19:44:04.175Z,1653507844.175 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2022-05-25T19:44:04.175Z,1653507844.175 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2022-05-25T19:44:04.814Z,1653507844.814 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2022-05-25T19:44:04.814Z,1653507844.814 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2022-05-25T19:44:05.265Z,1653507845.265 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2022-05-25T19:44:05.266Z,1653507845.266 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2022-05-25T19:44:05.826Z,1653507845.826 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2022-05-25T19:44:05.827Z,1653507845.827 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2022-05-25T19:44:06.277Z,1653507846.277 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2022-05-25T19:44:06.277Z,1653507846.277 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2022-05-25T19:44:06.599Z,1653507846.599 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2022-05-25T19:44:06.600Z,1653507846.600 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2022-05-25T19:44:06.966Z,1653507846.966 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2022-05-25T19:44:06.966Z,1653507846.966 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2022-05-25T19:44:07.183Z,1653507847.183 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2022-05-25T19:44:07.183Z,1653507847.183 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2022-05-25T19:44:07.311Z,1653507847.311 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2022-05-25T19:44:07.311Z,1653507847.311 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2022-05-25T19:44:07.390Z,1653507847.390 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2022-05-25T19:44:07.467Z,1653507847.467 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2022-05-25T19:44:07.650Z,1653507847.650 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2022-05-25T19:44:07.650Z,1653507847.650 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2022-05-25T19:44:07.864Z,1653507847.864 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2022-05-25T19:44:07.866Z,1653507847.866 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/
2022-05-25T19:44:07.867Z,1653507847.867 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/secure.cfg
2022-05-25T19:44:07.948Z,1653507847.948 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Battery.cfg
2022-05-25T19:44:08.261Z,1653507848.261 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2022-05-25T19:44:08.262Z,1653507848.262 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Navigation.cfg
2022-05-25T19:44:08.462Z,1653507848.462 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Sensor.cfg
2022-05-25T19:44:08.961Z,1653507848.961 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/vehicle.cfg
2022-05-25T19:44:09.145Z,1653507849.145 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Simulator.cfg
2022-05-25T19:44:09.229Z,1653507849.229 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Servo.cfg
2022-05-25T19:44:09.335Z,1653507849.335 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Control.cfg
2022-05-25T19:44:09.438Z,1653507849.438 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Science.cfg
2022-05-25T19:44:09.595Z,1653507849.595 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/logger.cfg
2022-05-25T19:44:09.696Z,1653507849.696 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/BIT.cfg
2022-05-25T19:44:09.794Z,1653507849.794 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/root/
2022-05-25T19:44:09.795Z,1653507849.795 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2022-05-25T19:44:09.813Z,1653507849.813 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2022-05-25T19:44:09.921Z,1653507849.921 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2022-05-25T19:44:09.922Z,1653507849.922 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2022-05-25T19:44:10.046Z,1653507850.046 [BuoyancyServo] Loaded
2022-05-25T19:44:10.046Z,1653507850.046 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2022-05-25T19:44:10.066Z,1653507850.066 [ElevatorServo] Loaded
2022-05-25T19:44:10.067Z,1653507850.067 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2022-05-25T19:44:10.085Z,1653507850.085 [RudderServo] Loaded
2022-05-25T19:44:10.086Z,1653507850.086 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2022-05-25T19:44:10.102Z,1653507850.102 [ThrusterHE] Loaded
2022-05-25T19:44:10.102Z,1653507850.102 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread.
2022-05-25T19:44:10.102Z,1653507850.102 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2022-05-25T19:44:10.103Z,1653507850.103 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2022-05-25T19:44:10.242Z,1653507850.242 [SBIT](DEBUG): Construct Startup Built In Test.
2022-05-25T19:44:10.256Z,1653507850.256 [SBIT] Loaded
2022-05-25T19:44:10.257Z,1653507850.257 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2022-05-25T19:44:10.259Z,1653507850.259 [IBIT](DEBUG): Construct Initiated Built In Test.
2022-05-25T19:44:10.279Z,1653507850.279 [IBIT] Loaded
2022-05-25T19:44:10.280Z,1653507850.280 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2022-05-25T19:44:10.285Z,1653507850.285 [CBIT](DEBUG): Construct Continuous Built In Test.
2022-05-25T19:44:10.497Z,1653507850.497 [CBIT] Loaded
2022-05-25T19:44:10.497Z,1653507850.497 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2022-05-25T19:44:10.497Z,1653507850.497 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2022-05-25T19:44:10.498Z,1653507850.498 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2022-05-25T19:44:10.663Z,1653507850.663 [CTD_Seabird] Loaded
2022-05-25T19:44:10.664Z,1653507850.664 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2022-05-25T19:44:10.665Z,1653507850.665 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 406614E0
2022-05-25T19:44:10.665Z,1653507850.665 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 779
2022-05-25T19:44:10.696Z,1653507850.696 [ESPComponent] Loaded
2022-05-25T19:44:10.696Z,1653507850.696 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread.
2022-05-25T19:44:10.715Z,1653507850.715 [PAR_Licor] Loaded
2022-05-25T19:44:10.715Z,1653507850.715 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2022-05-25T19:44:10.745Z,1653507850.745 [WetLabsBB2FL] Loaded
2022-05-25T19:44:10.745Z,1653507850.745 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2022-05-25T19:44:10.746Z,1653507850.746 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 406914E0
2022-05-25T19:44:10.747Z,1653507850.747 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 780
2022-05-25T19:44:10.747Z,1653507850.747 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2022-05-25T19:44:10.748Z,1653507850.748 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2022-05-25T19:44:10.798Z,1653507850.798 [DepthRateCalculator] Loaded
2022-05-25T19:44:10.798Z,1653507850.798 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2022-05-25T19:44:10.803Z,1653507850.803 [PitchRateCalculator] Loaded
2022-05-25T19:44:10.803Z,1653507850.803 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2022-05-25T19:44:10.813Z,1653507850.813 [SpeedCalculator] Loaded
2022-05-25T19:44:10.814Z,1653507850.814 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2022-05-25T19:44:10.818Z,1653507850.818 [YawRateCalculator] Loaded
2022-05-25T19:44:10.818Z,1653507850.818 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2022-05-25T19:44:10.837Z,1653507850.837 [ElevatorOffsetCalculator] Loaded
2022-05-25T19:44:10.837Z,1653507850.837 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2022-05-25T19:44:10.853Z,1653507850.853 [ShortestDistanceToPolygonSidesCalculator] Loaded
2022-05-25T19:44:10.853Z,1653507850.853 [ComponentRegistry](DEBUG): SyncComponent "ShortestDistanceToPolygonSidesCalculator" handled in the control thread.
2022-05-25T19:44:10.854Z,1653507850.854 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2022-05-25T19:44:10.854Z,1653507850.854 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2022-05-25T19:44:10.949Z,1653507850.949 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2022-05-25T19:44:10.949Z,1653507850.949 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2022-05-25T19:44:10.976Z,1653507850.976 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2022-05-25T19:44:10.977Z,1653507850.977 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2022-05-25T19:44:11.084Z,1653507851.084 [DeadReckonUsingMultipleVelocitySources] Loaded
2022-05-25T19:44:11.085Z,1653507851.085 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2022-05-25T19:44:11.098Z,1653507851.098 [NavChart] Loaded
2022-05-25T19:44:11.098Z,1653507851.098 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2022-05-25T19:44:11.104Z,1653507851.104 [UniversalFixResidualReporter] Loaded
2022-05-25T19:44:11.104Z,1653507851.104 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2022-05-25T19:44:11.105Z,1653507851.105 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2022-05-25T19:44:11.105Z,1653507851.105 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2022-05-25T19:44:11.496Z,1653507851.496 [AHRS_M2] Loaded
2022-05-25T19:44:11.496Z,1653507851.496 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2022-05-25T19:44:11.530Z,1653507851.530 [BackseatComponent] Loaded
2022-05-25T19:44:11.530Z,1653507851.530 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread.
2022-05-25T19:44:11.531Z,1653507851.531 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 40A0D4E0
2022-05-25T19:44:11.532Z,1653507851.532 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 781
2022-05-25T19:44:11.535Z,1653507851.535 [LcmUniversalReporter] Loaded
2022-05-25T19:44:11.535Z,1653507851.535 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread.
2022-05-25T19:44:11.610Z,1653507851.610 [DataOverHttps] Loaded
2022-05-25T19:44:11.610Z,1653507851.610 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2022-05-25T19:44:11.611Z,1653507851.611 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 40A3D4E0
2022-05-25T19:44:11.611Z,1653507851.611 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 782
2022-05-25T19:44:11.631Z,1653507851.631 [Depth_Keller] Loaded
2022-05-25T19:44:11.631Z,1653507851.631 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2022-05-25T19:44:11.635Z,1653507851.635 [DropWeight] Loaded
2022-05-25T19:44:11.636Z,1653507851.636 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2022-05-25T19:44:11.672Z,1653507851.672 [DVL_micro] Loaded
2022-05-25T19:44:11.672Z,1653507851.672 [ComponentRegistry](DEBUG): SyncComponent "DVL_micro" handled in the control thread.
2022-05-25T19:44:11.729Z,1653507851.729 [NAL9602] Loaded
2022-05-25T19:44:11.729Z,1653507851.729 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2022-05-25T19:44:11.754Z,1653507851.754 [Onboard] Loaded
2022-05-25T19:44:11.755Z,1653507851.755 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2022-05-25T19:44:11.756Z,1653507851.756 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 40A6D4E0
2022-05-25T19:44:11.756Z,1653507851.756 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 783
2022-05-25T19:44:11.768Z,1653507851.768 [Power24vConverter] Loaded
2022-05-25T19:44:11.768Z,1653507851.768 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2022-05-25T19:44:11.781Z,1653507851.781 [Radio_Surface] Loaded
2022-05-25T19:44:11.781Z,1653507851.781 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2022-05-25T19:44:11.782Z,1653507851.782 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 40A9D4E0
2022-05-25T19:44:11.782Z,1653507851.782 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 784
2022-05-25T19:44:11.783Z,1653507851.783 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2022-05-25T19:44:11.784Z,1653507851.784 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2022-05-25T19:44:11.841Z,1653507851.841 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2022-05-25T19:44:11.841Z,1653507851.841 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2022-05-25T19:44:11.891Z,1653507851.891 [VerticalControl](DEBUG): Construct VerticalControl.
2022-05-25T19:44:11.943Z,1653507851.943 [VerticalControl] Loaded
2022-05-25T19:44:11.943Z,1653507851.943 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2022-05-25T19:44:11.946Z,1653507851.946 [HorizontalControl](DEBUG): Construct HorizontalControl.
2022-05-25T19:44:11.981Z,1653507851.981 [HorizontalControl] Loaded
2022-05-25T19:44:11.981Z,1653507851.981 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2022-05-25T19:44:11.983Z,1653507851.983 [SpeedControl](DEBUG): Construct SpeedControl.
2022-05-25T19:44:11.985Z,1653507851.985 [SpeedControl] Loaded
2022-05-25T19:44:11.985Z,1653507851.985 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2022-05-25T19:44:11.988Z,1653507851.988 [LoopControl](DEBUG): Construct LoopControl.
2022-05-25T19:44:11.989Z,1653507851.989 [LoopControl] Loaded
2022-05-25T19:44:11.989Z,1653507851.989 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2022-05-25T19:44:11.989Z,1653507851.989 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2022-05-25T19:44:11.990Z,1653507851.990 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2022-05-25T19:44:12.000Z,1653507852.000 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2022-05-25T19:44:12.001Z,1653507852.001 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2022-05-25T19:44:12.309Z,1653507852.309 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2022-05-25T19:44:12.315Z,1653507852.315 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2022-05-25T19:44:12.317Z,1653507852.317 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2022-05-25T19:44:12.328Z,1653507852.328 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2022-05-25T19:44:12.329Z,1653507852.329 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40BA74E0
2022-05-25T19:44:12.329Z,1653507852.329 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 785
2022-05-25T19:44:12.334Z,1653507852.334 [Supervisor](INFO): Main Thread ID is 688
2022-05-25T19:44:12.334Z,1653507852.334 [Supervisor](DEBUG): Running supervisor.
2022-05-25T19:44:12.334Z,1653507852.334 [CommandExec ThreadHandler](INFO): Handler Thread ID is 786
2022-05-25T19:44:12.335Z,1653507852.335 [CommandExec](INFO): Initializing the command executive.
2022-05-25T19:44:12.336Z,1653507852.336 [CommandLine ThreadHandler](INFO): Handler Thread ID is 787
2022-05-25T19:44:12.339Z,1653507852.339 [controlThread ThreadHandler](INFO): Handler Thread ID is 788
2022-05-25T19:44:12.339Z,1653507852.339 [controlThread](DEBUG): Initializing ControlThread
2022-05-25T19:44:12.341Z,1653507852.341 [SBIT](INFO): Initialize SBIT Component.
2022-05-25T19:44:12.341Z,1653507852.341 [SBIT](IMPORTANT): git: 2022-05-16
2022-05-25T19:44:12.341Z,1653507852.341 [SBIT](INFO): git hash: 22dd8ec1d68d2d3458ffb0a0481759ba9019d0f5
2022-05-25T19:44:12.342Z,1653507852.342 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2022-05-25T19:44:12.343Z,1653507852.343 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018
Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021
2022-05-25T19:44:12.344Z,1653507852.344 [SBIT](INFO): Beginning SBIT in 59.000000 seconds.
2022-05-25T19:44:12.344Z,1653507852.344 [IBIT](INFO): Initialize IBIT Component.
2022-05-25T19:44:12.345Z,1653507852.345 [CBIT](DEBUG): Initialize CBIT Component.
2022-05-25T19:44:12.346Z,1653507852.346 [logger ThreadHandler](INFO): Handler Thread ID is 789
2022-05-25T19:44:12.360Z,1653507852.360 [CBIT](DEBUG): Initialized mux pins.
2022-05-25T19:44:12.360Z,1653507852.360 [CBIT](DEBUG): Initializing the watchdog timer.
2022-05-25T19:44:12.372Z,1653507852.372 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 790
2022-05-25T19:44:12.373Z,1653507852.373 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2022-05-25T19:44:12.377Z,1653507852.377 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 793
2022-05-25T19:44:12.380Z,1653507852.380 [WetLabsBB2FL](INFO): Powering up
2022-05-25T19:44:12.382Z,1653507852.382 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 797
2022-05-25T19:44:12.384Z,1653507852.384 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2022-05-25T19:44:12.384Z,1653507852.384 [CBIT](DEBUG): Initializing heartbeat.
2022-05-25T19:44:12.398Z,1653507852.398 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 798
2022-05-25T19:44:12.399Z,1653507852.399 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2022-05-25T19:44:12.412Z,1653507852.412 [Onboard ThreadHandler](INFO): Handler Thread ID is 799
2022-05-25T19:44:12.429Z,1653507852.429 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 800
2022-05-25T19:44:12.452Z,1653507852.452 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 802
2022-05-25T19:44:12.455Z,1653507852.455 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2022-05-25T19:44:12.455Z,1653507852.455 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2022-05-25T19:44:12.455Z,1653507852.455 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2022-05-25T19:44:12.455Z,1653507852.455 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2022-05-25T19:44:12.456Z,1653507852.456 [CBIT](DEBUG): Deactivating GF circuits.
2022-05-25T19:44:12.456Z,1653507852.456 [CBIT](DEBUG): Deactivating emergency mode.
2022-05-25T19:44:12.455Z,1653507852.455 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2022-05-25T19:44:12.456Z,1653507852.456 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2022-05-25T19:44:12.456Z,1653507852.456 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2022-05-25T19:44:12.457Z,1653507852.457 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2022-05-25T19:44:12.457Z,1653507852.457 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA69M.000
2022-05-25T19:44:12.457Z,1653507852.457 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA69M.000
2022-05-25T19:44:12.492Z,1653507852.492 [CBIT](DEBUG): Backplane powered.
2022-05-25T19:44:12.496Z,1653507852.496 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2022-05-25T19:44:12.497Z,1653507852.497 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2022-05-25T19:44:12.497Z,1653507852.497 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2022-05-25T19:44:12.497Z,1653507852.497 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2022-05-25T19:44:12.498Z,1653507852.498 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2022-05-25T19:44:12.498Z,1653507852.498 [ShortestDistanceToPolygonSidesCalculator](DEBUG): Initializing.
2022-05-25T19:44:12.499Z,1653507852.499 [NavChart](DEBUG): Initialize NavChart Navigation.
2022-05-25T19:44:12.500Z,1653507852.500 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2022-05-25T19:44:12.506Z,1653507852.506 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2022-05-25T19:44:12.512Z,1653507852.512 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2022-05-25T19:44:12.512Z,1653507852.512 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2022-05-25T19:44:12.513Z,1653507852.513 [LoopControl](DEBUG): Initialize LoopControlComponent.
2022-05-25T19:44:12.514Z,1653507852.514 [MissionManager](INFO): Loading Mission from file: Missions/Startup.xml
2022-05-25T19:44:12.556Z,1653507852.556 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2022-05-25T19:44:12.588Z,1653507852.588 [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-05-25T19:44:12.589Z,1653507852.589 [MissionManager](INFO): Loading Mission from file: Missions/Default.xml
2022-05-25T19:44:12.665Z,1653507852.665 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2022-05-25T19:44:12.666Z,1653507852.666 [Default:A.Wait](DEBUG): Construct Wait.
2022-05-25T19:44:12.692Z,1653507852.692 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2022-05-25T19:44:12.711Z,1653507852.711 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2022-05-25T19:44:12.726Z,1653507852.726 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2022-05-25T19:44:12.748Z,1653507852.748 [Default:E.Execute](DEBUG): Construct Execute.
2022-05-25T19:44:12.752Z,1653507852.752 [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-05-25T19:44:12.772Z,1653507852.772 [controlThread](DEBUG): Component order: CycleStarter,ESPComponent,PAR_Licor,AHRS_M2,Depth_Keller,DropWeight,DVL_micro,NAL9602,Power24vConverter,PAR_Licor,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,ShortestDistanceToPolygonSidesCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter,
2022-05-25T19:44:12.802Z,1653507852.802 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2022-05-25T19:44:12.836Z,1653507852.836 [Radio_Surface](INFO): Powering up
2022-05-25T19:44:12.841Z,1653507852.841 [Depth_Keller](ERROR): Pressure reading out of range: 1895.834351 decibar
2022-05-25T19:44:12.850Z,1653507852.850 [Power24vConverter](INFO): Powering up.
2022-05-25T19:44:12.892Z,1653507852.892 [DepthRateCalculator](ERROR): Depth measurement is not active
2022-05-25T19:44:12.919Z,1653507852.919 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2022-05-25T19:44:12.928Z,1653507852.928 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2022-05-25T19:44:12.929Z,1653507852.929 [ElevatorServo](DEBUG): Initializing EZServoServo.
2022-05-25T19:44:12.936Z,1653507852.936 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2022-05-25T19:44:12.937Z,1653507852.937 [RudderServo](DEBUG): Initializing EZServoServo.
2022-05-25T19:44:12.944Z,1653507852.944 [RudderServo](DEBUG): Initializing RudderServo.
2022-05-25T19:44:12.945Z,1653507852.945 [ThrusterHE](DEBUG): Initializing EZServoServo.
2022-05-25T19:44:12.952Z,1653507852.952 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2022-05-25T19:44:13.230Z,1653507853.230 [DropWeight](CRITICAL): DROP WEIGHT MISSING.

2022-05-25T19:44:13.230Z,1653507853.230 [DropWeight] Hardware Fault, FailCount= 1
2022-05-25T19:44:13.230Z,1653507853.230 [DropWeight](ERROR): Hardware Fault
2022-05-25T19:44:13.258Z,1653507853.258 [CommandExec](FAULT): Scheduling is paused
2022-05-25T19:44:13.258Z,1653507853.258 [CBIT](INFO): Critical error at 20220525T194413
2022-05-25T19:44:13.259Z,1653507853.259 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2022-05-25T19:44:13.270Z,1653507853.270 [CBIT](ERROR): Hardware Fault in component: DropWeight
2022-05-25T19:44:13.272Z,1653507853.272 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2022-05-25T19:44:13.657Z,1653507853.657 [CBIT](INFO): Critical error at 20220525T194413
2022-05-25T19:44:14.488Z,1653507854.488 [WetLabsBB2FL](INFO): Powering down
2022-05-25T19:44:16.340Z,1653507856.340 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-05-25T19:44:16.800Z,1653507856.800 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-05-25T19:44:17.272Z,1653507857.272 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-05-25T19:44:17.804Z,1653507857.804 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-05-25T19:44:18.252Z,1653507858.252 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-05-25T19:44:18.664Z,1653507858.664 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-05-25T19:44:19.120Z,1653507859.120 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-05-25T19:44:19.741Z,1653507859.741 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-05-25T19:44:20.172Z,1653507860.172 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-05-25T19:44:20.632Z,1653507860.632 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-05-25T19:44:21.032Z,1653507861.032 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-05-25T19:44:21.460Z,1653507861.460 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-05-25T19:44:21.904Z,1653507861.904 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-05-25T19:44:22.372Z,1653507862.372 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-05-25T19:44:22.473Z,1653507862.473 [CBIT](CRITICAL): Environmental Failure. Press:14.727183 PSI. Humidity:38%. Temp:24 C. ABORTING MISSION
2022-05-25T19:44:22.824Z,1653507862.824 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-05-25T19:44:22.882Z,1653507862.882 [CBIT](INFO): Critical error at 20220525T194422
2022-05-25T19:44:23.240Z,1653507863.240 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-05-25T19:44:23.668Z,1653507863.668 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-05-25T19:44:24.112Z,1653507864.112 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-05-25T19:44:24.540Z,1653507864.540 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-05-25T19:44:24.968Z,1653507864.968 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-05-25T19:44:25.388Z,1653507865.388 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-05-25T19:44:25.812Z,1653507865.812 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-05-25T19:44:25.812Z,1653507865.812 [AHRS_M2](FAULT): Failed to initialize within timeout.
2022-05-25T19:44:25.812Z,1653507865.812 [AHRS_M2] Communications Fault, FailCount= 1
2022-05-25T19:44:25.812Z,1653507865.812 [AHRS_M2](ERROR): Communications Fault
2022-05-25T19:44:25.864Z,1653507865.864 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2022-05-25T19:44:25.920Z,1653507865.920 [AHRS_M2](INFO): Powering down
2022-05-25T19:44:25.954Z,1653507865.954 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004770
2022-05-25T19:44:26.720Z,1653507866.720 [CBIT](INFO): Clearing failed state for component AHRS_M2
2022-05-25T19:44:26.720Z,1653507866.720 [AHRS_M2] No Fault, FailCount= 1
2022-05-25T19:44:27.084Z,1653507867.084 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2022-05-25T19:44:30.632Z,1653507870.632 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-05-25T19:44:31.064Z,1653507871.064 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-05-25T19:44:31.480Z,1653507871.480 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-05-25T19:44:31.896Z,1653507871.896 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-05-25T19:44:32.316Z,1653507872.316 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-05-25T19:44:32.732Z,1653507872.732 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-05-25T19:44:33.144Z,1653507873.144 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-05-25T19:44:33.576Z,1653507873.576 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-05-25T19:44:33.992Z,1653507873.992 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-05-25T19:44:34.404Z,1653507874.404 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-05-25T19:44:34.824Z,1653507874.824 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-05-25T19:44:35.236Z,1653507875.236 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-05-25T19:44:35.644Z,1653507875.644 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-05-25T19:44:36.092Z,1653507876.092 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-05-25T19:44:36.508Z,1653507876.508 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-05-25T19:44:36.920Z,1653507876.920 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-05-25T19:44:37.340Z,1653507877.340 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-05-25T19:44:37.772Z,1653507877.772 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-05-25T19:44:38.188Z,1653507878.188 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-05-25T19:44:38.612Z,1653507878.612 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-05-25T19:44:39.020Z,1653507879.020 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-05-25T19:44:39.444Z,1653507879.444 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-05-25T19:44:39.856Z,1653507879.856 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-05-25T19:44:40.276Z,1653507880.276 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-05-25T19:44:40.276Z,1653507880.276 [AHRS_M2](FAULT): Failed to initialize within timeout.
2022-05-25T19:44:40.276Z,1653507880.276 [AHRS_M2] Communications Fault, FailCount= 2
2022-05-25T19:44:40.276Z,1653507880.276 [AHRS_M2](ERROR): Communications Fault
2022-05-25T19:44:40.345Z,1653507880.345 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2022-05-25T19:44:40.365Z,1653507880.365 [AHRS_M2](INFO): Powering down
2022-05-25T19:44:41.220Z,1653507881.220 [CBIT](INFO): Clearing failed state for component AHRS_M2
2022-05-25T19:44:41.220Z,1653507881.220 [AHRS_M2] No Fault, FailCount= 2
2022-05-25T19:44:41.564Z,1653507881.564 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2022-05-25T19:44:41.974Z,1653507881.974 [NAL9602](INFO): Powering up NAL9602
2022-05-25T19:44:43.461Z,1653507883.461 [CommandExec](IMPORTANT): got command quit
2022-05-25T19:44:44.464Z,1653507884.464 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread.
2022-05-25T19:44:44.464Z,1653507884.464 [CommandExec](INFO): Uninitializing the command executive.
2022-05-25T19:44:44.464Z,1653507884.464 [CommandExec](INFO): Uninitializing the command scheduler.
2022-05-25T19:44:44.465Z,1653507884.465 [CommandExec ThreadHandler](INFO): Thread cancelled.
2022-05-25T19:44:44.552Z,1653507884.552 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2022-05-25T19:44:44.552Z,1653507884.552 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2022-05-25T19:44:44.552Z,1653507884.552 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2022-05-25T19:44:44.553Z,1653507884.553 [NavChartDb](INFO): Join timeout helper Thread ID is 811
2022-05-25T19:44:44.941Z,1653507884.941 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2022-05-25T19:44:44.941Z,1653507884.941 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2022-05-25T19:44:44.948Z,1653507884.948 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2022-05-25T19:44:44.948Z,1653507884.948 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2022-05-25T19:44:44.948Z,1653507884.948 [Radio_Surface](INFO): Join timeout helper Thread ID is 812
2022-05-25T19:44:45.112Z,1653507885.112 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-05-25T19:44:45.172Z,1653507885.172 [Radio_Surface](INFO): Powering down
2022-05-25T19:44:45.173Z,1653507885.173 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2022-05-25T19:44:45.173Z,1653507885.173 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2022-05-25T19:44:45.180Z,1653507885.180 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2022-05-25T19:44:45.180Z,1653507885.180 [Onboard ThreadHandler](INFO): Thread cancelled.
2022-05-25T19:44:45.180Z,1653507885.180 [Onboard](INFO): Join timeout helper Thread ID is 813
2022-05-25T19:44:45.572Z,1653507885.572 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-05-25T19:44:45.996Z,1653507885.996 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-05-25T19:44:46.408Z,1653507886.408 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-05-25T19:44:46.828Z,1653507886.828 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-05-25T19:44:47.248Z,1653507887.248 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-05-25T19:44:47.444Z,1653507887.444 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2022-05-25T19:44:47.444Z,1653507887.444 [Onboard ThreadHandler](INFO): Thread cancelled.
2022-05-25T19:44:47.460Z,1653507887.460 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2022-05-25T19:44:47.460Z,1653507887.460 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2022-05-25T19:44:47.461Z,1653507887.461 [DataOverHttps](INFO): Join timeout helper Thread ID is 814
2022-05-25T19:44:47.664Z,1653507887.664 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-05-25T19:44:48.084Z,1653507888.084 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-05-25T19:44:48.520Z,1653507888.520 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-05-25T19:44:48.673Z,1653507888.673 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2022-05-25T19:44:48.677Z,1653507888.677 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2022-05-25T19:44:48.688Z,1653507888.688 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler
2022-05-25T19:44:48.688Z,1653507888.688 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2022-05-25T19:44:48.688Z,1653507888.688 [BackseatComponent](INFO): Join timeout helper Thread ID is 816
2022-05-25T19:44:48.756Z,1653507888.756 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread.
2022-05-25T19:44:48.756Z,1653507888.756 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2022-05-25T19:44:48.773Z,1653507888.773 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2022-05-25T19:44:48.773Z,1653507888.773 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2022-05-25T19:44:48.773Z,1653507888.773 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 817
2022-05-25T19:44:48.932Z,1653507888.932 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-05-25T19:44:49.172Z,1653507889.172 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2022-05-25T19:44:49.172Z,1653507889.172 [WetLabsBB2FL](INFO): Powering down
2022-05-25T19:44:49.173Z,1653507889.173 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2022-05-25T19:44:49.181Z,1653507889.181 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2022-05-25T19:44:49.181Z,1653507889.181 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2022-05-25T19:44:49.181Z,1653507889.181 [CTD_Seabird](INFO): Join timeout helper Thread ID is 818
2022-05-25T19:44:49.336Z,1653507889.336 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-05-25T19:44:49.528Z,1653507889.528 [CTD_Seabird](INFO): Powering down
2022-05-25T19:44:49.540Z,1653507889.540 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2022-05-25T19:44:49.540Z,1653507889.540 [CTD_Seabird](INFO): Powering down
2022-05-25T19:44:49.552Z,1653507889.552 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2022-05-25T19:44:49.565Z,1653507889.565 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2022-05-25T19:44:49.565Z,1653507889.565 [logger ThreadHandler](INFO): Thread cancelled.
2022-05-25T19:44:49.565Z,1653507889.565 [logger](INFO): Join timeout helper Thread ID is 819
2022-05-25T19:44:49.566Z,1653507889.566 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2022-05-25T19:44:49.566Z,1653507889.566 [logger ThreadHandler](INFO): Thread cancelled.
2022-05-25T19:44:49.567Z,1653507889.567 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2022-05-25T19:44:49.567Z,1653507889.567 [CommandLine ThreadHandler](INFO): Thread cancelled.
2022-05-25T19:44:49.568Z,1653507889.568 [CommandLine](INFO): Join timeout helper Thread ID is 820
2022-05-25T19:44:49.664Z,1653507889.664 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2022-05-25T19:44:49.664Z,1653507889.664 [CommandLine ThreadHandler](INFO): Thread cancelled.
2022-05-25T19:44:49.668Z,1653507889.668 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler
2022-05-25T19:44:49.669Z,1653507889.669 [CommandExec ThreadHandler](INFO): Thread cancelled.
2022-05-25T19:44:49.669Z,1653507889.669 [CommandExec](INFO): Join timeout helper Thread ID is 821
2022-05-25T19:44:49.670Z,1653507889.670 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2022-05-25T19:44:49.670Z,1653507889.670 [controlThread ThreadHandler](INFO): Thread cancelled.
2022-05-25T19:44:49.671Z,1653507889.671 [controlThread](INFO): Join timeout helper Thread ID is 822
2022-05-25T19:44:49.748Z,1653507889.748 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2022-05-25T19:44:49.772Z,1653507889.772 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2022-05-25T19:44:49.772Z,1653507889.772 [controlThread](DEBUG): Uninitializing ControlThread
2022-05-25T19:44:49.774Z,1653507889.774 [AHRS_M2](INFO): Powering down
2022-05-25T19:44:49.916Z,1653507889.916 [DVL_micro](INFO): Powering down
2022-05-25T19:44:49.917Z,1653507889.917 [NAL9602](INFO): Powering down
2022-05-25T19:44:49.918Z,1653507889.918 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2022-05-25T19:44:49.919Z,1653507889.919 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2022-05-25T19:44:49.920Z,1653507889.920 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2022-05-25T19:44:49.921Z,1653507889.921 [MissionManager](INFO): Uninitializing Mission Default
2022-05-25T19:44:49.923Z,1653507889.923 [MissionManager](INFO): Uninitializing Mission Startup
2022-05-25T19:44:49.924Z,1653507889.924 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2022-05-25T19:44:49.925Z,1653507889.925 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2022-05-25T19:44:49.925Z,1653507889.925 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2022-05-25T19:44:49.925Z,1653507889.925 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2022-05-25T19:44:49.926Z,1653507889.926 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2022-05-25T19:44:49.926Z,1653507889.926 [BuoyancyServo](INFO): Powering down
2022-05-25T19:44:49.940Z,1653507889.940 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2022-05-25T19:44:49.940Z,1653507889.940 [ElevatorServo](INFO): Powering down
2022-05-25T19:44:49.941Z,1653507889.941 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2022-05-25T19:44:49.941Z,1653507889.941 [RudderServo](INFO): Powering down
2022-05-25T19:44:49.942Z,1653507889.942 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2022-05-25T19:44:49.942Z,1653507889.942 [ThrusterHE](INFO): Powering down
2022-05-25T19:44:49.943Z,1653507889.943 [SBIT](DEBUG): Uninitialize SBIT Component.
2022-05-25T19:44:49.943Z,1653507889.943 [IBIT](DEBUG): Uninitialize IBIT Component.
2022-05-25T19:44:49.943Z,1653507889.943 [CBIT](DEBUG): Uninitialize CBIT Component.
2022-05-25T19:44:49.944Z,1653507889.944 [CBIT](DEBUG): Powering off loads.
2022-05-25T19:44:49.956Z,1653507889.956 [CBIT](DEBUG): Disabling WDT.
2022-05-25T19:44:49.968Z,1653507889.968 [CBIT](DEBUG): Opening all GF detection circuits.
2022-05-25T19:44:49.969Z,1653507889.969 [controlThread ThreadHandler](INFO): Thread cancelled.
2022-05-25T19:44:50.136Z,1653507890.136 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2022-05-25T19:44:50.142Z,1653507890.142 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2022-05-25T19:44:50.170Z,1653507890.170 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2022-05-25T19:44:50.172Z,1653507890.172 [Onboard ThreadHandler](INFO): Thread cancelled.
2022-05-25T19:44:50.179Z,1653507890.179 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2022-05-25T19:44:50.185Z,1653507890.185 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2022-05-25T19:44:50.232Z,1653507890.232 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2022-05-25T19:44:50.294Z,1653507890.294 [logger ThreadHandler](INFO): Thread cancelled.