2018-05-29T17:04:07.265Z,1527613447.265 [Supervisor](DEBUG): Initializing supervisor.
2018-05-29T17:04:07.268Z,1527613447.268 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2018-05-29T17:04:07.269Z,1527613447.269 [SyncHandler](INFO): Protected caller Thread ID is 799
2018-05-29T17:04:07.269Z,1527613447.269 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2018-05-29T17:04:07.270Z,1527613447.270 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2018-05-29T17:04:07.270Z,1527613447.270 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 800
2018-05-29T17:04:07.273Z,1527613447.273 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2018-05-29T17:04:07.285Z,1527613447.285 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2018-05-29T17:04:07.286Z,1527613447.286 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2018-05-29T17:04:07.286Z,1527613447.286 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 801
2018-05-29T17:04:07.287Z,1527613447.287 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2018-05-29T17:04:07.288Z,1527613447.288 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2018-05-29T17:04:07.288Z,1527613447.288 [logger ThreadHandler](INFO): Protected caller Thread ID is 802
2018-05-29T17:04:07.290Z,1527613447.290 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2018-05-29T17:04:07.290Z,1527613447.290 [Supervisor](INFO): Looking for Config files in directory: Config/
2018-05-29T17:04:07.294Z,1527613447.294 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2018-05-29T17:04:07.393Z,1527613447.393 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2018-05-29T17:04:07.395Z,1527613447.395 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2018-05-29T17:04:07.498Z,1527613447.498 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2018-05-29T17:04:07.498Z,1527613447.498 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2018-05-29T17:04:07.708Z,1527613447.708 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2018-05-29T17:04:07.710Z,1527613447.710 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2018-05-29T17:04:08.043Z,1527613448.043 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2018-05-29T17:04:08.044Z,1527613448.044 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2018-05-29T17:04:08.394Z,1527613448.394 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2018-05-29T17:04:08.395Z,1527613448.395 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2018-05-29T17:04:08.871Z,1527613448.871 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2018-05-29T17:04:08.871Z,1527613448.871 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2018-05-29T17:04:09.272Z,1527613449.272 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2018-05-29T17:04:09.274Z,1527613449.274 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2018-05-29T17:04:09.745Z,1527613449.745 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2018-05-29T17:04:09.746Z,1527613449.746 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2018-05-29T17:04:09.827Z,1527613449.827 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2018-05-29T17:04:10.136Z,1527613450.136 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2018-05-29T17:04:10.138Z,1527613450.138 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2018-05-29T17:04:10.284Z,1527613450.284 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2018-05-29T17:04:10.285Z,1527613450.285 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2018-05-29T17:04:10.498Z,1527613450.498 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2018-05-29T17:04:10.500Z,1527613450.500 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2018-05-29T17:04:10.761Z,1527613450.761 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2018-05-29T17:04:10.761Z,1527613450.761 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2018-05-29T17:04:11.160Z,1527613451.160 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2018-05-29T17:04:11.347Z,1527613451.347 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2018-05-29T17:04:11.947Z,1527613451.947 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2018-05-29T17:04:11.949Z,1527613451.949 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/
2018-05-29T17:04:11.952Z,1527613451.952 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Battery.cfg
2018-05-29T17:04:12.185Z,1527613452.185 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2018-05-29T17:04:12.186Z,1527613452.186 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/logger.cfg
2018-05-29T17:04:12.265Z,1527613452.265 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Science.cfg
2018-05-29T17:04:12.413Z,1527613452.413 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Control.cfg
2018-05-29T17:04:12.507Z,1527613452.507 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Simulator.cfg
2018-05-29T17:04:12.594Z,1527613452.594 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Sensor.cfg
2018-05-29T17:04:12.735Z,1527613452.735 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/vehicle.cfg
2018-05-29T17:04:12.908Z,1527613452.908 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Servo.cfg
2018-05-29T17:04:13.007Z,1527613453.007 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Navigation.cfg
2018-05-29T17:04:13.101Z,1527613453.101 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/BIT.cfg
2018-05-29T17:04:13.201Z,1527613453.201 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/secure.cfg
2018-05-29T17:04:13.285Z,1527613453.285 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2018-05-29T17:04:13.301Z,1527613453.301 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2018-05-29T17:04:13.429Z,1527613453.429 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2018-05-29T17:04:13.429Z,1527613453.429 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2018-05-29T17:04:13.453Z,1527613453.453 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2018-05-29T17:04:13.454Z,1527613453.454 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2018-05-29T17:04:13.509Z,1527613453.509 [DepthRateCalculator] Loaded
2018-05-29T17:04:13.509Z,1527613453.509 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2018-05-29T17:04:13.515Z,1527613453.515 [PitchRateCalculator] Loaded
2018-05-29T17:04:13.515Z,1527613453.515 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2018-05-29T17:04:13.531Z,1527613453.531 [SpeedCalculator] Loaded
2018-05-29T17:04:13.531Z,1527613453.531 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2018-05-29T17:04:13.552Z,1527613453.552 [TempGradientCalculator] Loaded
2018-05-29T17:04:13.553Z,1527613453.553 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2018-05-29T17:04:13.568Z,1527613453.568 [VerticalTemperatureHomogeneityIndexCalculator] Loaded
2018-05-29T17:04:13.568Z,1527613453.568 [ComponentRegistry](DEBUG): SyncComponent "VerticalTemperatureHomogeneityIndexCalculator" handled in the control thread.
2018-05-29T17:04:13.574Z,1527613453.574 [YawRateCalculator] Loaded
2018-05-29T17:04:13.574Z,1527613453.574 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2018-05-29T17:04:13.614Z,1527613453.614 [ElevatorOffsetCalculator] Loaded
2018-05-29T17:04:13.614Z,1527613453.614 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2018-05-29T17:04:13.615Z,1527613453.615 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2018-05-29T17:04:13.615Z,1527613453.615 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2018-05-29T17:04:13.652Z,1527613453.652 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2018-05-29T17:04:13.653Z,1527613453.653 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2018-05-29T17:04:14.133Z,1527613454.133 [AcousticModem_Benthos_ATM900] Loaded
2018-05-29T17:04:14.133Z,1527613454.133 [ComponentRegistry](DEBUG): SyncComponent "AcousticModem_Benthos_ATM900" handled in the control thread.
2018-05-29T17:04:14.268Z,1527613454.268 [DataOverHttps] Loaded
2018-05-29T17:04:14.268Z,1527613454.268 [ComponentRegistry](DEBUG): SyncComponent "DataOverHttps" handled in the control thread.
2018-05-29T17:04:14.282Z,1527613454.282 [Depth_Keller] Loaded
2018-05-29T17:04:14.283Z,1527613454.283 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2018-05-29T17:04:14.380Z,1527613454.380 [NAL9602] Loaded
2018-05-29T17:04:14.380Z,1527613454.380 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2018-05-29T17:04:14.396Z,1527613454.396 [Onboard] Loaded
2018-05-29T17:04:14.396Z,1527613454.396 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2018-05-29T17:04:14.406Z,1527613454.406 [Radio_Surface] Loaded
2018-05-29T17:04:14.407Z,1527613454.407 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2018-05-29T17:04:14.408Z,1527613454.408 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 407B74E0
2018-05-29T17:04:14.408Z,1527613454.408 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 882
2018-05-29T17:04:14.561Z,1527613454.561 [PNI_TCM] Loaded
2018-05-29T17:04:14.561Z,1527613454.561 [ComponentRegistry](DEBUG): SyncComponent "PNI_TCM" handled in the control thread.
2018-05-29T17:04:16.675Z,1527613456.675 [BPC1] Loaded
2018-05-29T17:04:16.675Z,1527613456.675 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2018-05-29T17:04:16.675Z,1527613456.675 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2018-05-29T17:04:16.676Z,1527613456.676 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2018-05-29T17:04:16.896Z,1527613456.896 [SBIT](DEBUG): Construct Startup Built In Test.
2018-05-29T17:04:16.919Z,1527613456.919 [SBIT] Loaded
2018-05-29T17:04:16.919Z,1527613456.919 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2018-05-29T17:04:16.920Z,1527613456.920 [IBIT](DEBUG): Construct Initiated Built In Test.
2018-05-29T17:04:16.932Z,1527613456.932 [IBIT] Loaded
2018-05-29T17:04:16.932Z,1527613456.932 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2018-05-29T17:04:16.935Z,1527613456.935 [CBIT](DEBUG): Construct Continuous Built In Test.
2018-05-29T17:04:17.084Z,1527613457.084 [CBIT] Loaded
2018-05-29T17:04:17.085Z,1527613457.085 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2018-05-29T17:04:17.085Z,1527613457.085 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2018-05-29T17:04:17.086Z,1527613457.086 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2018-05-29T17:04:17.300Z,1527613457.300 [CTD_Seabird] Loaded
2018-05-29T17:04:17.301Z,1527613457.301 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2018-05-29T17:04:17.302Z,1527613457.302 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 408774E0
2018-05-29T17:04:17.302Z,1527613457.302 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 883
2018-05-29T17:04:17.319Z,1527613457.319 [ESPComponent] Loaded
2018-05-29T17:04:17.319Z,1527613457.319 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread.
2018-05-29T17:04:17.333Z,1527613457.333 [PAR_Licor] Loaded
2018-05-29T17:04:17.334Z,1527613457.334 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2018-05-29T17:04:17.334Z,1527613457.334 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2018-05-29T17:04:17.335Z,1527613457.335 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2018-05-29T17:04:17.614Z,1527613457.614 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2018-05-29T17:04:17.614Z,1527613457.614 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2018-05-29T17:04:17.702Z,1527613457.702 [VerticalControl](DEBUG): Construct VerticalControl.
2018-05-29T17:04:17.796Z,1527613457.796 [VerticalControl] Loaded
2018-05-29T17:04:17.796Z,1527613457.796 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2018-05-29T17:04:17.797Z,1527613457.797 [HorizontalControl](DEBUG): Construct HorizontalControl.
2018-05-29T17:04:17.857Z,1527613457.857 [HorizontalControl] Loaded
2018-05-29T17:04:17.857Z,1527613457.857 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2018-05-29T17:04:17.858Z,1527613457.858 [SpeedControl](DEBUG): Construct SpeedControl.
2018-05-29T17:04:17.864Z,1527613457.864 [SpeedControl] Loaded
2018-05-29T17:04:17.864Z,1527613457.864 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2018-05-29T17:04:17.865Z,1527613457.865 [LoopControl](DEBUG): Construct LoopControl.
2018-05-29T17:04:17.865Z,1527613457.865 [LoopControl] Loaded
2018-05-29T17:04:17.865Z,1527613457.865 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2018-05-29T17:04:17.866Z,1527613457.866 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2018-05-29T17:04:17.867Z,1527613457.867 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2018-05-29T17:04:17.989Z,1527613457.989 [StratificationFrontDetector](INFO): threshold set to: 0.399988 degC
2018-05-29T17:04:17.989Z,1527613457.989 [StratificationFrontDetector](DEBUG): (re)initializing
2018-05-29T17:04:17.989Z,1527613457.989 [StratificationFrontDetector] Loaded
2018-05-29T17:04:17.989Z,1527613457.989 [ComponentRegistry](DEBUG): SyncComponent "StratificationFrontDetector" handled in the control thread.
2018-05-29T17:04:17.990Z,1527613457.990 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2018-05-29T17:04:17.991Z,1527613457.991 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2018-05-29T17:04:18.110Z,1527613458.110 [BuoyancyServo] Loaded
2018-05-29T17:04:18.110Z,1527613458.110 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2018-05-29T17:04:18.122Z,1527613458.122 [ElevatorServo] Loaded
2018-05-29T17:04:18.122Z,1527613458.122 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2018-05-29T17:04:18.133Z,1527613458.133 [MassServo] Loaded
2018-05-29T17:04:18.133Z,1527613458.133 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2018-05-29T17:04:18.144Z,1527613458.144 [RudderServo] Loaded
2018-05-29T17:04:18.145Z,1527613458.145 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2018-05-29T17:04:18.155Z,1527613458.155 [ThrusterServo] Loaded
2018-05-29T17:04:18.156Z,1527613458.156 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2018-05-29T17:04:18.156Z,1527613458.156 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2018-05-29T17:04:18.158Z,1527613458.158 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2018-05-29T17:04:18.271Z,1527613458.271 [DeadReckonUsingMultipleVelocitySources] Loaded
2018-05-29T1