2017-09-22T23:45:45.706Z,1506123945.706 [Supervisor](DEBUG): Initializing supervisor. 2017-09-22T23:45:45.709Z,1506123945.709 [SyncHandler](DEBUG): Created PCaller Thread at 4051A4E0 2017-09-22T23:45:45.709Z,1506123945.709 [SyncHandler](INFO): Protected caller Thread ID is 769 2017-09-22T23:45:45.710Z,1506123945.710 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2017-09-22T23:45:45.711Z,1506123945.711 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 4054A4E0 2017-09-22T23:45:45.711Z,1506123945.711 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 770 2017-09-22T23:45:45.714Z,1506123945.714 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2017-09-22T23:45:45.727Z,1506123945.727 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2017-09-22T23:45:45.728Z,1506123945.728 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 4057A4E0 2017-09-22T23:45:45.728Z,1506123945.728 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 771 2017-09-22T23:45:45.729Z,1506123945.729 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2017-09-22T23:45:45.730Z,1506123945.730 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405AA4E0 2017-09-22T23:45:45.730Z,1506123945.730 [logger ThreadHandler](INFO): Protected caller Thread ID is 772 2017-09-22T23:45:45.732Z,1506123945.732 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2017-09-22T23:45:45.733Z,1506123945.733 [Supervisor](INFO): Looking for Config files in directory: Config/ 2017-09-22T23:45:45.735Z,1506123945.735 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2017-09-22T23:45:45.927Z,1506123945.927 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2017-09-22T23:45:45.927Z,1506123945.927 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2017-09-22T23:45:46.062Z,1506123946.062 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2017-09-22T23:45:46.063Z,1506123946.063 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2017-09-22T23:45:46.404Z,1506123946.404 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2017-09-22T23:45:46.406Z,1506123946.406 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2017-09-22T23:45:46.547Z,1506123946.547 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2017-09-22T23:45:46.548Z,1506123946.548 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2017-09-22T23:45:46.634Z,1506123946.634 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2017-09-22T23:45:46.836Z,1506123946.836 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2017-09-22T23:45:46.837Z,1506123946.837 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2017-09-22T23:45:46.923Z,1506123946.923 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample 2017-09-22T23:45:46.924Z,1506123946.924 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2017-09-22T23:45:47.214Z,1506123947.214 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2017-09-22T23:45:47.215Z,1506123947.215 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2017-09-22T23:45:47.573Z,1506123947.573 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2017-09-22T23:45:47.574Z,1506123947.574 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2017-09-22T23:45:47.880Z,1506123947.880 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2017-09-22T23:45:47.881Z,1506123947.881 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2017-09-22T23:45:48.388Z,1506123948.388 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2017-09-22T23:45:52.987Z,1506123952.987 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2017-09-22T23:45:53.207Z,1506123953.207 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2017-09-22T23:45:53.208Z,1506123953.208 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2017-09-22T23:45:53.313Z,1506123953.313 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2017-09-22T23:45:53.313Z,1506123953.313 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2017-09-22T23:45:53.775Z,1506123953.775 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2017-09-22T23:45:53.776Z,1506123953.776 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2017-09-22T23:45:57.337Z,1506123957.337 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2017-09-22T23:45:57.339Z,1506123957.339 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-ahi/ 2017-09-22T23:45:57.341Z,1506123957.341 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Battery.cfg 2017-09-22T23:45:57.572Z,1506123957.572 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2017-09-22T23:45:57.573Z,1506123957.573 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/BIT.cfg 2017-09-22T23:45:57.676Z,1506123957.676 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Navigation.cfg 2017-09-22T23:45:57.784Z,1506123957.784 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Control.cfg 2017-09-22T23:45:57.886Z,1506123957.886 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Simulator.cfg 2017-09-22T23:45:57.977Z,1506123957.977 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Science.cfg 2017-09-22T23:45:58.129Z,1506123958.129 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Sensor.cfg 2017-09-22T23:45:58.302Z,1506123958.302 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Servo.cfg 2017-09-22T23:45:58.416Z,1506123958.416 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/logger.cfg 2017-09-22T23:45:58.517Z,1506123958.517 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/secure.cfg 2017-09-22T23:45:58.606Z,1506123958.606 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/vehicle.cfg 2017-09-22T23:45:58.776Z,1506123958.776 [Supervisor](FAULT): Ignoring configuration overrides from Data/persisted.cfg 2017-09-22T23:46:00.770Z,1506123960.770 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2017-09-22T23:46:00.942Z,1506123960.942 [SBIT](DEBUG): Construct Startup Built In Test. 2017-09-22T23:46:00.972Z,1506123960.972 [SBIT] Loaded 2017-09-22T23:46:00.972Z,1506123960.972 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2017-09-22T23:46:00.973Z,1506123960.973 [IBIT](DEBUG): Construct Initiated Built In Test. 2017-09-22T23:46:01.001Z,1506123961.001 [IBIT] Loaded 2017-09-22T23:46:01.001Z,1506123961.001 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2017-09-22T23:46:01.005Z,1506123961.005 [CBIT](DEBUG): Construct Continuous Built In Test. 2017-09-22T23:46:01.152Z,1506123961.152 [CBIT] Loaded 2017-09-22T23:46:01.152Z,1506123961.152 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2017-09-22T23:46:01.153Z,1506123961.153 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2017-09-22T23:46:01.153Z,1506123961.153 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2017-09-22T23:46:01.243Z,1506123961.243 [VerticalControl](DEBUG): Construct VerticalControl. 2017-09-22T23:46:01.341Z,1506123961.341 [VerticalControl] Loaded 2017-09-22T23:46:01.341Z,1506123961.341 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2017-09-22T23:46:01.342Z,1506123961.342 [HorizontalControl](DEBUG): Construct HorizontalControl. 2017-09-22T23:46:01.404Z,1506123961.404 [HorizontalControl] Loaded 2017-09-22T23:46:01.405Z,1506123961.405 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2017-09-22T23:46:01.405Z,1506123961.405 [SpeedControl](DEBUG): Construct SpeedControl. 2017-09-22T23:46:01.411Z,1506123961.411 [SpeedControl] Loaded 2017-09-22T23:46:01.411Z,1506123961.411 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2017-09-22T23:46:01.412Z,1506123961.412 [BackSeatDriver](DEBUG): Construct BackSeatDriver. 2017-09-22T23:46:01.414Z,1506123961.414 [BackSeatDriver] Loaded 2017-09-22T23:46:01.414Z,1506123961.414 [ComponentRegistry](DEBUG): SyncComponent "BackSeatDriver" handled in the control thread. 2017-09-22T23:46:01.415Z,1506123961.415 [LoopControl](DEBUG): Construct LoopControl. 2017-09-22T23:46:01.416Z,1506123961.416 [LoopControl] Loaded 2017-09-22T23:46:01.416Z,1506123961.416 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2017-09-22T23:46:01.416Z,1506123961.416 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2017-09-22T23:46:01.417Z,1506123961.417 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2017-09-22T23:46:01.456Z,1506123961.456 [DepthRateCalculator] Loaded 2017-09-22T23:46:01.457Z,1506123961.457 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2017-09-22T23:46:01.462Z,1506123961.462 [PitchRateCalculator] Loaded 2017-09-22T23:46:01.462Z,1506123961.462 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2017-09-22T23:46:01.478Z,1506123961.478 [SpeedCalculator] Loaded 2017-09-22T23:46:01.478Z,1506123961.478 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2017-09-22T23:46:01.499Z,1506123961.499 [TempGradientCalculator] Loaded 2017-09-22T23:46:01.500Z,1506123961.500 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread. 2017-09-22T23:46:01.515Z,1506123961.515 [VerticalTemperatureHomogeneityIndexCalculator] Loaded 2017-09-22T23:46:01.515Z,1506123961.515 [ComponentRegistry](DEBUG): SyncComponent "VerticalTemperatureHomogeneityIndexCalculator" handled in the control thread. 2017-09-22T23:46:01.520Z,1506123961.520 [YawRateCalculator] Loaded 2017-09-22T23:46:01.520Z,1506123961.520 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2017-09-22T23:46:01.521Z,1506123961.521 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2017-09-22T23:46:01.522Z,1506123961.522 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2017-09-22T23:46:01.639Z,1506123961.639 [StratificationFrontDetector](INFO): threshold set to: 0.399988 degC 2017-09-22T23:46:01.640Z,1506123961.640 [StratificationFrontDetector](DEBUG): (re)initializing 2017-09-22T23:46:01.640Z,1506123961.640 [StratificationFrontDetector] Loaded 2017-09-22T23:46:01.640Z,1506123961.640 [ComponentRegistry](DEBUG): SyncComponent "StratificationFrontDetector" handled in the control thread. 2017-09-22T23:46:01.641Z,1506123961.641 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2017-09-22T23:46:01.642Z,1506123961.642 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2017-09-22T23:46:01.907Z,1506123961.907 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2017-09-22T23:46:01.908Z,1506123961.908 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2017-09-22T23:46:02.025Z,1506123962.025 [DeadReckonUsingMultipleVelocitySources] Loaded 2017-09-22T23:46:02.025Z,1506123962.025 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2017-09-22T23:46:02.078Z,1506123962.078 [DeadReckonUsingSpeedCalculator] Loaded 2017-09-22T23:46:02.079Z,1506123962.079 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread. 2017-09-22T23:46:02.132Z,1506123962.132 [DeadReckonWithRespectToSeafloor] Loaded 2017-09-22T23:46:02.133Z,1506123962.133 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToSeafloor" handled in the control thread. 2017-09-22T23:46:02.149Z,1506123962.149 [NavChart] Loaded 2017-09-22T23:46:02.149Z,1506123962.149 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2017-09-22T23:46:02.153Z,1506123962.153 [UniversalFixResidualReporter] Loaded 2017-09-22T23:46:02.154Z,1506123962.154 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2017-09-22T23:46:02.154Z,1506123962.154 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2017-09-22T23:46:02.155Z,1506123962.155 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2017-09-22T23:46:02.164Z,1506123962.164 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2017-09-22T23:46:02.165Z,1506123962.165 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2017-09-22T23:46:02.346Z,1506123962.346 [Aanderaa_O2] Loaded 2017-09-22T23:46:02.346Z,1506123962.346 [ComponentRegistry](DEBUG): SyncComponent "Aanderaa_O2" handled in the control thread. 2017-09-22T23:46:02.381Z,1506123962.381 [CTD_Seabird] Loaded 2017-09-22T23:46:02.381Z,1506123962.381 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2017-09-22T23:46:02.382Z,1506123962.382 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 4077A4E0 2017-09-22T23:46:02.383Z,1506123962.383 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 851 2017-09-22T23:46:02.398Z,1506123962.398 [PAR_Licor] Loaded 2017-09-22T23:46:02.398Z,1506123962.398 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2017-09-22T23:46:02.446Z,1506123962.446 [WetLabsBB2FL] Loaded 2017-09-22T23:46:02.447Z,1506123962.447 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2017-09-22T23:46:02.448Z,1506123962.448 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 407AA4E0 2017-09-22T23:46:02.448Z,1506123962.448 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 852 2017-09-22T23:46:02.449Z,1506123962.449 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2017-09-22T23:46:02.449Z,1506123962.449 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2017-09-22T23:46:03.057Z,1506123963.057 [DataOverHttps] Loaded 2017-09-22T23:46:03.058Z,1506123963.058 [ComponentRegistry](DEBUG): SyncComponent "DataOverHttps" handled in the control thread. 2017-09-22T23:46:03.071Z,1506123963.071 [Depth_Keller] Loaded 2017-09-22T23:46:03.072Z,1506123963.072 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2017-09-22T23:46:03.077Z,1506123963.077 [DropWeight] Loaded 2017-09-22T23:46:03.077Z,1506123963.077 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2017-09-22T23:46:03.166Z,1506123963.166 [NAL9602] Loaded 2017-09-22T23:46:03.166Z,1506123963.166 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2017-09-22T23:46:03.175Z,1506123963.175 [Onboard] Loaded 2017-09-22T23:46:03.175Z,1506123963.175 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread. 2017-09-22T23:46:03.182Z,1506123963.182 [Radio_Surface] Loaded 2017-09-22T23:46:03.182Z,1506123963.182 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2017-09-22T23:46:03.184Z,1506123963.184 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409F54E0 2017-09-22T23:46:03.184Z,1506123963.184 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 853 2017-09-22T23:46:03.375Z,1506123963.375 [PNI_TCM] Loaded 2017-09-22T23:46:03.376Z,1506123963.376 [ComponentRegistry](DEBUG): SyncComponent "PNI_TCM" handled in the control thread. 2017-09-22T23:46:03.436Z,1506123963.436 [Rowe_600LCM] Loaded 2017-09-22T23:46:03.436Z,1506123963.436 [ComponentRegistry](DEBUG): Component "Rowe_600LCM" handled in its own thread. 2017-09-22T23:46:03.438Z,1506123963.438 [Rowe_600LCM ThreadHandler](DEBUG): Created PCaller Thread at 40A254E0 2017-09-22T23:46:03.438Z,1506123963.438 [Rowe_600LCM ThreadHandler](INFO): Protected caller Thread ID is 854