2017-09-08T22:42:26.525Z,1504910546.525 [Supervisor](DEBUG): Initializing supervisor. 2017-09-08T22:42:26.530Z,1504910546.530 [SyncHandler](DEBUG): Created PCaller Thread at 4051A4E0 2017-09-08T22:42:26.531Z,1504910546.531 [SyncHandler](INFO): Protected caller Thread ID is 1575 2017-09-08T22:42:26.532Z,1504910546.532 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2017-09-08T22:42:26.533Z,1504910546.533 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 4054A4E0 2017-09-08T22:42:26.534Z,1504910546.534 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 1576 2017-09-08T22:42:26.537Z,1504910546.537 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2017-09-08T22:42:26.553Z,1504910546.553 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2017-09-08T22:42:26.554Z,1504910546.554 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 4057A4E0 2017-09-08T22:42:26.554Z,1504910546.554 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 1577 2017-09-08T22:42:26.555Z,1504910546.555 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2017-09-08T22:42:26.556Z,1504910546.556 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405AA4E0 2017-09-08T22:42:26.557Z,1504910546.557 [logger ThreadHandler](INFO): Protected caller Thread ID is 1578 2017-09-08T22:42:26.559Z,1504910546.559 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2017-09-08T22:42:26.560Z,1504910546.560 [Supervisor](INFO): Looking for Config files in directory: Config/ 2017-09-08T22:42:26.561Z,1504910546.561 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2017-09-08T22:42:26.763Z,1504910546.763 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2017-09-08T22:42:26.764Z,1504910546.764 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2017-09-08T22:42:26.904Z,1504910546.904 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2017-09-08T22:42:26.905Z,1504910546.905 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2017-09-08T22:42:27.280Z,1504910547.280 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2017-09-08T22:42:27.281Z,1504910547.281 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2017-09-08T22:42:27.431Z,1504910547.431 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2017-09-08T22:42:27.432Z,1504910547.432 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2017-09-08T22:42:27.516Z,1504910547.516 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2017-09-08T22:42:27.736Z,1504910547.736 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2017-09-08T22:42:27.737Z,1504910547.737 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2017-09-08T22:42:27.845Z,1504910547.845 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample 2017-09-08T22:42:27.845Z,1504910547.845 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2017-09-08T22:42:28.175Z,1504910548.175 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2017-09-08T22:42:28.176Z,1504910548.176 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2017-09-08T22:42:28.597Z,1504910548.597 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2017-09-08T22:42:28.598Z,1504910548.598 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2017-09-08T22:42:29.098Z,1504910549.098 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2017-09-08T22:42:29.099Z,1504910549.099 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2017-09-08T22:42:29.707Z,1504910549.707 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2017-09-08T22:42:29.707Z,1504910549.707 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2017-09-08T22:42:29.915Z,1504910549.915 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2017-09-08T22:42:29.916Z,1504910549.916 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2017-09-08T22:42:30.021Z,1504910550.021 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2017-09-08T22:42:30.022Z,1504910550.022 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2017-09-08T22:42:30.567Z,1504910550.567 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2017-09-08T22:42:30.567Z,1504910550.567 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2017-09-08T22:42:30.684Z,1504910550.684 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2017-09-08T22:42:30.686Z,1504910550.686 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-daphne/ 2017-09-08T22:42:30.686Z,1504910550.686 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Battery.cfg 2017-09-08T22:42:30.985Z,1504910550.985 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2017-09-08T22:42:30.986Z,1504910550.986 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/BIT.cfg 2017-09-08T22:42:31.092Z,1504910551.092 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Navigation.cfg 2017-09-08T22:42:31.188Z,1504910551.188 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Control.cfg 2017-09-08T22:42:31.296Z,1504910551.296 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Simulator.cfg 2017-09-08T22:42:31.387Z,1504910551.387 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Science.cfg 2017-09-08T22:42:31.523Z,1504910551.523 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Sensor.cfg 2017-09-08T22:42:31.691Z,1504910551.691 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Servo.cfg 2017-09-08T22:42:31.793Z,1504910551.793 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/logger.cfg 2017-09-08T22:42:31.890Z,1504910551.890 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/secure.cfg 2017-09-08T22:42:31.977Z,1504910551.977 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/vehicle.cfg 2017-09-08T22:42:32.171Z,1504910552.171 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/workSite.cfg 2017-09-08T22:42:32.252Z,1504910552.252 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-daphne/root/ 2017-09-08T22:42:32.253Z,1504910552.253 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg 2017-09-08T22:42:32.262Z,1504910552.262 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2017-09-08T22:42:32.389Z,1504910552.389 [SBIT](DEBUG): Construct Startup Built In Test. 2017-09-08T22:42:32.426Z,1504910552.426 [SBIT] Loaded 2017-09-08T22:42:32.426Z,1504910552.426 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2017-09-08T22:42:32.427Z,1504910552.427 [IBIT](DEBUG): Construct Initiated Built In Test. 2017-09-08T22:42:32.463Z,1504910552.463 [IBIT] Loaded 2017-09-08T22:42:32.463Z,1504910552.463 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2017-09-08T22:42:32.468Z,1504910552.468 [CBIT](DEBUG): Construct Continuous Built In Test. 2017-09-08T22:42:32.664Z,1504910552.664 [CBIT] Loaded 2017-09-08T22:42:32.665Z,1504910552.665 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2017-09-08T22:42:32.665Z,1504910552.665 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2017-09-08T22:42:32.666Z,1504910552.666 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2017-09-08T22:42:32.733Z,1504910552.733 [VerticalControl](DEBUG): Construct VerticalControl. 2017-09-08T22:42:32.854Z,1504910552.854 [VerticalControl] Loaded 2017-09-08T22:42:32.854Z,1504910552.854 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2017-09-08T22:42:32.855Z,1504910552.855 [HorizontalControl](DEBUG): Construct HorizontalControl. 2017-09-08T22:42:32.933Z,1504910552.933 [HorizontalControl] Loaded 2017-09-08T22:42:32.933Z,1504910552.933 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2017-09-08T22:42:32.934Z,1504910552.934 [SpeedControl](DEBUG): Construct SpeedControl. 2017-09-08T22:42:32.941Z,1504910552.941 [SpeedControl] Loaded 2017-09-08T22:42:32.942Z,1504910552.942 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2017-09-08T22:42:32.943Z,1504910552.943 [LoopControl](DEBUG): Construct LoopControl. 2017-09-08T22:42:32.943Z,1504910552.943 [LoopControl] Loaded 2017-09-08T22:42:32.944Z,1504910552.944 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2017-09-08T22:42:32.944Z,1504910552.944 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2017-09-08T22:42:32.945Z,1504910552.945 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2017-09-08T22:42:32.971Z,1504910552.971 [DepthRateCalculator] Loaded 2017-09-08T22:42:32.971Z,1504910552.971 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2017-09-08T22:42:32.977Z,1504910552.977 [PitchRateCalculator] Loaded 2017-09-08T22:42:32.978Z,1504910552.978 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2017-09-08T22:42:32.997Z,1504910552.997 [SpeedCalculator] Loaded 2017-09-08T22:42:32.997Z,1504910552.997 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2017-09-08T22:42:33.023Z,1504910553.023 [TempGradientCalculator] Loaded 2017-09-08T22:42:33.024Z,1504910553.024 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread. 2017-09-08T22:42:33.043Z,1504910553.043 [VerticalTemperatureHomogeneityIndexCalculator] Loaded 2017-09-08T22:42:33.043Z,1504910553.043 [ComponentRegistry](DEBUG): SyncComponent "VerticalTemperatureHomogeneityIndexCalculator" handled in the control thread. 2017-09-08T22:42:33.049Z,1504910553.049 [YawRateCalculator] Loaded 2017-09-08T22:42:33.050Z,1504910553.050 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2017-09-08T22:42:33.050Z,1504910553.050 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2017-09-08T22:42:33.051Z,1504910553.051 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2017-09-08T22:42:33.136Z,1504910553.136 [StratificationFrontDetector](INFO): threshold set to: 0.399988 degC 2017-09-08T22:42:33.136Z,1504910553.136 [StratificationFrontDetector](DEBUG): (re)initializing 2017-09-08T22:42:33.137Z,1504910553.137 [StratificationFrontDetector] Loaded 2017-09-08T22:42:33.137Z,1504910553.137 [ComponentRegistry](DEBUG): SyncComponent "StratificationFrontDetector" handled in the control thread. 2017-09-08T22:42:33.138Z,1504910553.138 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2017-09-08T22:42:33.139Z,1504910553.139 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2017-09-08T22:42:33.370Z,1504910553.370 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2017-09-08T22:42:33.370Z,1504910553.370 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2017-09-08T22:42:33.485Z,1504910553.485 [DeadReckonUsingMultipleVelocitySources] Loaded 2017-09-08T22:42:33.485Z,1504910553.485 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2017-09-08T22:42:33.554Z,1504910553.554 [DeadReckonUsingSpeedCalculator] Loaded 2017-09-08T22:42:33.555Z,1504910553.555 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread. 2017-09-08T22:42:33.576Z,1504910553.576 [NavChart] Loaded 2017-09-08T22:42:33.576Z,1504910553.576 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2017-09-08T22:42:33.581Z,1504910553.581 [UniversalFixResidualReporter] Loaded 2017-09-08T22:42:33.582Z,1504910553.582 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2017-09-08T22:42:33.582Z,1504910553.582 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2017-09-08T22:42:33.583Z,1504910553.583 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2017-09-08T22:42:33.597Z,1504910553.597 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2017-09-08T22:42:33.597Z,1504910553.597 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2017-09-08T22:42:33.749Z,1504910553.749 [Aanderaa_O2] Loaded 2017-09-08T22:42:33.749Z,1504910553.749 [ComponentRegistry](DEBUG): SyncComponent "Aanderaa_O2" handled in the control thread. 2017-09-08T22:42:33.856Z,1504910553.856 [CTD_NeilBrown] Loaded 2017-09-08T22:42:33.856Z,1504910553.856 [ComponentRegistry](DEBUG): Component "CTD_NeilBrown" handled in its own thread. 2017-09-08T22:42:33.858Z,1504910553.858 [CTD_NeilBrown ThreadHandler](DEBUG): Created PCaller Thread at 4081C4E0 2017-09-08T22:42:33.858Z,1504910553.858 [CTD_NeilBrown ThreadHandler](INFO): Protected caller Thread ID is 1660 2017-09-08T22:42:33.877Z,1504910553.877 [PAR_Licor] Loaded 2017-09-08T22:42:33.877Z,1504910553.877 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2017-09-08T22:42:33.936Z,1504910553.936 [WetLabsBB2FL] Loaded 2017-09-08T22:42:33.936Z,1504910553.936 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2017-09-08T22:42:33.937Z,1504910553.937 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 4084C4E0 2017-09-08T22:42:33.938Z,1504910553.938 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 1661 2017-09-08T22:42:33.938Z,1504910553.938 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2017-09-08T22:42:33.939Z,1504910553.939 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2017-09-08T22:42:34.210Z,1504910554.210 [DataOverHttps] Loaded 2017-09-08T22:42:34.211Z,1504910554.211 [ComponentRegistry](DEBUG): SyncComponent "DataOverHttps" handled in the control thread. 2017-09-08T22:42:34.228Z,1504910554.228 [Depth_Keller] Loaded 2017-09-08T22:42:34.228Z,1504910554.228 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2017-09-08T22:42:34.235Z,1504910554.235 [DropWeight] Loaded 2017-09-08T22:42:34.235Z,1504910554.235 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2017-09-08T22:42:34.348Z,1504910554.348 [NAL9602] Loaded 2017-09-08T22:42:34.348Z,1504910554.348 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2017-09-08T22:42:34.360Z,1504910554.360 [Onboard] Loaded 2017-09-08T22:42:34.360Z,1504910554.360 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread. 2017-09-08T22:42:34.369Z,1504910554.369 [Radio_Surface] Loaded 2017-09-08T22:42:34.370Z,1504910554.370 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2017-09-08T22:42:34.371Z,1504910554.371 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 40AD24E0 2017-09-08T22:42:34.371Z,1504910554.371 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 1662 2017-09-08T22:42:34.431Z,1504910554.431 [PNI_TCM] Loaded 2017-09-08T22:42:34.431Z,1504910554.431 [ComponentRegistry](DEBUG): SyncComponent "PNI_TCM" handled in the control thread. 2017-09-08T22:42:36.936Z,1504910556.936 [BPC1] Loaded 2017-09-08T22:42:36.936Z,1504910556.936 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2017-09-08T22:42:36.937Z,1504910556.937 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2017-09-08T22:42:36.937Z,1504910556.937 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2017-09-08T22:42:37.039Z,1504910557.039 [BuoyancyServo] Loaded 2017-09-08T22:42:37.039Z,1504910557.039 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2017-09-08T22:42:37.054Z,1504910