2018-01-11T23:57:18.707Z,1515715038.707 [Supervisor](DEBUG): Initializing supervisor. 2018-01-11T23:57:18.710Z,1515715038.710 [SyncHandler](DEBUG): Created PCaller Thread at 4051A4E0 2018-01-11T23:57:18.710Z,1515715038.710 [SyncHandler](INFO): Protected caller Thread ID is 770 2018-01-11T23:57:18.711Z,1515715038.711 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2018-01-11T23:57:18.712Z,1515715038.712 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 4054A4E0 2018-01-11T23:57:18.712Z,1515715038.712 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 771 2018-01-11T23:57:18.715Z,1515715038.715 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2018-01-11T23:57:18.726Z,1515715038.726 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2018-01-11T23:57:18.727Z,1515715038.727 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 4057A4E0 2018-01-11T23:57:18.728Z,1515715038.728 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 772 2018-01-11T23:57:18.728Z,1515715038.728 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2018-01-11T23:57:18.729Z,1515715038.729 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405AA4E0 2018-01-11T23:57:18.730Z,1515715038.730 [logger ThreadHandler](INFO): Protected caller Thread ID is 773 2018-01-11T23:57:18.732Z,1515715038.732 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2018-01-11T23:57:18.732Z,1515715038.732 [Supervisor](INFO): Looking for Config files in directory: Config/ 2018-01-11T23:57:18.736Z,1515715038.736 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2018-01-11T23:57:18.918Z,1515715038.918 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2018-01-11T23:57:18.918Z,1515715038.918 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2018-01-11T23:57:19.062Z,1515715039.062 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2018-01-11T23:57:19.062Z,1515715039.062 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2018-01-11T23:57:19.376Z,1515715039.376 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2018-01-11T23:57:19.377Z,1515715039.377 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2018-01-11T23:57:19.517Z,1515715039.517 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2018-01-11T23:57:19.520Z,1515715039.520 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2018-01-11T23:57:19.605Z,1515715039.605 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2018-01-11T23:57:19.797Z,1515715039.797 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2018-01-11T23:57:19.799Z,1515715039.799 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2018-01-11T23:57:19.900Z,1515715039.900 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample 2018-01-11T23:57:19.901Z,1515715039.901 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2018-01-11T23:57:20.216Z,1515715040.216 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2018-01-11T23:57:20.216Z,1515715040.216 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2018-01-11T23:57:20.557Z,1515715040.557 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2018-01-11T23:57:20.558Z,1515715040.558 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2018-01-11T23:57:20.847Z,1515715040.847 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2018-01-11T23:57:20.848Z,1515715040.848 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2018-01-11T23:57:21.333Z,1515715041.333 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2018-01-11T23:57:21.334Z,1515715041.334 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2018-01-11T23:57:24.359Z,1515715044.359 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2018-01-11T23:57:24.360Z,1515715044.360 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2018-01-11T23:57:26.159Z,1515715046.159 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2018-01-11T23:57:26.160Z,1515715046.160 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2018-01-11T23:57:26.613Z,1515715046.613 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2018-01-11T23:57:26.616Z,1515715046.616 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2018-01-11T23:57:26.730Z,1515715046.730 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2018-01-11T23:57:26.732Z,1515715046.732 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-ahi/ 2018-01-11T23:57:26.734Z,1515715046.734 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Battery.cfg 2018-01-11T23:57:26.963Z,1515715046.963 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2018-01-11T23:57:26.964Z,1515715046.964 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/BIT.cfg 2018-01-11T23:57:27.067Z,1515715047.067 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Navigation.cfg 2018-01-11T23:57:27.174Z,1515715047.174 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Control.cfg 2018-01-11T23:57:27.275Z,1515715047.275 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Simulator.cfg 2018-01-11T23:57:27.365Z,1515715047.365 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Science.cfg 2018-01-11T23:57:27.515Z,1515715047.515 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Sensor.cfg 2018-01-11T23:57:27.685Z,1515715047.685 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Servo.cfg 2018-01-11T23:57:27.797Z,1515715047.797 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/logger.cfg 2018-01-11T23:57:27.897Z,1515715047.897 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/secure.cfg 2018-01-11T23:57:27.985Z,1515715047.985 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/vehicle.cfg 2018-01-11T23:57:28.152Z,1515715048.152 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg 2018-01-11T23:57:28.159Z,1515715048.159 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2018-01-11T23:57:28.318Z,1515715048.318 [SBIT](DEBUG): Construct Startup Built In Test. 2018-01-11T23:57:28.349Z,1515715048.349 [SBIT] Loaded 2018-01-11T23:57:28.349Z,1515715048.349 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2018-01-11T23:57:28.350Z,1515715048.350 [IBIT](DEBUG): Construct Initiated Built In Test. 2018-01-11T23:57:28.378Z,1515715048.378 [IBIT] Loaded 2018-01-11T23:57:28.378Z,1515715048.378 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2018-01-11T23:57:28.382Z,1515715048.382 [CBIT](DEBUG): Construct Continuous Built In Test. 2018-01-11T23:57:28.541Z,1515715048.541 [CBIT] Loaded 2018-01-11T23:57:28.541Z,1515715048.541 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2018-01-11T23:57:28.542Z,1515715048.542 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2018-01-11T23:57:28.542Z,1515715048.542 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2018-01-11T23:57:28.633Z,1515715048.633 [VerticalControl](DEBUG): Construct VerticalControl. 2018-01-11T23:57:28.734Z,1515715048.734 [VerticalControl] Loaded 2018-01-11T23:57:28.734Z,1515715048.734 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2018-01-11T23:57:28.735Z,1515715048.735 [HorizontalControl](DEBUG): Construct HorizontalControl. 2018-01-11T23:57:28.798Z,1515715048.798 [HorizontalControl] Loaded 2018-01-11T23:57:28.798Z,1515715048.798 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2018-01-11T23:57:28.799Z,1515715048.799 [SpeedControl](DEBUG): Construct SpeedControl. 2018-01-11T23:57:28.804Z,1515715048.804 [SpeedControl] Loaded 2018-01-11T23:57:28.804Z,1515715048.804 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2018-01-11T23:57:28.805Z,1515715048.805 [LoopControl](DEBUG): Construct LoopControl. 2018-01-11T23:57:28.806Z,1515715048.806 [LoopControl] Loaded 2018-01-11T23:57:28.806Z,1515715048.806 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2018-01-11T23:57:28.806Z,1515715048.806 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2018-01-11T23:57:28.807Z,1515715048.807 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2018-01-11T23:57:28.864Z,1515715048.864 [DepthRateCalculator] Loaded 2018-01-11T23:57:28.865Z,1515715048.865 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2018-01-11T23:57:28.870Z,1515715048.870 [PitchRateCalculator] Loaded 2018-01-11T23:57:28.870Z,1515715048.870 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2018-01-11T23:57:28.886Z,1515715048.886 [SpeedCalculator] Loaded 2018-01-11T23:57:28.887Z,1515715048.887 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2018-01-11T23:57:28.909Z,1515715048.909 [TempGradientCalculator] Loaded 2018-01-11T23:57:28.910Z,1515715048.910 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread. 2018-01-11T23:57:28.926Z,1515715048.926 [VerticalTemperatureHomogeneityIndexCalculator] Loaded 2018-01-11T23:57:28.926Z,1515715048.926 [ComponentRegistry](DEBUG): SyncComponent "VerticalTemperatureHomogeneityIndexCalculator" handled in the control thread. 2018-01-11T23:57:28.931Z,1515715048.931 [YawRateCalculator] Loaded 2018-01-11T23:57:28.931Z,1515715048.931 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2018-01-11T23:57:28.932Z,1515715048.932 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2018-01-11T23:57:28.934Z,1515715048.934 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2018-01-11T23:57:29.059Z,1515715049.059 [StratificationFrontDetector](INFO): threshold set to: 0.399988 degC 2018-01-11T23:57:29.059Z,1515715049.059 [StratificationFrontDetector](DEBUG): (re)initializing 2018-01-11T23:57:29.060Z,1515715049.060 [StratificationFrontDetector] Loaded 2018-01-11T23:57:29.060Z,1515715049.060 [ComponentRegistry](DEBUG): SyncComponent "StratificationFrontDetector" handled in the control thread. 2018-01-11T23:57:29.061Z,1515715049.061 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2018-01-11T23:57:29.061Z,1515715049.061 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2018-01-11T23:57:29.342Z,1515715049.342 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2018-01-11T23:57:29.342Z,1515715049.342 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2018-01-11T23:57:29.459Z,1515715049.459 [DeadReckonUsingMultipleVelocitySources] Loaded 2018-01-11T23:57:29.459Z,1515715049.459 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2018-01-11T23:57:29.515Z,1515715049.515 [DeadReckonUsingSpeedCalculator] Loaded 2018-01-11T23:57:29.515Z,1515715049.515 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread. 2018-01-11T23:57:29.571Z,1515715049.571 [DeadReckonWithRespectToSeafloor] Loaded 2018-01-11T23:57:29.571Z,1515715049.571 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToSeafloor" handled in the control thread. 2018-01-11T23:57:29.588Z,1515715049.588 [NavChart] Loaded 2018-01-11T23:57:29.588Z,1515715049.588 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2018-01-11T23:57:29.592Z,1515715049.592 [UniversalFixResidualReporter] Loaded 2018-01-11T23:57:29.592Z,1515715049.592 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualRepor