2017-04-18T23:07:38.668Z,1492556858.668 [Supervisor](DEBUG): Initializing supervisor.
2017-04-18T23:07:38.671Z,1492556858.671 [SyncHandler](DEBUG): Created PCaller Thread at 4051A4E0
2017-04-18T23:07:38.671Z,1492556858.671 [SyncHandler](INFO): Protected caller Thread ID is 770
2017-04-18T23:07:38.672Z,1492556858.672 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2017-04-18T23:07:38.673Z,1492556858.673 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 4054A4E0
2017-04-18T23:07:38.673Z,1492556858.673 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 771
2017-04-18T23:07:38.676Z,1492556858.676 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2017-04-18T23:07:38.688Z,1492556858.688 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2017-04-18T23:07:38.689Z,1492556858.689 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 4057A4E0
2017-04-18T23:07:38.689Z,1492556858.690 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 772
2017-04-18T23:07:38.690Z,1492556858.690 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2017-04-18T23:07:38.691Z,1492556858.691 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405AA4E0
2017-04-18T23:07:38.692Z,1492556858.692 [logger ThreadHandler](INFO): Protected caller Thread ID is 773
2017-04-18T23:07:38.694Z,1492556858.694 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2017-04-18T23:07:38.694Z,1492556858.694 [Supervisor](INFO): Looking for Config files in directory: Config/
2017-04-18T23:07:38.698Z,1492556858.698 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2017-04-18T23:07:38.786Z,1492556858.786 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2017-04-18T23:07:39.113Z,1492556859.113 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2017-04-18T23:07:39.115Z,1492556859.115 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2017-04-18T23:07:39.249Z,1492556859.249 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2017-04-18T23:07:39.250Z,1492556859.250 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2017-04-18T23:07:39.450Z,1492556859.450 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2017-04-18T23:07:39.451Z,1492556859.451 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2017-04-18T23:07:39.552Z,1492556859.552 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2017-04-18T23:07:39.554Z,1492556859.554 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2017-04-18T23:07:39.750Z,1492556859.750 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2017-04-18T23:07:39.752Z,1492556859.752 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2017-04-18T23:07:40.221Z,1492556860.221 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2017-04-18T23:07:40.222Z,1492556860.222 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2017-04-18T23:07:40.509Z,1492556860.509 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2017-04-18T23:07:40.510Z,1492556860.510 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2017-04-18T23:07:40.597Z,1492556860.597 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2017-04-18T23:07:40.598Z,1492556860.598 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2017-04-18T23:07:40.740Z,1492556860.740 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2017-04-18T23:07:40.741Z,1492556860.741 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2017-04-18T23:07:40.939Z,1492556860.940 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2017-04-18T23:07:40.940Z,1492556860.940 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2017-04-18T23:07:41.382Z,1492556861.382 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2017-04-18T23:07:41.383Z,1492556861.383 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2017-04-18T23:07:46.473Z,1492556866.473 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2017-04-18T23:07:46.473Z,1492556866.473 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2017-04-18T23:07:46.824Z,1492556866.824 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2017-04-18T23:07:46.825Z,1492556866.825 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2017-04-18T23:07:46.937Z,1492556866.937 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2017-04-18T23:07:46.939Z,1492556866.940 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-opah/
2017-04-18T23:07:46.943Z,1492556866.944 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/secure.cfg
2017-04-18T23:07:47.032Z,1492556867.032 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/vehicle.cfg
2017-04-18T23:07:47.200Z,1492556867.200 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Battery.cfg
2017-04-18T23:07:47.437Z,1492556867.437 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2017-04-18T23:07:47.438Z,1492556867.438 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Control.cfg
2017-04-18T23:07:47.541Z,1492556867.541 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/BIT.cfg
2017-04-18T23:07:47.656Z,1492556867.656 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Navigation.cfg
2017-04-18T23:07:47.766Z,1492556867.766 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Science.cfg
2017-04-18T23:07:47.918Z,1492556867.918 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Sensor.cfg
2017-04-18T23:07:48.091Z,1492556868.091 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Servo.cfg
2017-04-18T23:07:48.205Z,1492556868.205 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/Simulator.cfg
2017-04-18T23:07:48.296Z,1492556868.296 [Supervisor](INFO): Opening Config file at: Config/lrauv-opah/logger.cfg
2017-04-18T23:07:48.399Z,1492556868.399 [Supervisor](FAULT): Ignoring configuration overrides from Data/persisted.cfg
2017-04-18T23:07:48.403Z,1492556868.404 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2017-04-18T23:07:48.446Z,1492556868.446 [DepthRateCalculator] Loaded
2017-04-18T23:07:48.446Z,1492556868.446 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2017-04-18T23:07:48.452Z,1492556868.452 [PitchRateCalculator] Loaded
2017-04-18T23:07:48.453Z,1492556868.453 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2017-04-18T23:07:48.465Z,1492556868.465 [SpeedCalculator] Loaded
2017-04-18T23:07:48.465Z,1492556868.465 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2017-04-18T23:07:48.487Z,1492556868.487 [TempGradientCalculator] Loaded
2017-04-18T23:07:48.487Z,1492556868.487 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2017-04-18T23:07:48.503Z,1492556868.503 [VerticalTemperatureHomogeneityIndexCalculator] Loaded
2017-04-18T23:07:48.503Z,1492556868.503 [ComponentRegistry](DEBUG): SyncComponent "VerticalTemperatureHomogeneityIndexCalculator" handled in the control thread.
2017-04-18T23:07:48.509Z,1492556868.509 [YawRateCalculator] Loaded
2017-04-18T23:07:48.509Z,1492556868.509 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2017-04-18T23:07:48.510Z,1492556868.510 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2017-04-18T23:07:48.510Z,1492556868.510 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2017-04-18T23:07:48.633Z,1492556868.634 [DeadReckonUsingMultipleVelocitySources] Loaded
2017-04-18T23:07:48.634Z,1492556868.634 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2017-04-18T23:07:48.688Z,1492556868.688 [DeadReckonUsingSpeedCalculator] Loaded
2017-04-18T23:07:48.688Z,1492556868.688 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2017-04-18T23:07:48.743Z,1492556868.743 [DeadReckonWithRespectToSeafloor] Loaded
2017-04-18T23:07:48.744Z,1492556868.744 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToSeafloor" handled in the control thread.
2017-04-18T23:07:48.760Z,1492556868.760 [NavChart] Loaded
2017-04-18T23:07:48.760Z,1492556868.760 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2017-04-18T23:07:48.764Z,1492556868.764 [UniversalFixResidualReporter] Loaded
2017-04-18T23:07:48.765Z,1492556868.765 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2017-04-18T23:07:48.765Z,1492556868.765 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2017-04-18T23:07:48.766Z,1492556868.766 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2017-04-18T23:07:48.958Z,1492556868.958 [Aanderaa_O2] Loaded
2017-04-18T23:07:48.959Z,1492556868.959 [ComponentRegistry](DEBUG): SyncComponent "Aanderaa_O2" handled in the control thread.
2017-04-18T23:07:48.974Z,1492556868.974 [PAR_Licor] Loaded
2017-04-18T23:07:48.974Z,1492556868.974 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2017-04-18T23:07:49.025Z,1492556869.025 [WetLabsBB2FL] Loaded
2017-04-18T23:07:49.025Z,1492556869.025 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2017-04-18T23:07:49.026Z,1492556869.026 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 4066F4E0
2017-04-18T23:07:49.026Z,1492556869.026 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 852
2017-04-18T23:07:49.027Z,1492556869.027 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2017-04-18T23:07:49.028Z,1492556869.028 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2017-04-18T23:07:49.068Z,1492556869.068 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2017-04-18T23:07:49.069Z,1492556869.069 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2017-04-18T23:07:49.078Z,1492556869.078 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2017-04-18T23:07:49.079Z,1492556869.079 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2017-04-18T23:07:49.360Z,1492556869.360 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2017-04-18T23:07:49.361Z,1492556869.361 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2017-04-18T23:07:49.519Z,1492556869.519 [SBIT](DEBUG): Construct Startup Built In Test.
2017-04-18T23:07:49.550Z,1492556869.550 [SBIT] Loaded
2017-04-18T23:07:49.551Z,1492556869.551 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2017-04-18T23:07:49.552Z,1492556869.552 [IBIT](DEBUG): Construct Initiated Built In Test.
2017-04-18T23:07:49.579Z,1492556869.579 [IBIT] Loaded
2017-04-18T23:07:49.580Z,1492556869.579 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2017-04-18T23:07:49.583Z,1492556869.583 [CBIT](DEBUG): Construct Continuous Built In Test.
2017-04-18T23:07:49.737Z,1492556869.737 [CBIT] Loaded
2017-04-18T23:07:49.737Z,1492556869.737 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2017-04-18T23:07:49.737Z,1492556869.737 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2017-04-18T23:07:49.738Z,1492556869.738 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2017-04-18T23:07:50.357Z,1492556870.357 [DataOverHttps] Loaded
2017-04-18T23:07:50.357Z,1492556870.357 [ComponentRegistry](DEBUG): SyncComponent "DataOverHttps" handled in the control thread.
2017-04-18T23:07:50.371Z,1492556870.372 [Depth_Keller] Loaded
2017-04-18T23:07:50.372Z,1492556870.372 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2017-04-18T23:07:50.377Z,1492556870.377 [DropWeight] Loaded
2017-04-18T23:07:50.377Z,1492556870.377 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2017-04-18T23:07:50.471Z,1492556870.471 [NAL9602] Loaded
2017-04-18T23:07:50.472Z,1492556870.471 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2017-04-18T23:07:50.481Z,1492556870.481 [Onboard] Loaded
2017-04-18T23:07:50.481Z,1492556870.481 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2017-04-18T23:07:50.488Z,1492556870.488 [Radio_Surface] Loaded
2017-04-18T23:07:50.489Z,1492556870.489 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2017-04-18T23:07:50.490Z,1492556870.490 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409604E0
2017-04-18T23:07:50.490Z,1492556870.490 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 853
2017-04-18T23:07:50.626Z,1492556870.626 [DAT] Loaded
2017-04-18T23:07:50.626Z,1492556870.626 [ComponentRegistry](DEBUG): SyncComponent "DAT" handled in the control thread.
2017-04-18T23:07:50.633Z,1492556870.633 [SCPI] Loaded
2017-04-18T23:07:50.633Z,1492556870.633 [ComponentRegistry](DEBUG): SyncComponent "SCPI" handled in the control thread.
2017-04-18T23:07:50.826Z,1492556870.826 [PNI_TCM] Loaded
2017-04-18T23:07:50.826Z,1492556870.826 [ComponentRegistry](DEBUG): SyncComponent "PNI_TCM" handled in the control thread.
2017-04-18T23:07:51.184Z,1492556871.184 [Rowe_600LCM] Loaded
2017-04-18T23:07:51.184Z,1492556871.184 [ComponentRegistry](DEBUG): Component "Rowe_600LCM" handled in its own thread.
2017-04-18T23:07:51.185Z,1492556871.185 [Rowe_600LCM ThreadHandler](DEBUG): Created PCaller Thread at 409904E0
2017-04-18T23:07:51.185Z,1492556871.185 [Rowe_600LCM ThreadHandler](INFO): Protected caller Thread ID is 854
2017-04-18T23:07:53.086Z,1492556873.086 [BPC1] Loaded
2017-04-18T23:07:53.086Z,1492556873.086 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2017-04-18T23:07:53.086Z,1492556873.086 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2017-04-18T23:07:53.087Z,1492556873.087 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2017-04-18T23:07:53.845Z,1492556873.845 [BuoyancyServo] Loaded
2017-04-18T23:07:53.845Z,1492556873.845 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2017-04-18T23:07:53.861Z,1492556873.861 [ElevatorServo] Loaded
2017-04-18T23:07:53.861Z,1492556873.861 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2017-04-18T23:07:53.876Z,1492556873.876 [MassServo] Loaded
2017-04-18T23:07:53.876Z,1492556873.876 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2017-04-18T23:07:53.892Z,1492556873.892 [RudderServo] Loaded
2017-04-18T23:07:53.892Z,1492556873.892 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2017-04-18T23:07:53.907Z,1492556873.907 [ThrusterServo] Loaded
2017-04-18T23:07:53.908Z,1492556873.908 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2017-04-18T23:07:53.908Z,1492556873.908 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2017-04-18T23:07:53.909Z,1492556873.909 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2017-04-18T23:07:53.979Z,1492556873.978 [VerticalControl](DEBUG): Construct VerticalControl.
2017-04-18T23:07:54.071Z,1492556874.070 [VerticalControl] Loaded
2017-04-18T23:07:54.071Z,1492556874.071 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2017-04-18T23:07:54.072Z,1492556874.072 [HorizontalControl](DEBUG): Construct HorizontalControl.
2017-04-18T23:07:54.131Z,1492556874.131 [HorizontalControl] Loaded
2017-04-18T23:07:54.131Z,1492556874.131 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control threa