2021-10-22T19:19:49.216Z,1634930389.216 [Supervisor](DEBUG): Initializing supervisor.
2021-10-22T19:19:49.221Z,1634930389.221 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2021-10-22T19:19:49.222Z,1634930389.222 [SyncHandler](INFO): Protected caller Thread ID is 2539
2021-10-22T19:19:49.222Z,1634930389.222 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2021-10-22T19:19:49.223Z,1634930389.223 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2021-10-22T19:19:49.224Z,1634930389.224 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 2540
2021-10-22T19:19:49.228Z,1634930389.228 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2021-10-22T19:19:49.247Z,1634930389.247 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2021-10-22T19:19:49.248Z,1634930389.248 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2021-10-22T19:19:49.248Z,1634930389.248 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 2541
2021-10-22T19:19:49.252Z,1634930389.252 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2021-10-22T19:19:49.253Z,1634930389.253 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2021-10-22T19:19:49.254Z,1634930389.254 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 2542
2021-10-22T19:19:49.256Z,1634930389.256 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2021-10-22T19:19:49.257Z,1634930389.257 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2021-10-22T19:19:49.257Z,1634930389.257 [logger ThreadHandler](INFO): Protected caller Thread ID is 2543
2021-10-22T19:19:49.261Z,1634930389.261 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2021-10-22T19:19:49.261Z,1634930389.261 [Supervisor](INFO): Looking for Config files in directory: Config/
2021-10-22T19:19:49.263Z,1634930389.263 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2021-10-22T19:19:49.676Z,1634930389.676 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2021-10-22T19:19:49.676Z,1634930389.676 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2021-10-22T19:19:49.817Z,1634930389.817 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2021-10-22T19:19:49.818Z,1634930389.818 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2021-10-22T19:19:49.896Z,1634930389.896 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2021-10-22T19:19:50.108Z,1634930390.108 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2021-10-22T19:19:50.109Z,1634930390.109 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2021-10-22T19:19:50.185Z,1634930390.185 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2021-10-22T19:19:50.278Z,1634930390.278 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2021-10-22T19:19:50.278Z,1634930390.278 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2021-10-22T19:19:50.614Z,1634930390.614 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2021-10-22T19:19:50.615Z,1634930390.615 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2021-10-22T19:19:50.736Z,1634930390.736 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2021-10-22T19:19:50.736Z,1634930390.736 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2021-10-22T19:19:51.243Z,1634930391.243 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2021-10-22T19:19:51.244Z,1634930391.244 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2021-10-22T19:19:51.428Z,1634930391.428 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2021-10-22T19:19:51.429Z,1634930391.429 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2021-10-22T19:19:51.789Z,1634930391.789 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2021-10-22T19:19:51.790Z,1634930391.790 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2021-10-22T19:19:52.022Z,1634930392.022 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2021-10-22T19:19:52.022Z,1634930392.022 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2021-10-22T19:19:52.128Z,1634930392.128 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2021-10-22T19:19:52.129Z,1634930392.129 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2021-10-22T19:19:52.854Z,1634930392.854 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2021-10-22T19:19:52.855Z,1634930392.855 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2021-10-22T19:19:53.186Z,1634930393.186 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2021-10-22T19:19:53.187Z,1634930393.187 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2021-10-22T19:19:53.390Z,1634930393.390 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2021-10-22T19:19:53.392Z,1634930393.392 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-triton/
2021-10-22T19:19:53.392Z,1634930393.392 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/vehicle.cfg
2021-10-22T19:19:53.578Z,1634930393.578 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/secure.cfg
2021-10-22T19:19:53.658Z,1634930393.658 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Science.cfg
2021-10-22T19:19:53.790Z,1634930393.790 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Simulator.cfg
2021-10-22T19:19:53.881Z,1634930393.881 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Battery.cfg
2021-10-22T19:19:54.393Z,1634930394.393 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2021-10-22T19:19:54.394Z,1634930394.394 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/logger.cfg
2021-10-22T19:19:54.494Z,1634930394.494 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Servo.cfg
2021-10-22T19:19:54.603Z,1634930394.603 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Navigation.cfg
2021-10-22T19:19:54.694Z,1634930394.694 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Sensor.cfg
2021-10-22T19:19:54.833Z,1634930394.833 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Control.cfg
2021-10-22T19:19:54.928Z,1634930394.928 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/BIT.cfg
2021-10-22T19:19:55.020Z,1634930395.020 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-triton/root/
2021-10-22T19:19:55.020Z,1634930395.020 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2021-10-22T19:19:55.035Z,1634930395.035 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2021-10-22T19:19:55.051Z,1634930395.051 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2021-10-22T19:19:55.052Z,1634930395.052 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2021-10-22T19:19:55.170Z,1634930395.170 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2021-10-22T19:19:55.171Z,1634930395.171 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2021-10-22T19:19:55.241Z,1634930395.241 [VerticalControl](DEBUG): Construct VerticalControl.
2021-10-22T19:19:55.302Z,1634930395.302 [VerticalControl] Loaded
2021-10-22T19:19:55.302Z,1634930395.302 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2021-10-22T19:19:55.305Z,1634930395.305 [HorizontalControl](DEBUG): Construct HorizontalControl.
2021-10-22T19:19:55.343Z,1634930395.343 [HorizontalControl] Loaded
2021-10-22T19:19:55.344Z,1634930395.344 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2021-10-22T19:19:55.346Z,1634930395.346 [SpeedControl](DEBUG): Construct SpeedControl.
2021-10-22T19:19:55.349Z,1634930395.349 [SpeedControl] Loaded
2021-10-22T19:19:55.349Z,1634930395.349 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2021-10-22T19:19:55.352Z,1634930395.352 [LoopControl](DEBUG): Construct LoopControl.
2021-10-22T19:19:55.352Z,1634930395.352 [LoopControl] Loaded
2021-10-22T19:19:55.353Z,1634930395.353 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2021-10-22T19:19:55.353Z,1634930395.353 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2021-10-22T19:19:55.354Z,1634930395.354 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2021-10-22T19:19:55.509Z,1634930395.509 [BuoyancyServo] Loaded
2021-10-22T19:19:55.509Z,1634930395.509 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2021-10-22T19:19:55.528Z,1634930395.528 [ElevatorServo] Loaded
2021-10-22T19:19:55.529Z,1634930395.529 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2021-10-22T19:19:55.547Z,1634930395.547 [MassServo] Loaded
2021-10-22T19:19:55.547Z,1634930395.547 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2021-10-22T19:19:55.564Z,1634930395.564 [RudderServo] Loaded
2021-10-22T19:19:55.565Z,1634930395.565 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2021-10-22T19:19:55.565Z,1634930395.565 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2021-10-22T19:19:55.566Z,1634930395.566 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2021-10-22T19:19:55.625Z,1634930395.625 [DepthRateCalculator] Loaded
2021-10-22T19:19:55.626Z,1634930395.626 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2021-10-22T19:19:55.630Z,1634930395.630 [PitchRateCalculator] Loaded
2021-10-22T19:19:55.631Z,1634930395.631 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2021-10-22T19:19:55.641Z,1634930395.641 [SpeedCalculator] Loaded
2021-10-22T19:19:55.641Z,1634930395.641 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2021-10-22T19:19:55.654Z,1634930395.654 [TempGradientCalculator] Loaded
2021-10-22T19:19:55.655Z,1634930395.655 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2021-10-22T19:19:55.659Z,1634930395.659 [YawRateCalculator] Loaded
2021-10-22T19:19:55.659Z,1634930395.659 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2021-10-22T19:19:55.676Z,1634930395.676 [ElevatorOffsetCalculator] Loaded
2021-10-22T19:19:55.677Z,1634930395.677 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2021-10-22T19:19:55.677Z,1634930395.677 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2021-10-22T19:19:55.678Z,1634930395.678 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2021-10-22T19:19:55.775Z,1634930395.775 [DeadReckonUsingMultipleVelocitySources] Loaded
2021-10-22T19:19:55.776Z,1634930395.776 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2021-10-22T19:19:55.789Z,1634930395.789 [NavChart] Loaded
2021-10-22T19:19:55.789Z,1634930395.789 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2021-10-22T19:19:55.795Z,1634930395.795 [UniversalFixResidualReporter] Loaded
2021-10-22T19:19:55.795Z,1634930395.795 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2021-10-22T19:19:55.795Z,1634930395.795 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2021-10-22T19:19:55.796Z,1634930395.796 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2021-10-22T19:19:56.298Z,1634930396.298 [AHRS_M2] Loaded
2021-10-22T19:19:56.298Z,1634930396.298 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2021-10-22T19:19:56.328Z,1634930396.328 [BackseatComponent] Loaded
2021-10-22T19:19:56.328Z,1634930396.328 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread.
2021-10-22T19:19:56.330Z,1634930396.330 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 4089D4E0
2021-10-22T19:19:56.330Z,1634930396.330 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 2626
2021-10-22T19:19:56.333Z,1634930396.333 [LcmUniversalReporter] Loaded
2021-10-22T19:19:56.333Z,1634930396.333 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread.
2021-10-22T19:19:57.127Z,1634930397.127 [BPC1] Loaded
2021-10-22T19:19:57.127Z,1634930397.127 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2021-10-22T19:19:57.200Z,1634930397.200 [DataOverHttps] Loaded
2021-10-22T19:19:57.200Z,1634930397.200 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2021-10-22T19:19:57.201Z,1634930397.201 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 408CD4E0
2021-10-22T19:19:57.202Z,1634930397.202 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 2627
2021-10-22T19:19:57.221Z,1634930397.221 [Depth_Keller] Loaded
2021-10-22T19:19:57.222Z,1634930397.222 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2021-10-22T19:19:57.226Z,1634930397.226 [DropWeight] Loaded
2021-10-22T19:19:57.226Z,1634930397.226 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2021-10-22T19:19:57.285Z,1634930397.285 [NAL9602] Loaded
2021-10-22T19:19:57.286Z,1634930397.286 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2021-10-22T19:19:57.315Z,1634930397.315 [Onboard] Loaded
2021-10-22T19:19:57.315Z,1634930397.315 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2021-10-22T19:19:57.316Z,1634930397.316 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 408FD4E0
2021-10-22T19:19:57.316Z,1634930397.316 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 2628
2021-10-22T19:19:57.329Z,1634930397.329 [Power24vConverter] Loaded
2021-10-22T19:19:57.329Z,1634930397.329 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2021-10-22T19:19:57.342Z,1634930397.342 [Radio_Surface] Loaded
2021-10-22T19:19:57.342Z,1634930397.342 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2021-10-22T19:19:57.343Z,1634930397.343 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 4092D4E0
2021-10-22T19:19:57.344Z,1634930397.344 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 2629
2021-10-22T19:19:57.344Z,1634930397.344 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2021-10-22T19:19:57.345Z,1634930397.345 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2021-10-22T19:19:57.428Z,1634930397.428 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2021-10-22T19:19:57.429Z,1634930397.429 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2021-10-22T19:19:57.561Z,1634930397.561 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2021-10-22T19:19:57.562Z,1634930397.562 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2021-10-22T19:19:57.603Z,1634930397.603 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2021-10-22T19:19:57.604Z,1634930397.604 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2021-10-22T19:19:57.822Z,1634930397.822 [CTD_Seabird] Loaded
2021-10-22T19:19:57.823Z,1634930397.823 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2021-10-22T19:19:57.824Z,1634930397.824 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40A4D4E0
2021-10-22T19:19:57.824Z,1634930397.824 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 2630
2021-10-22T19:19:57.856Z,1634930397.856 [ESPComponent] Loaded
2021-10-22T19:19:57.856Z,1634930397.856 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread.
2021-10-22T19:19:57.875Z,1634930397.875 [PAR_Licor] Loaded
2021-10-22T19:19:57.876Z,1634930397.876 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2021-10-22T19:19:57.907Z,1634930397.907 [WetLabsBB2FL] Loaded
2021-10-22T19:19:57.907Z,1634930397.907 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2021-10-22T19:19:57.908Z,1634930397.908 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40A7D4E0
2021-10-22T19:19:57.909Z,1634930397.909 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 2631
2021-10-22T19:19:57.909Z,1634930397.909 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2021-10-22T19:19:57.910Z,1634930397.910 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2021-10-22T19:19:58.284Z,1634930398.284 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2021-10-22T19:19:58.284Z,1634930398.284 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2021-10-22T19:19:58.458Z,1634930398.458 [SBIT](DEBUG): Construct Startup Built In Test.
2021-10-22T19:19:58.468Z,1634930398.468 [SBIT] Loaded
2021-10-22T19:19:58.468Z,1634930398.468 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2021-10-22T19:19:58.471Z,1634930398.471 [IBIT](DEBUG): Construct Initiated Built In Test.
2021-10-22T19:19:58.484Z,1634930398.484 [IBIT] Loaded
2021-10-22T19:19:58.484Z,1634930398.484 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2021-10-22T19:19:58.490Z,1634930398.490 [CBIT](DEBUG): Construct Continuous Built In Test.
2021-10-22T19:19:58.590Z,1634930398.590 [CBIT] Loaded
2021-10-22T19:19:58.590Z,1634930398.590 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2021-10-22T19:19:58.590Z,1634930398.590 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2021-10-22T19:19:58.596Z,1634930398.596 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2021-10-22T19:19:58.599Z,1634930398.599 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2021-10-22T19:19:58.610Z,1634930398.610 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2021-10-22T19:19:58.611Z,1634930398.611 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40B644E0
2021-10-22T19:19:58.612Z,1634930398.612 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 2632
2021-10-22T19:19:58.617Z,1634930398.617 [Supervisor](INFO): Main Thread ID is 2538
2021-10-22T19:19:58.617Z,1634930398.617 [Supervisor](DEBUG): Running supervisor.
2021-10-22T19:19:58.617Z,1634930398.617 [CommandExec ThreadHandler](INFO): Handler Thread ID is 2633
2021-10-22T19:19:58.618Z,1634930398.618 [CommandExec](INFO): Initializing the command executive.
2021-10-22T19:19:58.620Z,1634930398.620 [CommandLine ThreadHandler](INFO): Handler Thread ID is 2634
2021-10-22T19:19:58.622Z,1634930398.622 [controlThread ThreadHandler](INFO): Handler Thread ID is 2635
2021-10-22T19:19:58.623Z,1634930398.623 [controlThread](DEBUG): Initializing ControlThread
2021-10-22T19:19:58.624Z,1634930398.624 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2021-10-22T19:19:58.626Z,1634930398.626 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2021-10-22T19:19:58.626Z,1634930398.626 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2021-10-22T19:19:58.627Z,1634930398.627 [LoopControl](DEBUG): Initialize LoopControlComponent.
2021-10-22T19:19:58.628Z,1634930398.628 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2021-10-22T19:19:58.628Z,1634930398.628 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2021-10-22T19:19:58.629Z,1634930398.629 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2021-10-22T19:19:58.629Z,1634930398.629 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2021-10-22T19:19:58.629Z,1634930398.629 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2021-10-22T19:19:58.630Z,1634930398.630 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2021-10-22T19:19:58.631Z,1634930398.631 [NavChart](DEBUG): Initialize NavChart Navigation.
2021-10-22T19:19:58.631Z,1634930398.631 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2021-10-22T19:19:58.639Z,1634930398.639 [SBIT](INFO): Initialize SBIT Component.
2021-10-22T19:19:58.640Z,1634930398.640 [SBIT](IMPORTANT): git: 2021-10-07-17-gd0beb73bf
2021-10-22T19:19:58.640Z,1634930398.640 [SBIT](INFO): git hash: d0beb73bfdf59edfdac67f341549a8f27f650b74
2021-10-22T19:19:58.640Z,1634930398.640 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2021-10-22T19:19:58.641Z,1634930398.641 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #1 PREEMPT Tue Dec 18 21:19:28 PST 2018
Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021
2021-10-22T19:19:58.642Z,1634930398.642 [SBIT](INFO): Beginning SBIT in 57.000000 seconds.
2021-10-22T19:19:58.643Z,1634930398.643 [IBIT](INFO): Initialize IBIT Component.
2021-10-22T19:19:58.644Z,1634930398.644 [CBIT](DEBUG): Initialize CBIT Component.
2021-10-22T19:19:58.645Z,1634930398.645 [logger ThreadHandler](INFO): Handler Thread ID is 2636
2021-10-22T19:19:58.655Z,1634930398.655 [CBIT](DEBUG): Initialized mux pins.
2021-10-22T19:19:58.655Z,1634930398.655 [CBIT](DEBUG): Initializing the watchdog timer.
2021-10-22T19:19:58.663Z,1634930398.663 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 2637
2021-10-22T19:19:58.675Z,1634930398.675 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 2638
2021-10-22T19:19:58.676Z,1634930398.676 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2021-10-22T19:19:58.679Z,1634930398.679 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2021-10-22T19:19:58.680Z,1634930398.680 [CBIT](DEBUG): Initializing heartbeat.
2021-10-22T19:19:58.687Z,1634930398.687 [Onboard ThreadHandler](INFO): Handler Thread ID is 2639
2021-10-22T19:19:58.705Z,1634930398.705 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 2640
2021-10-22T19:19:58.724Z,1634930398.724 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 2641
2021-10-22T19:19:58.724Z,1634930398.724 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2021-10-22T19:19:58.728Z,1634930398.728 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 2643
2021-10-22T19:19:58.731Z,1634930398.731 [WetLabsBB2FL](INFO): Powering up
2021-10-22T19:19:58.732Z,1634930398.732 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 2645
2021-10-22T19:19:58.736Z,1634930398.736 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2021-10-22T19:19:58.736Z,1634930398.736 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2021-10-22T19:19:58.736Z,1634930398.736 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2021-10-22T19:19:58.737Z,1634930398.737 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2021-10-22T19:19:58.737Z,1634930398.737 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2021-10-22T19:19:58.737Z,1634930398.737 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2021-10-22T19:19:58.737Z,1634930398.737 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2021-10-22T19:19:58.737Z,1634930398.737 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2021-10-22T19:19:58.737Z,1634930398.737 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2021-10-22T19:19:58.738Z,1634930398.738 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2021-10-22T19:19:58.738Z,1634930398.738 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2021-10-22T19:19:58.738Z,1634930398.738 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2021-10-22T19:19:58.738Z,1634930398.738 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2021-10-22T19:19:58.738Z,1634930398.738 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2021-10-22T19:19:58.739Z,1634930398.739 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2021-10-22T19:19:58.739Z,1634930398.739 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2021-10-22T19:19:58.751Z,1634930398.751 [CBIT](DEBUG): Deactivating GF circuits.
2021-10-22T19:19:58.751Z,1634930398.751 [CBIT](DEBUG): Deactivating emergency mode.
2021-10-22T19:19:58.787Z,1634930398.787 [CBIT](DEBUG): Backplane powered.
2021-10-22T19:19:58.788Z,1634930398.788 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2021-10-22T19:19:58.801Z,1634930398.801 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2021-10-22T19:19:58.830Z,1634930398.830 [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>


2021-10-22T19:19:58.830Z,1634930398.830 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2021-10-22T19:19:58.921Z,1634930398.921 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2021-10-22T19:19:58.923Z,1634930398.923 [Default:A.Wait](DEBUG): Construct Wait.
2021-10-22T19:19:58.925Z,1634930398.925 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2021-10-22T19:19:58.957Z,1634930398.957 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2021-10-22T19:19:58.960Z,1634930398.960 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2021-10-22T19:19:58.990Z,1634930398.990 [Default:E.Execute](DEBUG): Construct Execute.
2021-10-22T19:19:59.032Z,1634930399.032 [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>


2021-10-22T19:19:59.037Z,1634930399.037 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,NAL9602,Power24vConverter,ESPComponent,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter,
2021-10-22T19:19:59.065Z,1634930399.065 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2021-10-22T19:19:59.111Z,1634930399.111 [Radio_Surface](INFO): Powering up
2021-10-22T19:19:59.157Z,1634930399.157 [Power24vConverter](INFO): Powering up.
2021-10-22T19:19:59.229Z,1634930399.229 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2021-10-22T19:19:59.265Z,1634930399.265 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2021-10-22T19:19:59.266Z,1634930399.266 [ElevatorServo](DEBUG): Initializing EZServoServo.
2021-10-22T19:19:59.294Z,1634930399.294 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2021-10-22T19:19:59.296Z,1634930399.296 [MassServo](DEBUG): Initializing EZServoServo.
2021-10-22T19:19:59.423Z,1634930399.423 [MassServo](DEBUG): Initializing MassServo.
2021-10-22T19:19:59.424Z,1634930399.424 [RudderServo](DEBUG): Initializing EZServoServo.
2021-10-22T19:19:59.435Z,1634930399.435 [RudderServo](DEBUG): Initializing RudderServo.
2021-10-22T19:19:59.537Z,1634930399.537 [DropWeight](CRITICAL): DROP WEIGHT MISSING.

2021-10-22T19:19:59.537Z,1634930399.537 [DropWeight] Hardware Fault, FailCount= 1
2021-10-22T19:19:59.537Z,1634930399.537 [DropWeight](ERROR): Hardware Fault
2021-10-22T19:19:59.562Z,1634930399.562 [CommandExec](FAULT): Scheduling is paused
2021-10-22T19:19:59.579Z,1634930399.579 [CBIT](INFO): Critical error at 20211022T191959
2021-10-22T19:19:59.579Z,1634930399.579 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2021-10-22T19:19:59.582Z,1634930399.582 [CBIT](ERROR): Hardware Fault in component: DropWeight
2021-10-22T19:19:59.582Z,1634930399.582 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2021-10-22T19:19:59.877Z,1634930399.877 [CBIT](INFO): Critical error at 20211022T191959
2021-10-22T19:20:02.603Z,1634930402.603 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-22T19:20:03.007Z,1634930403.007 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-22T19:20:03.515Z,1634930403.515 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-22T19:20:04.019Z,1634930404.019 [WetLabsBB2FL] Communications Fault, FailCount= 1
2021-10-22T19:20:04.019Z,1634930404.019 [WetLabsBB2FL](ERROR): Communications Fault
2021-10-22T19:20:04.035Z,1634930404.035 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-22T19:20:04.355Z,1634930404.355 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2021-10-22T19:20:04.519Z,1634930404.519 [WetLabsBB2FL](INFO): Powering down
2021-10-22T19:20:04.679Z,1634930404.679 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-22T19:20:05.123Z,1634930405.123 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-22T19:20:05.591Z,1634930405.591 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-22T19:20:05.675Z,1634930405.675 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2021-10-22T19:20:05.675Z,1634930405.675 [WetLabsBB2FL] No Fault, FailCount= 1
2021-10-22T19:20:05.732Z,1634930405.732 [WetLabsBB2FL](INFO): Powering up
2021-10-22T19:20:06.011Z,1634930406.011 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-22T19:20:06.447Z,1634930406.447 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-22T19:20:06.899Z,1634930406.899 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-22T19:20:07.367Z,1634930407.367 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-22T19:20:07.799Z,1634930407.799 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-22T19:20:08.235Z,1634930408.235 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-22T19:20:08.675Z,1634930408.675 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-22T19:20:09.111Z,1634930409.111 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-22T19:20:09.531Z,1634930409.531 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-22T19:20:09.971Z,1634930409.971 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-22T19:20:10.531Z,1634930410.531 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-22T19:20:10.943Z,1634930410.943 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-22T19:20:11.031Z,1634930411.031 [WetLabsBB2FL] Communications Fault, FailCount= 2
2021-10-22T19:20:11.031Z,1634930411.031 [WetLabsBB2FL](ERROR): Communications Fault
2021-10-22T19:20:11.379Z,1634930411.379 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-22T19:20:11.471Z,1634930411.471 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2021-10-22T19:20:11.531Z,1634930411.531 [WetLabsBB2FL](INFO): Powering down
2021-10-22T19:20:11.657Z,1634930411.657 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004786
2021-10-22T19:20:11.775Z,1634930411.775 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2021-10-22T19:20:11.775Z,1634930411.775 [CTD_Seabird] Communications Fault, FailCount= 1
2021-10-22T19:20:11.775Z,1634930411.775 [CTD_Seabird](ERROR): Communications Fault
2021-10-22T19:20:11.803Z,1634930411.803 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-22T19:20:11.887Z,1634930411.887 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2021-10-22T19:20:12.180Z,1634930412.180 [CTD_Seabird](INFO): Powering down
2021-10-22T19:20:12.211Z,1634930412.211 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-22T19:20:12.211Z,1634930412.211 [AHRS_M2](FAULT): Failed to initialize within timeout.
2021-10-22T19:20:12.211Z,1634930412.211 [AHRS_M2] Communications Fault, FailCount= 1
2021-10-22T19:20:12.211Z,1634930412.211 [AHRS_M2](ERROR): Communications Fault
2021-10-22T19:20:12.295Z,1634930412.295 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2021-10-22T19:20:12.302Z,1634930412.302 [AHRS_M2](INFO): Powering down
2021-10-22T19:20:12.439Z,1634930412.439 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2021-10-22T19:20:12.439Z,1634930412.439 [WetLabsBB2FL] No Fault, FailCount= 2
2021-10-22T19:20:12.744Z,1634930412.744 [WetLabsBB2FL](INFO): Powering up
2021-10-22T19:20:13.208Z,1634930413.208 [CBIT](INFO): Clearing failed state for component AHRS_M2
2021-10-22T19:20:13.208Z,1634930413.208 [AHRS_M2] No Fault, FailCount= 1
2021-10-22T19:20:13.208Z,1634930413.208 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2021-10-22T19:20:13.208Z,1634930413.208 [CTD_Seabird] No Fault, FailCount= 1
2021-10-22T19:20:13.519Z,1634930413.519 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2021-10-22T19:20:13.532Z,1634930413.532 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2021-10-22T19:20:17.091Z,1634930417.091 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-22T19:20:17.499Z,1634930417.499 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-22T19:20:17.895Z,1634930417.895 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-22T19:20:18.043Z,1634930418.043 [WetLabsBB2FL] Communications Fault, FailCount= 3
2021-10-22T19:20:18.043Z,1634930418.043 [WetLabsBB2FL](ERROR): Communications Fault
2021-10-22T19:20:18.323Z,1634930418.323 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-22T19:20:18.415Z,1634930418.415 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2021-10-22T19:20:18.551Z,1634930418.551 [WetLabsBB2FL](INFO): Powering down
2021-10-22T19:20:18.743Z,1634930418.743 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-22T19:20:19.171Z,1634930419.171 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-22T19:20:19.587Z,1634930419.587 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-22T19:20:19.684Z,1634930419.684 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2021-10-22T19:20:19.684Z,1634930419.684 [WetLabsBB2FL] No Fault, FailCount= 3
2021-10-22T19:20:19.765Z,1634930419.765 [WetLabsBB2FL](INFO): Powering up
2021-10-22T19:20:20.015Z,1634930420.015 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-22T19:20:20.435Z,1634930420.435 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-22T19:20:20.923Z,1634930420.923 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-22T19:20:21.315Z,1634930421.315 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-22T19:20:21.723Z,1634930421.723 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-22T19:20:22.127Z,1634930422.127 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-22T19:20:22.595Z,1634930422.595 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-22T19:20:22.983Z,1634930422.983 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-22T19:20:23.403Z,1634930423.403 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-22T19:20:23.799Z,1634930423.799 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-22T19:20:24.195Z,1634930424.195 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-22T19:20:24.623Z,1634930424.623 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-22T19:20:25.027Z,1634930425.027 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-22T19:20:25.055Z,1634930425.055 [WetLabsBB2FL] Communications Fault, FailCount= 4
2021-10-22T19:20:25.055Z,1634930425.055 [WetLabsBB2FL](ERROR): Communications Fault
2021-10-22T19:20:25.093Z,1634930425.093 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2021-10-22T19:20:25.443Z,1634930425.443 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-22T19:20:25.555Z,1634930425.555 [WetLabsBB2FL](INFO): Powering down
2021-10-22T19:20:25.859Z,1634930425.859 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-22T19:20:26.315Z,1634930426.315 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-22T19:20:26.403Z,1634930426.403 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2021-10-22T19:20:26.403Z,1634930426.403 [WetLabsBB2FL] No Fault, FailCount= 4
2021-10-22T19:20:26.571Z,1634930426.571 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2021-10-22T19:20:26.571Z,1634930426.571 [CTD_Seabird] Communications Fault, FailCount= 2
2021-10-22T19:20:26.571Z,1634930426.571 [CTD_Seabird](ERROR): Communications Fault
2021-10-22T19:20:26.735Z,1634930426.735 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-22T19:20:26.735Z,1634930426.735 [AHRS_M2](FAULT): Failed to initialize within timeout.
2021-10-22T19:20:26.735Z,1634930426.735 [AHRS_M2] Communications Fault, FailCount= 2
2021-10-22T19:20:26.735Z,1634930426.735 [AHRS_M2](ERROR): Communications Fault
2021-10-22T19:20:26.791Z,1634930426.791 [WetLabsBB2FL](INFO): Powering up
2021-10-22T19:20:26.815Z,1634930426.815 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2021-10-22T19:20:26.816Z,1634930426.816 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2021-10-22T19:20:26.843Z,1634930426.843 [AHRS_M2](INFO): Powering down
2021-10-22T19:20:26.975Z,1634930426.975 [CTD_Seabird](INFO): Powering down
2021-10-22T19:20:27.639Z,1634930427.639 [NAL9602](INFO): Powering up NAL9602
2021-10-22T19:20:27.672Z,1634930427.672 [CBIT](INFO): Clearing failed state for component AHRS_M2
2021-10-22T19:20:27.672Z,1634930427.672 [AHRS_M2] No Fault, FailCount= 2
2021-10-22T19:20:28.040Z,1634930428.040 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2021-10-22T19:20:28.124Z,1634930428.124 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2021-10-22T19:20:28.124Z,1634930428.124 [CTD_Seabird] No Fault, FailCount= 2
2021-10-22T19:20:28.319Z,1634930428.319 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2021-10-22T19:20:31.599Z,1634930431.599 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-22T19:20:31.999Z,1634930431.999 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-22T19:20:32.062Z,1634930432.062 [WetLabsBB2FL] Communications Fault, FailCount= 5
2021-10-22T19:20:32.062Z,1634930432.062 [WetLabsBB2FL](ERROR): Communications Fault
2021-10-22T19:20:32.403Z,1634930432.403 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-22T19:20:32.486Z,1634930432.486 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2021-10-22T19:20:32.486Z,1634930432.486 [CBIT](FAULT): Communications Fault in component: WetLabsBB2FL
2021-10-22T19:20:32.555Z,1634930432.555 [WetLabsBB2FL](INFO): Powering down
2021-10-22T19:20:32.819Z,1634930432.819 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-22T19:20:33.219Z,1634930433.219 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-22T19:20:33.627Z,1634930433.627 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-22T19:20:34.043Z,1634930434.043 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-22T19:20:34.451Z,1634930434.451 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-22T19:20:34.851Z,1634930434.851 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-22T19:20:35.255Z,1634930435.255 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-22T19:20:35.659Z,1634930435.659 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-22T19:20:36.075Z,1634930436.075 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-22T19:20:36.499Z,1634930436.499 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-22T19:20:36.911Z,1634930436.911 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-22T19:20:37.347Z,1634930437.347 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-22T19:20:37.791Z,1634930437.791 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-22T19:20:38.199Z,1634930438.199 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-22T19:20:38.631Z,1634930438.631 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-22T19:20:38.652Z,1634930438.652 [NAL9602](INFO): NAL9602 initialized
2021-10-22T19:20:39.091Z,1634930439.091 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-22T19:20:39.507Z,1634930439.507 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-22T19:20:40.011Z,1634930440.011 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-22T19:20:40.215Z,1634930440.215 [CommandExec](IMPORTANT): got command configSet ThrusterHE.loadAtStartup 1.000000 bool persist
2021-10-22T19:20:40.215Z,1634930440.215 [CommandExec](IMPORTANT): configSet ThrusterHE.loadAtStartup requires a restart to take effect.
2021-10-22T19:20:40.218Z,1634930440.218 [CommandExec](IMPORTANT): got command restart application
2021-10-22T19:20:40.459Z,1634930440.459 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-22T19:20:40.875Z,1634930440.875 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2021-10-22T19:20:40.875Z,1634930440.875 [AHRS_M2](FAULT): Failed to initialize within timeout.
2021-10-22T19:20:40.875Z,1634930440.875 [AHRS_M2] Communications Fault, FailCount= 3
2021-10-22T19:20:40.875Z,1634930440.875 [AHRS_M2](ERROR): Communications Fault
2021-10-22T19:20:40.977Z,1634930440.977 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2021-10-22T19:20:41.012Z,1634930441.012 [AHRS_M2](INFO): Powering down
2021-10-22T19:20:41.219Z,1634930441.219 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread.
2021-10-22T19:20:41.219Z,1634930441.219 [CommandExec](INFO): Uninitializing the command executive.
2021-10-22T19:20:41.219Z,1634930441.219 [CommandExec](INFO): Uninitializing the command scheduler.
2021-10-22T19:20:41.220Z,1634930441.220 [CommandExec ThreadHandler](INFO): Thread cancelled.
2021-10-22T19:20:41.371Z,1634930441.371 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2021-10-22T19:20:41.371Z,1634930441.371 [CTD_Seabird] Communications Fault, FailCount= 3
2021-10-22T19:20:41.371Z,1634930441.371 [CTD_Seabird](ERROR): Communications Fault
2021-10-22T19:20:41.419Z,1634930441.419 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2021-10-22T19:20:41.419Z,1634930441.419 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2021-10-22T19:20:41.419Z,1634930441.419 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2021-10-22T19:20:41.420Z,1634930441.420 [NavChartDb](INFO): Join timeout helper Thread ID is 2659
2021-10-22T19:20:41.487Z,1634930441.487 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2021-10-22T19:20:41.488Z,1634930441.488 [CBIT](FAULT): Communications Fault in component: CTD_Seabird
2021-10-22T19:20:41.775Z,1634930441.775 [CTD_Seabird](INFO): Powering down
2021-10-22T19:20:41.872Z,1634930441.872 [CBIT](INFO): Clearing failed state for component AHRS_M2
2021-10-22T19:20:41.872Z,1634930441.872 [AHRS_M2] No Fault, FailCount= 3
2021-10-22T19:20:42.196Z,1634930442.196 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2021-10-22T19:20:42.649Z,1634930442.649 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2021-10-22T19:20:42.649Z,1634930442.649 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2021-10-22T19:20:42.675Z,1634930442.675 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2021-10-22T19:20:42.675Z,1634930442.675 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2021-10-22T19:20:42.675Z,1634930442.675 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 2661
2021-10-22T19:20:43.059Z,1634930443.059 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2021-10-22T19:20:43.059Z,1634930443.059 [WetLabsBB2FL](INFO): Powering down
2021-10-22T19:20:43.060Z,1634930443.060 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2021-10-22T19:20:43.075Z,1634930443.075 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2021-10-22T19:20:43.075Z,1634930443.075 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2021-10-22T19:20:43.075Z,1634930443.075 [CTD_Seabird](INFO): Join timeout helper Thread ID is 2662
2021-10-22T19:20:43.119Z,1634930443.119 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2021-10-22T19:20:43.119Z,1634930443.119 [CTD_Seabird](INFO): Powering down
2021-10-22T19:20:43.131Z,1634930443.131 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2021-10-22T19:20:43.136Z,1634930443.136 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2021-10-22T19:20:43.136Z,1634930443.136 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2021-10-22T19:20:43.137Z,1634930443.137 [Radio_Surface](INFO): Join timeout helper Thread ID is 2663
2021-10-22T19:20:43.167Z,1634930443.167 [Radio_Surface](INFO): Powering down
2021-10-22T19:20:43.168Z,1634930443.168 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2021-10-22T19:20:43.168Z,1634930443.168 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2021-10-22T19:20:43.175Z,1634930443.175 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2021-10-22T19:20:43.175Z,1634930443.175 [Onboard ThreadHandler](INFO): Thread cancelled.
2021-10-22T19:20:43.175Z,1634930443.175 [Onboard](INFO): Join timeout helper Thread ID is 2664
2021-10-22T19:20:43.723Z,1634930443.723 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2021-10-22T19:20:43.723Z,1634930443.723 [Onboard ThreadHandler](INFO): Thread cancelled.
2021-10-22T19:20:43.740Z,1634930443.740 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2021-10-22T19:20:43.740Z,1634930443.740 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2021-10-22T19:20:43.740Z,1634930443.740 [DataOverHttps](INFO): Join timeout helper Thread ID is 2665
2021-10-22T19:20:43.783Z,1634930443.783 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2021-10-22T19:20:43.786Z,1634930443.786 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2021-10-22T19:20:43.792Z,1634930443.792 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler
2021-10-22T19:20:43.792Z,1634930443.792 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2021-10-22T19:20:43.792Z,1634930443.792 [BackseatComponent](INFO): Join timeout helper Thread ID is 2666
2021-10-22T19:20:43.975Z,1634930443.975 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread.
2021-10-22T19:20:43.975Z,1634930443.975 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2021-10-22T19:20:43.995Z,1634930443.995 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2021-10-22T19:20:43.996Z,1634930443.996 [logger ThreadHandler](INFO): Thread cancelled.
2021-10-22T19:20:43.996Z,1634930443.996 [logger](INFO): Join timeout helper Thread ID is 2667
2021-10-22T19:20:44.015Z,1634930444.015 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2021-10-22T19:20:44.015Z,1634930444.015 [logger ThreadHandler](INFO): Thread cancelled.
2021-10-22T19:20:44.036Z,1634930444.036 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2021-10-22T19:20:44.036Z,1634930444.036 [CommandLine ThreadHandler](INFO): Thread cancelled.
2021-10-22T19:20:44.036Z,1634930444.036 [CommandLine](INFO): Join timeout helper Thread ID is 2668
2021-10-22T19:20:44.119Z,1634930444.119 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2021-10-22T19:20:44.119Z,1634930444.119 [CommandLine ThreadHandler](INFO): Thread cancelled.
2021-10-22T19:20:44.135Z,1634930444.135 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler
2021-10-22T19:20:44.136Z,1634930444.136 [CommandExec ThreadHandler](INFO): Thread cancelled.
2021-10-22T19:20:44.136Z,1634930444.136 [CommandExec](INFO): Join timeout helper Thread ID is 2669
2021-10-22T19:20:44.137Z,1634930444.137 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2021-10-22T19:20:44.137Z,1634930444.137 [controlThread ThreadHandler](INFO): Thread cancelled.
2021-10-22T19:20:44.138Z,1634930444.138 [controlThread](INFO): Join timeout helper Thread ID is 2670
2021-10-22T19:20:44.223Z,1634930444.223 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2021-10-22T19:20:44.223Z,1634930444.223 [controlThread](DEBUG): Uninitializing ControlThread
2021-10-22T19:20:44.224Z,1634930444.224 [AHRS_M2](INFO): Powering down
2021-10-22T19:20:44.296Z,1634930444.296 [NAL9602](INFO): Powering down
2021-10-22T19:20:44.298Z,1634930444.298 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2021-10-22T19:20:44.299Z,1634930444.299 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2021-10-22T19:20:44.300Z,1634930444.300 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2021-10-22T19:20:44.300Z,1634930444.300 [MissionManager](INFO): Uninitializing Mission Default
2021-10-22T19:20:44.303Z,1634930444.303 [MissionManager](INFO): Uninitializing Mission Startup
2021-10-22T19:20:44.305Z,1634930444.305 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2021-10-22T19:20:44.305Z,1634930444.305 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2021-10-22T19:20:44.306Z,1634930444.306 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2021-10-22T19:20:44.306Z,1634930444.306 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2021-10-22T19:20:44.306Z,1634930444.306 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2021-10-22T19:20:44.306Z,1634930444.306 [BuoyancyServo](INFO): Powering down
2021-10-22T19:20:44.319Z,1634930444.319 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2021-10-22T19:20:44.319Z,1634930444.319 [ElevatorServo](INFO): Powering down
2021-10-22T19:20:44.320Z,1634930444.320 [MassServo](DEBUG): Uninitialize Mass Servo.
2021-10-22T19:20:44.320Z,1634930444.320 [MassServo](INFO): Powering down
2021-10-22T19:20:44.321Z,1634930444.321 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2021-10-22T19:20:44.321Z,1634930444.321 [RudderServo](INFO): Powering down
2021-10-22T19:20:44.322Z,1634930444.322 [SBIT](DEBUG): Uninitialize SBIT Component.
2021-10-22T19:20:44.322Z,1634930444.322 [IBIT](DEBUG): Uninitialize IBIT Component.
2021-10-22T19:20:44.323Z,1634930444.323 [CBIT](DEBUG): Uninitialize CBIT Component.
2021-10-22T19:20:44.323Z,1634930444.323 [CBIT](DEBUG): Powering off loads.
2021-10-22T19:20:44.335Z,1634930444.335 [CBIT](DEBUG): Disabling WDT.
2021-10-22T19:20:44.347Z,1634930444.347 [CBIT](DEBUG): Opening all GF detection circuits.
2021-10-22T19:20:44.348Z,1634930444.348 [controlThread ThreadHandler](INFO): Thread cancelled.
2021-10-22T19:20:44.509Z,1634930444.509 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2021-10-22T19:20:44.512Z,1634930444.512 [Onboard ThreadHandler](INFO): Thread cancelled.
2021-10-22T19:20:44.518Z,1634930444.518 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2021-10-22T19:20:44.562Z,1634930444.562 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2021-10-22T19:20:44.594Z,1634930444.594 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2021-10-22T19:20:44.600Z,1634930444.600 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2021-10-22T19:20:44.631Z,1634930444.631 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2021-10-22T19:20:44.692Z,1634930444.692 [logger ThreadHandler](INFO): Thread cancelled.