2018-01-14T07:35:15.717Z,1515915315.717 [Supervisor](DEBUG): Initializing supervisor. 2018-01-14T07:35:15.720Z,1515915315.720 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2018-01-14T07:35:15.720Z,1515915315.720 [SyncHandler](INFO): Protected caller Thread ID is 801 2018-01-14T07:35:15.721Z,1515915315.721 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2018-01-14T07:35:15.722Z,1515915315.722 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2018-01-14T07:35:15.722Z,1515915315.722 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 802 2018-01-14T07:35:15.724Z,1515915315.724 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2018-01-14T07:35:15.735Z,1515915315.735 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2018-01-14T07:35:15.736Z,1515915315.736 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2018-01-14T07:35:15.737Z,1515915315.737 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 803 2018-01-14T07:35:15.737Z,1515915315.737 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2018-01-14T07:35:15.738Z,1515915315.738 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2018-01-14T07:35:15.739Z,1515915315.739 [logger ThreadHandler](INFO): Protected caller Thread ID is 804 2018-01-14T07:35:15.741Z,1515915315.741 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2018-01-14T07:35:15.741Z,1515915315.741 [Supervisor](INFO): Looking for Config files in directory: Config/ 2018-01-14T07:35:15.746Z,1515915315.746 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2018-01-14T07:35:15.922Z,1515915315.922 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2018-01-14T07:35:15.922Z,1515915315.922 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2018-01-14T07:35:16.056Z,1515915316.056 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2018-01-14T07:35:16.058Z,1515915316.058 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2018-01-14T07:35:16.365Z,1515915316.365 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2018-01-14T07:35:16.366Z,1515915316.366 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2018-01-14T07:35:16.496Z,1515915316.496 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2018-01-14T07:35:16.498Z,1515915316.498 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2018-01-14T07:35:16.578Z,1515915316.578 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2018-01-14T07:35:16.767Z,1515915316.767 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2018-01-14T07:35:16.769Z,1515915316.769 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2018-01-14T07:35:16.865Z,1515915316.865 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample 2018-01-14T07:35:16.866Z,1515915316.866 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2018-01-14T07:35:17.175Z,1515915317.175 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2018-01-14T07:35:17.176Z,1515915317.176 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2018-01-14T07:35:17.514Z,1515915317.514 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2018-01-14T07:35:17.515Z,1515915317.515 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2018-01-14T07:35:17.794Z,1515915317.794 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2018-01-14T07:35:17.795Z,1515915317.795 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2018-01-14T07:35:18.268Z,1515915318.268 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2018-01-14T07:35:18.269Z,1515915318.269 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2018-01-14T07:35:18.461Z,1515915318.461 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2018-01-14T07:35:18.461Z,1515915318.461 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2018-01-14T07:35:18.557Z,1515915318.557 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2018-01-14T07:35:18.558Z,1515915318.558 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2018-01-14T07:35:19.002Z,1515915319.002 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2018-01-14T07:35:19.004Z,1515915319.004 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2018-01-14T07:35:19.116Z,1515915319.116 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2018-01-14T07:35:19.118Z,1515915319.118 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-ahi/ 2018-01-14T07:35:23.364Z,1515915323.364 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Battery.cfg 2018-01-14T07:35:23.642Z,1515915323.642 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2018-01-14T07:35:23.643Z,1515915323.643 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/BIT.cfg 2018-01-14T07:35:23.739Z,1515915323.739 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Navigation.cfg 2018-01-14T07:35:23.840Z,1515915323.840 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Control.cfg 2018-01-14T07:35:23.935Z,1515915323.935 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Simulator.cfg 2018-01-14T07:35:24.021Z,1515915324.021 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Science.cfg 2018-01-14T07:35:25.890Z,1515915325.890 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Sensor.cfg 2018-01-14T07:35:26.051Z,1515915326.051 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Servo.cfg 2018-01-14T07:35:26.156Z,1515915326.156 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/logger.cfg 2018-01-14T07:35:26.251Z,1515915326.251 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/secure.cfg 2018-01-14T07:35:26.334Z,1515915326.334 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/vehicle.cfg 2018-01-14T07:35:26.491Z,1515915326.491 [Supervisor](FAULT): Ignoring configuration overrides from Data/persisted.cfg 2018-01-14T07:35:26.494Z,1515915326.494 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2018-01-14T07:35:26.645Z,1515915326.645 [SBIT](DEBUG): Construct Startup Built In Test. 2018-01-14T07:35:26.674Z,1515915326.674 [SBIT] Loaded 2018-01-14T07:35:26.675Z,1515915326.675 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2018-01-14T07:35:26.675Z,1515915326.675 [IBIT](DEBUG): Construct Initiated Built In Test. 2018-01-14T07:35:26.702Z,1515915326.702 [IBIT] Loaded 2018-01-14T07:35:26.702Z,1515915326.702 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2018-01-14T07:35:26.705Z,1515915326.705 [CBIT](DEBUG): Construct Continuous Built In Test. 2018-01-14T07:35:26.854Z,1515915326.854 [CBIT] Loaded 2018-01-14T07:35:26.854Z,1515915326.854 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2018-01-14T07:35:26.855Z,1515915326.855 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2018-01-14T07:35:26.857Z,1515915326.857 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2018-01-14T07:35:26.943Z,1515915326.943 [VerticalControl](DEBUG): Construct VerticalControl. 2018-01-14T07:35:27.039Z,1515915327.039 [VerticalControl] Loaded 2018-01-14T07:35:27.040Z,1515915327.040 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2018-01-14T07:35:27.040Z,1515915327.040 [HorizontalControl](DEBUG): Construct HorizontalControl. 2018-01-14T07:35:27.100Z,1515915327.100 [HorizontalControl] Loaded 2018-01-14T07:35:27.100Z,1515915327.100 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2018-01-14T07:35:27.100Z,1515915327.100 [SpeedControl](DEBUG): Construct SpeedControl. 2018-01-14T07:35:27.106Z,1515915327.106 [SpeedControl] Loaded 2018-01-14T07:35:27.106Z,1515915327.106 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2018-01-14T07:35:27.107Z,1515915327.107 [LoopControl](DEBUG): Construct LoopControl. 2018-01-14T07:35:27.107Z,1515915327.107 [LoopControl] Loaded 2018-01-14T07:35:27.108Z,1515915327.108 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2018-01-14T07:35:27.108Z,1515915327.108 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2018-01-14T07:35:27.110Z,1515915327.110 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2018-01-14T07:35:27.164Z,1515915327.164 [DepthRateCalculator] Loaded 2018-01-14T07:35:27.165Z,1515915327.165 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2018-01-14T07:35:27.170Z,1515915327.170 [PitchRateCalculator] Loaded 2018-01-14T07:35:27.170Z,1515915327.170 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2018-01-14T07:35:27.186Z,1515915327.186 [SpeedCalculator] Loaded 2018-01-14T07:35:27.186Z,1515915327.186 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2018-01-14T07:35:27.206Z,1515915327.206 [TempGradientCalculator] Loaded 2018-01-14T07:35:27.207Z,1515915327.207 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread. 2018-01-14T07:35:27.221Z,1515915327.221 [VerticalTemperatureHomogeneityIndexCalculator] Loaded 2018-01-14T07:35:27.222Z,1515915327.222 [ComponentRegistry](DEBUG): SyncComponent "VerticalTemperatureHomogeneityIndexCalculator" handled in the control thread. 2018-01-14T07:35:27.226Z,1515915327.226 [YawRateCalculator] Loaded 2018-01-14T07:35:27.227Z,1515915327.227 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2018-01-14T07:35:27.227Z,1515915327.227 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2018-01-14T07:35:27.229Z,1515915327.229 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2018-01-14T07:35:27.348Z,1515915327.348 [StratificationFrontDetector](INFO): threshold set to: 0.399988 degC 2018-01-14T07:35:27.348Z,1515915327.348 [StratificationFrontDetector](DEBUG): (re)initializing 2018-01-14T07:35:27.349Z,1515915327.349 [StratificationFrontDetector] Loaded 2018-01-14T07:35:27.349Z,1515915327.349 [ComponentRegistry](DEBUG): SyncComponent "StratificationFrontDetector" handled in the control thread. 2018-01-14T07:35:27.350Z,1515915327.350 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2018-01-14T07:35:27.350Z,1515915327.350 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2018-01-14T07:35:27.619Z,1515915327.619 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2018-01-14T07:35:27.621Z,1515915327.621 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2018-01-14T07:35:27.732Z,1515915327.732 [DeadReckonUsingMultipleVelocitySources] Loaded 2018-01-14T07:35:27.732Z,1515915327.732 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2018-01-14T07:35:27.784Z,1515915327.784 [DeadReckonUsingSpeedCalculator] Loaded 2018-01-14T07:35:27.785Z,1515915327.785 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread. 2018-01-14T07:35:27.837Z,1515915327.837 [DeadReckonWithRespectToSeafloor] Loaded 2018-01-14T07:35:27.837Z,1515915327.837 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToSeafloor" handled in the control thread. 2018-01-14T07:35:27.853Z,1515915327.853 [NavChart] Loaded 2018-01-14T07:35:27.853Z,1515915327.853 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2018-01-14T07:35:27.857Z,1515915327.857 [UniversalFixResidualReporter] Loaded 2018-01-14T07:35:27.857Z,1515915327.857 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2018-01-14T07:35:27.858Z,1515915327.858 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2018-01-14T07:35:27.858Z,1515915327.858 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2018-01-14T07:35:27.883Z,1515915327.883 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2018-01-14T07:35:27.883Z,1515915327.883 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2018-01-14T07:35:28.077Z,1515915328.077 [Aanderaa_O2] Loaded 2018-01-14T07:35:28.078Z,1515915328.078 [ComponentRegistry](DEBUG): SyncComponent "Aanderaa_O2" handled in the control thread. 2018-01-14T07:35:28.123Z,1515915328.123 [CTD_Seabird] Loaded 2018-01-14T07:35:28.124Z,1515915328.124 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2018-01-14T07:35:28.125Z,1515915328.125 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 406D34E0 2018-01-14T07:35:28.125Z,1515915328.125 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 883 2018-01-14T07:35:28.139Z,1515915328.139 [PAR_Licor] Loaded 2018-01-14T07:35:28.140Z,1515915328.139 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2018-01-14T07:35:28.187Z,1515915328.187 [WetLabsBB2FL] Loaded 2018-01-14T07:35:28.187Z,1515915328.187 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2018-01-14T07:35:28.188Z,1515915328.188 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 407034E0 2018-01-14T07:35:28.189Z,1515915328.189 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 884 2018-01-14T07:35:28.231Z,1515915328.231 [WetLabsSeaOWL_UV_A] Loaded 2018-01-14T07:35:28.231Z,1515915328.231 [ComponentRegistry](DEBUG): Component "WetLabsSeaOWL_UV_A" handled in its own thread. 2018-01-14T07:35:28.232Z,1515915328.232 [WetLabsSeaOWL_UV_A ThreadHandler](DEBUG): Created PCaller Thread at 407334E0 2018-01-14T07:35:28.232Z,1515915328.232 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Protected caller Thread ID is 885 2018-01-14T07:35:28.233Z,1515915328.233 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2018-01-14T07:35:28.233Z,1515915328.233 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2018-01-14T07:35:28.755Z,1515915328.755 [DataOverHttps] Loaded 2018-01-14T07:35:28.755Z,1515915328.755 [ComponentRegistry](DEBUG): SyncComponent "DataOverHttps" handled in the control thread. 2018-01-14T07:35:28.768Z,1515915328.768 [Depth_Keller] Loaded 2018-01-14T07:35:28.768Z,1515915328.768 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2018-01-14T07:35:28.773Z,1515915328.773 [DropWeight] Loaded 2018-01-14T07:35:28.773Z,1515915328.773 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2018-01-14T07:35:28.861Z,1515915328.861 [NAL9602] Loaded 2018-01-14T07:35:28.861Z,1515915328.861 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2018-01-14T07:35:28.866Z,1515915328.866 [Onboard] Loaded 2018-01-14T07:35:28.867Z,1515915328.867 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread. 2018-01-14T07:35:28.873Z,1515915328.873 [Radio_Surface] Loaded 2018-01-14T07:35:28.874Z,1515915328.874 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2018-01-14T07:35:28.875Z,1515915328.875 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409774E0 2018-01-14T07:35:28.875Z,1515915328.875 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 886 2018-01-14T07:35:28.993Z,1515915328.993 [DAT] Loaded 2018-01-14T07:35:28.994Z,1515915328.994 [ComponentRegistry](DEBUG): SyncComponent "DAT" handled in the control thread. 2018-01-14T07:35:29.171Z,1515915329.171 [PNI_TCM] Loaded 2018-01-14T07:35:29.171Z,1515915329.171 [ComponentRegistry](DEBUG): SyncComponent "PNI_TCM" handled in the control thread. 2018-01-14T07:35:29.230Z,1515915329.230 [Rowe_600LCM] Loaded 2018-01-14T07:35:29.230