2019-02-16T07:50:32.847Z,1550303432.847 [Supervisor](DEBUG): Initializing supervisor. 2019-02-16T07:50:32.850Z,1550303432.850 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2019-02-16T07:50:32.850Z,1550303432.850 [SyncHandler](INFO): Protected caller Thread ID is 7183 2019-02-16T07:50:32.850Z,1550303432.850 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2019-02-16T07:50:32.851Z,1550303432.851 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2019-02-16T07:50:32.852Z,1550303432.852 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 7184 2019-02-16T07:50:32.854Z,1550303432.854 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2019-02-16T07:50:32.865Z,1550303432.865 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2019-02-16T07:50:32.866Z,1550303432.866 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2019-02-16T07:50:32.867Z,1550303432.867 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 7185 2019-02-16T07:50:32.868Z,1550303432.868 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2019-02-16T07:50:32.868Z,1550303432.868 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2019-02-16T07:50:32.869Z,1550303432.869 [logger ThreadHandler](INFO): Protected caller Thread ID is 7186 2019-02-16T07:50:32.871Z,1550303432.871 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2019-02-16T07:50:32.871Z,1550303432.871 [Supervisor](INFO): Looking for Config files in directory: Config/ 2019-02-16T07:50:32.873Z,1550303432.873 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2019-02-16T07:50:32.967Z,1550303432.967 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2019-02-16T07:50:32.968Z,1550303432.968 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2019-02-16T07:50:33.169Z,1550303433.169 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2019-02-16T07:50:33.170Z,1550303433.170 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2019-02-16T07:50:33.306Z,1550303433.306 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2019-02-16T07:50:33.307Z,1550303433.307 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2019-02-16T07:50:33.780Z,1550303433.780 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2019-02-16T07:50:33.780Z,1550303433.780 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2019-02-16T07:50:34.223Z,1550303434.223 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2019-02-16T07:50:34.224Z,1550303434.224 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2019-02-16T07:50:34.706Z,1550303434.706 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2019-02-16T07:50:34.707Z,1550303434.707 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2019-02-16T07:50:35.016Z,1550303435.016 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2019-02-16T07:50:35.016Z,1550303435.016 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2019-02-16T07:50:35.367Z,1550303435.367 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2019-02-16T07:50:35.367Z,1550303435.367 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2019-02-16T07:50:35.760Z,1550303435.760 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2019-02-16T07:50:35.761Z,1550303435.761 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2019-02-16T07:50:35.911Z,1550303435.911 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2019-02-16T07:50:35.911Z,1550303435.911 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2019-02-16T07:50:36.018Z,1550303436.018 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2019-02-16T07:50:36.019Z,1550303436.019 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2019-02-16T07:50:36.099Z,1550303436.099 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2019-02-16T07:50:36.200Z,1550303436.200 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample 2019-02-16T07:50:36.200Z,1550303436.200 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2019-02-16T07:50:36.397Z,1550303436.397 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2019-02-16T07:50:36.398Z,1550303436.398 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2019-02-16T07:50:36.606Z,1550303436.606 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2019-02-16T07:50:36.608Z,1550303436.608 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/ 2019-02-16T07:50:36.609Z,1550303436.609 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/secure.cfg 2019-02-16T07:50:36.692Z,1550303436.692 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Battery.cfg 2019-02-16T07:50:37.007Z,1550303437.007 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2019-02-16T07:50:37.008Z,1550303437.008 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Navigation.cfg 2019-02-16T07:50:37.211Z,1550303437.211 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Sensor.cfg 2019-02-16T07:50:37.748Z,1550303437.748 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/vehicle.cfg 2019-02-16T07:50:38.066Z,1550303438.066 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Simulator.cfg 2019-02-16T07:50:38.151Z,1550303438.151 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Servo.cfg 2019-02-16T07:50:38.248Z,1550303438.248 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Control.cfg 2019-02-16T07:50:38.340Z,1550303438.340 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Science.cfg 2019-02-16T07:50:38.491Z,1550303438.491 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/logger.cfg 2019-02-16T07:50:38.596Z,1550303438.596 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/BIT.cfg 2019-02-16T07:50:38.694Z,1550303438.694 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/root/ 2019-02-16T07:50:38.694Z,1550303438.694 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg 2019-02-16T07:50:38.698Z,1550303438.698 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2019-02-16T07:50:38.810Z,1550303438.810 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2019-02-16T07:50:38.811Z,1550303438.811 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2019-02-16T07:50:38.948Z,1550303438.948 [BuoyancyServo] Loaded 2019-02-16T07:50:38.948Z,1550303438.948 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2019-02-16T07:50:38.964Z,1550303438.964 [ElevatorServo] Loaded 2019-02-16T07:50:38.964Z,1550303438.964 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2019-02-16T07:50:38.979Z,1550303438.979 [MassServo] Loaded 2019-02-16T07:50:38.980Z,1550303438.980 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2019-02-16T07:50:38.995Z,1550303438.995 [RudderServo] Loaded 2019-02-16T07:50:38.995Z,1550303438.995 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2019-02-16T07:50:39.010Z,1550303439.010 [ThrusterServo] Loaded 2019-02-16T07:50:39.010Z,1550303439.010 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread. 2019-02-16T07:50:39.011Z,1550303439.011 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2019-02-16T07:50:39.011Z,1550303439.011 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2019-02-16T07:50:39.162Z,1550303439.162 [SBIT](DEBUG): Construct Startup Built In Test. 2019-02-16T07:50:39.192Z,1550303439.192 [SBIT] Loaded 2019-02-16T07:50:39.192Z,1550303439.192 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2019-02-16T07:50:39.193Z,1550303439.193 [IBIT](DEBUG): Construct Initiated Built In Test. 2019-02-16T07:50:39.222Z,1550303439.222 [IBIT] Loaded 2019-02-16T07:50:39.222Z,1550303439.222 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2019-02-16T07:50:39.225Z,1550303439.225 [CBIT](DEBUG): Construct Continuous Built In Test. 2019-02-16T07:50:39.642Z,1550303439.642 [CBIT] Loaded 2019-02-16T07:50:39.642Z,1550303439.642 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2019-02-16T07:50:39.643Z,1550303439.643 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2019-02-16T07:50:39.643Z,1550303439.643 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2019-02-16T07:50:39.840Z,1550303439.840 [Aanderaa_O2] Loaded 2019-02-16T07:50:39.840Z,1550303439.840 [ComponentRegistry](DEBUG): SyncComponent "Aanderaa_O2" handled in the control thread. 2019-02-16T07:50:39.849Z,1550303439.849 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_density 2019-02-16T07:50:39.855Z,1550303439.855 [CTD_Seabird](INFO): created writer for : sea_water_density 2019-02-16T07:50:39.856Z,1550303439.856 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): depth 2019-02-16T07:50:39.861Z,1550303439.861 [CTD_Seabird](INFO): created writer for : depth 2019-02-16T07:50:39.862Z,1550303439.862 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_pressure 2019-02-16T07:50:39.868Z,1550303439.868 [CTD_Seabird](INFO): created writer for : sea_water_pressure 2019-02-16T07:50:39.868Z,1550303439.868 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_salinity 2019-02-16T07:50:39.874Z,1550303439.874 [CTD_Seabird](INFO): created writer for : sea_water_salinity 2019-02-16T07:50:39.874Z,1550303439.874 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_temperature 2019-02-16T07:50:39.880Z,1550303439.880 [CTD_Seabird](INFO): created writer for : sea_water_temperature 2019-02-16T07:50:39.881Z,1550303439.881 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_electrical_conductivity 2019-02-16T07:50:39.887Z,1550303439.887 [CTD_Seabird](INFO): created writer for : sea_water_electrical_conductivity 2019-02-16T07:50:39.887Z,1550303439.887 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): speed_of_sound_in_sea_water 2019-02-16T07:50:39.893Z,1550303439.893 [CTD_Seabird](INFO): created writer for : speed_of_sound_in_sea_water 2019-02-16T07:50:39.921Z,1550303439.921 [CTD_Seabird] Loaded 2019-02-16T07:50:39.922Z,1550303439.922 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2019-02-16T07:50:39.923Z,1550303439.923 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 4062F4E0 2019-02-16T07:50:39.923Z,1550303439.923 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 7265 2019-02-16T07:50:39.945Z,1550303439.945 [ESPComponent] Loaded 2019-02-16T07:50:39.946Z,1550303439.946 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread. 2019-02-16T07:50:39.960Z,1550303439.960 [PAR_Licor] Loaded 2019-02-16T07:50:39.960Z,1550303439.960 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2019-02-16T07:50:40.011Z,1550303440.011 [WetLabsBB2FL] Loaded 2019-02-16T07:50:40.011Z,1550303440.011 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2019-02-16T07:50:40.012Z,1550303440.012 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 4065F4E0 2019-02-16T07:50:40.013Z,1550303440.013 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 7266 2019-02-16T07:50:40.014Z,1550303440.014 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2019-02-16T07:50:40.014Z,1550303440.014 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2019-02-16T07:50:40.059Z,1550303440.059 [DepthRateCalculator] Loaded 2019-02-16T07:50:40.059Z,1550303440.059 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2019-02-16T07:50:40.065Z,1550303440.065 [PitchRateCalculator] Loaded 2019-02-16T07:50:40.065Z,1550303440.065 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2019-02-16T07:50:40.082Z,1550303440.082 [SpeedCalculator] Loaded 2019-02-16T07:50:40.082Z,1550303440.082 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2019-02-16T07:50:40.103Z,1550303440.103 [TempGradientCalculator] Loaded 2019-02-16T07:50:40.104Z,1550303440.104 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread. 2019-02-16T07:50:40.110Z,1550303440.110 [YawRateCalculator] Loaded 2019-02-16T07:50:40.110Z,1550303440.110 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2019-02-16T07:50:40.145Z,1550303440.145 [ElevatorOffsetCalculator] Loaded 2019-02-16T07:50:40.145Z,1550303440.145 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2019-02-16T07:50:40.146Z,1550303440.146 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2019-02-16T07:50:40.146Z,1550303440.146 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2019-02-16T07:50:40.175Z,1550303440.175 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2019-02-16T07:50:40.176Z,1550303440.176 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2019-02-16T07:50:40.284Z,1550303440.284 [DeadReckonUsingMultipleVelocitySources] Loaded 2019-02-16T07:50:40.284Z,1550303440.284 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2019-02-16T07:50:40.347Z,1550303440.347 [DeadReckonUsingSpeedCalculator] Loaded 2019-02-16T07:50:40.347Z,1550303440.347 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread. 2019-02-16T07:50:40.410Z,1550303440.410 [DeadReckonWithRespectToSeafloor] Loaded 2019-02-16T07:50:40.410Z,1550303440.410 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToSeafloor" handled in the control thread. 2019-02-16T07:50:40.427Z,1550303440.427 [NavChart] Loaded 2019-02-16T07:50:40.427Z,1550303440.427 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2019-02-16T07:50:40.432Z,1550303440.432 [UniversalFixResidualReporter] Loaded 2019-02-16T07:50:40.432Z,1550303440.432 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2019-02-16T07:50:40.432Z,1550303440.432 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2019-02-16T07:50:40.433Z,1550303440.433 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2019-02-16T07:50:40.748Z,1550303440.748 [AcousticModem_Benthos_ATM900] Loaded 2019-02-16T07:50:40.748Z,1550303440.748 [ComponentRegistry](DEBUG): SyncComponent "AcousticModem_Benthos_ATM900" handled in the control thread. 2019-02-16T07:50:40.826Z,1550303440.826 [DataOverHttps] Loaded 2019-02-16T07:50:40.827Z,1550303440.827 [ComponentRegistry](DEBUG): SyncComponent "DataOverHttps" handled in the control thread. 2019-02-16T07:50:40.841Z,1550303440.841 [Depth_Keller] Loaded 2019-02-16T07:50:40.841Z,1550303440.841 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2019-02-16T07:50:40.938Z,1550303440.938 [NAL9602] Loaded 2019-02-16T07:50:40.939Z,1550303440.939 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2019-02-16T07:50:40.944Z,1550303440.944 [Onboard] Loaded 2019-02-16T07:50:40.944Z,1550303440.944 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread. 2019-02-16T07:50:40.951Z,1550303440.951 [Radio_Surface] Loaded 2019-02-16T07:50:40.951Z,1550303440.951 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2019-02-16T07:50:40.952Z,1550303440.952 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409264E0 2019-02-16T07:50:40.953Z,1550303440.953 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 7267 2019-02-16T07:50:41.002Z,1550303441.002 [PNI_TCM] Loaded 2019-02-16T07:50:41.003Z,1550303441.003 [ComponentRegistry](DEBUG): SyncComponent "PNI_TCM" handled in the control thread. 2019-02-16T07:50:41.067Z,1550303441.067 [Rowe_600LCM] Loaded 2019-02-16T07:50:41.067Z,1550303441.067 [ComponentRegistry](DEBUG): Component "Rowe_600LCM" handled in its own thread. 2019-02-16T07:50:41.068Z,1550303441.068 [Rowe_600LCM ThreadHandler](DEBUG): Created PCaller Thread at 409564E0 2019-02-16T07:50:41.069Z,1550303441.069 [Rowe_600LCM ThreadHandler](INFO): Protected caller Thread ID is 7268 2019-02-16T07:50:42.967Z,1550303442.967 [BPC1] Loaded 2019-02-16T07:50:42.967Z,1550303442.967 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2019-02-16T07:50:42.968Z,1550303442.968 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2019-02-16T07:50:42.968Z,1550303442.968 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2019-02-16T07:50:43.180Z,1550303443.180 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2019-02-16T07:50:43.181Z,1550303443.181 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2019-02-16T07:50:43.306Z,1550303443.306 [VerticalControl](DEBUG): Construct VerticalControl. 2019-02-16T07:50:43.391Z,1550303443.391 [VerticalControl] Loaded 2019-02-16T07:50:43.392Z,1550303443.392 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2019-02-16T07:50:43.393Z,1550303443.393 [HorizontalControl](DEBUG): Construct HorizontalControl. 2019-02-16T07:50:43.453Z,1550303443.453 [HorizontalControl] Loaded 2019-02-16T07:50:43.453Z,1550303443.453 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2019-02-16T07:50:43.454Z,1550303443.454 [SpeedControl](DEBUG): Construct SpeedControl. 2019-02-16T07:50:43.455Z,1550303443.455 [SpeedControl] Loaded 2019-02-16T07:50:43.455Z,1550303443.455 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2019-02-16T07:50:43.456Z,1550303443.456 [LoopControl](DEBUG): Construct LoopControl. 2019-02-16T07:50:43.457Z,1550303443.457 [LoopControl] Loaded 2019-02-16T07:50:43.457Z,1550303443.457 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2019-02-16T07:50:43.457Z,1550303443.457 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2019-02-16T07:50:43.458Z,1550303443.458 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2019-02-16T07:50:43.472Z,1550303443.472 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2019-02-16T07:50:43.472Z,1550303443.472 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2019-02-16T07:50:43.740Z,1550303443.740 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2019-02-16T07:50:43.743Z,1550303443.743 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2019-02-16T07:50:43.744Z,1550303443.744 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2019-02-16T07:50:43.751Z,1550303443.751 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2019-02-16T07:50:43.752Z,1550303443.752 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40A784E0 2019-02-16T07:50:43.752Z,1550303443.752 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 7269 2019-02-16T07:50:43.757Z,1550303443.757 [Supervisor](INFO): Main Thread ID is 6818 2019-02-16T07:50:43.757Z,1550303443.757 [Supervisor](DEBUG): Running supervisor. 2019-02-16T07:50:43.758Z,1550303443.758 [CommandLine ThreadHandler](INFO): Handler Thread ID is 7270 2019-02-16T07:50:43.760Z,1550303443.760 [controlThread ThreadHandler](INFO): Handler Thread ID is 7271 2019-02-16T07:50:43.760Z,1550303443.760 [controlThread](DEBUG): Initializing ControlThread 2019-02-16T07:50:43.762Z,1550303443.762 [SBIT](INFO): Initialize SBIT Component. 2019-02-16T07:50:43.763Z,1550303443.763 [SBIT](IMPORTANT): git: 2019-02-11-18-g088f29c 2019-02-16T07:50:43.763Z,1550303443.763 [SBIT](INFO): git hash: 088f29c08f1651a006237423a6ffed1cbba6c6ba 2019-02-16T07:50:43.763Z,1550303443.763 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2019-02-16T07:50:43.764Z,1550303443.764 [SBIT](INFO): Kernel Reporting Different Version From Configuration. Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018 Kernel Reported: #1 PREEMPT Tue Dec 18 21:19:28 PST 2018 2019-02-16T07:50:43.766Z,1550303443.766 [SBIT](INFO): Beginning SBIT in 24.000000 seconds. 2019-02-16T07:50:43.766Z,1550303443.766 [IBIT](INFO): Initialize IBIT Component. 2019-02-16T07:50:43.767Z,1550303443.767 [CBIT](DEBUG): Initialize CBIT Component. 2019-02-16T07:50:43.768Z,1550303443.768 [logger ThreadHandler](INFO): Handler Thread ID is 7272 2019-02-16T07:50:43.777Z,1550303443.777 [CBIT](DEBUG): Initialized mux pins. 2019-02-16T07:50:43.777Z,1550303443.777 [CBIT](DEBUG): Initializing the watchdog timer. 2019-02-16T07:50:43.786Z,1550303443.786 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 7273 2019-02-16T07:50:43.786Z,1550303443.786 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2019-02-16T07:50:43.790Z,1550303443.790 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20 2019-02-16T07:50:43.791Z,1550303443.791 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 7275 2019-02-16T07:50:43.792Z,1550303443.792 [WetLabsBB2FL](INFO): Powering down 2019-02-16T07:50:43.805Z,1550303443.805 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2019-02-16T07:50:43.806Z,1550303443.806 [CBIT](DEBUG): Initializing heartbeat. 2019-02-16T07:50:43.850Z,1550303443.850 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 7276 2019-02-16T07:50:43.850Z,1550303443.850 [Radio_Surface](INFO): Stopped 2019-02-16T07:50:43.871Z,1550303443.871 [Rowe_600LCM ThreadHandler](INFO): Handler Thread ID is 7277 2019-02-16T07:50:43.872Z,1550303443.872 [Rowe_600LCM](INFO): Initializing 2019-02-16T07:50:43.877Z,1550303443.877 [CBIT](DEBUG): Deactivating GF circuits. 2019-02-16T07:50:43.878Z,1550303443.878 [CBIT](DEBUG): Deactivating emergency mode. 2019-02-16T07:50:43.882Z,1550303443.882 [Rowe_600LCM](INFO): Powering up 2019-02-16T07:50:43.902Z,1550303443.902 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 7278 2019-02-16T07:50:43.905Z,1550303443.905 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2019-02-16T07:50:43.905Z,1550303443.905 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2019-02-16T07:50:43.905Z,1550303443.905 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2019-02-16T07:50:43.906Z,1550303443.906 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2019-02-16T07:50:43.906Z,1550303443.906 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2019-02-16T07:50:43.906Z,1550303443.906 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2019-02-16T07:50:43.906Z,1550303443.906 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000 2019-02-16T07:50:43.906Z,1550303443.906 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000 2019-02-16T07:50:43.907Z,1550303443.907 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2019-02-16T07:50:43.907Z,1550303443.907 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2019-02-16T07:50:43.907Z,1550303443.907 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000 2019-02-16T07:50:43.907Z,1550303443.907 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000 2019-02-16T07:50:43.907Z,1550303443.907 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000 2019-02-16T07:50:43.908Z,1550303443.908 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000 2019-02-16T07:50:43.908Z,1550303443.908 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000 2019-02-16T07:50:43.908Z,1550303443.908 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000 2019-02-16T07:50:43.918Z,1550303443.918 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2019-02-16T07:50:43.918Z,1550303443.918 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2019-02-16T07:50:43.918Z,1550303443.918 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2019-02-16T07:50:43.919Z,1550303443.919 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator. 2019-02-16T07:50:43.919Z,1550303443.919 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2019-02-16T07:50:43.920Z,1550303443.920 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2019-02-16T07:50:43.921Z,1550303443.921 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2019-02-16T07:50:43.926Z,1550303443.926 [NavChart](DEBUG): Initialize NavChart Navigation. 2019-02-16T07:50:43.926Z,1550303443.926 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2019-02-16T07:50:43.935Z,1550303443.935 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2019-02-16T07:50:43.937Z,1550303443.937 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2019-02-16T07:50:43.938Z,1550303443.938 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2019-02-16T07:50:43.938Z,1550303443.938 [LoopControl](DEBUG): Initialize LoopControlComponent. 2019-02-16T07:50:43.939Z,1550303443.939 [MissionManager](INFO): Loading Mission: Missions/Startup.xml 2019-02-16T07:50:43.987Z,1550303443.987 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2019-02-16T07:50:44.036Z,1550303444.036 [MissionManager](DEBUG): 2019-02-16T07:50:44.037Z,1550303444.037 [MissionManager](INFO): Loading Mission: Missions/Default.xml 2019-02-16T07:50:44.141Z,1550303444.141 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2019-02-16T07:50:44.142Z,1550303444.142 [Default:A.Wait](DEBUG): Construct Wait. 2019-02-16T07:50:44.144Z,1550303444.144 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2019-02-16T07:50:44.179Z,1550303444.179 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2019-02-16T07:50:44.234Z,1550303444.234 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2019-02-16T07:50:44.239Z,1550303444.239 [Default:E.Execute](DEBUG): Construct Execute. 2019-02-16T07:50:44.253Z,1550303444.253 [Radio_Surface](INFO): Start 2019-02-16T07:50:44.254Z,1550303444.254 [Radio_Surface](INFO): Powering up 2019-02-16T07:50:44.259Z,1550303444.259 [MissionManager](DEBUG): 0 Wait a moment to see if the scheduler starts a new mission before starting to actually run Default. 13 Burn on Dropped weight due to communications timeout. 5 Default mission has been running for Restarting logs and Default mission. restart logs 2019-02-16T07:50:44.264Z,1550303444.264 [controlThread](DEBUG): Component order: CycleStarter,Aanderaa_O2,ESPComponent,PAR_Licor,AcousticModem_Benthos_ATM900,DataOverHttps,Depth_Keller,NAL9602,Onboard,PNI_TCM,BPC1,PAR_Licor,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,DeadReckonWithRespectToSeafloor,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter, 2019-02-16T07:50:44.356Z,1550303444.356 [ESPComponent](INFO): powering down ESP 2019-02-16T07:50:44.658Z,1550303444.658 [Radio_Surface](INFO): Starting 2019-02-16T07:50:44.804Z,1550303444.804 [AcousticModem_Benthos_ATM900](INFO): Powering up 2019-02-16T07:50:44.804Z,1550303444.804 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900. 2019-02-16T07:50:44.836Z,1550303444.836 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2019-02-16T07:50:44.853Z,1550303444.853 [Depth_Keller](ERROR): Pressure reading out of range: 1895.684326 decibar 2019-02-16T07:50:45.004Z,1550303445.004 [DepthRateCalculator](ERROR): Depth measurement is not active 2019-02-16T07:50:45.061Z,1550303445.061 [Radio_Surface](INFO): Starting 2019-02-16T07:50:45.346Z,1550303445.346 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2019-02-16T07:50:45.358Z,1550303445.358 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2019-02-16T07:50:45.384Z,1550303445.384 [ElevatorServo](DEBUG): Initializing EZServoServo. 2019-02-16T07:50:45.394Z,1550303445.394 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2019-02-16T07:50:45.412Z,1550303445.412 [MassServo](DEBUG): Initializing EZServoServo. 2019-02-16T07:50:45.422Z,1550303445.422 [MassServo](DEBUG): Initializing MassServo. 2019-02-16T07:50:45.443Z,1550303445.443 [RudderServo](DEBUG): Initializing EZServoServo. 2019-02-16T07:50:45.454Z,1550303445.454 [RudderServo](DEBUG): Initializing RudderServo. 2019-02-16T07:50:45.465Z,1550303445.465 [Radio_Surface](INFO): Starting 2019-02-16T07:50:45.468Z,1550303445.468 [ThrusterServo](DEBUG): Initializing EZServoServo. 2019-02-16T07:50:45.478Z,1550303445.478 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2019-02-16T07:50:45.869Z,1550303445.869 [Radio_Surface](INFO): Starting 2019-02-16T07:50:46.274Z,1550303446.274 [Radio_Surface](INFO): Starting 2019-02-16T07:50:46.286Z,1550303446.286 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout 2019-02-16T07:50:46.286Z,1550303446.286 [BuoyancyServo](FAULT): Buoyancy failed to initialize 2019-02-16T07:50:46.286Z,1550303446.286 [BuoyancyServo] Communications Fault, FailCount= 1 2019-02-16T07:50:46.286Z,1550303446.286 [BuoyancyServo](ERROR): Communications Fault 2019-02-16T07:50:46.494Z,1550303446.494 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2019-02-16T07:50:46.677Z,1550303446.677 [Radio_Surface](INFO): Starting 2019-02-16T07:50:47.081Z,1550303447.081 [Radio_Surface](INFO): Starting 2019-02-16T07:50:47.485Z,1550303447.485 [Radio_Surface](INFO): Starting 2019-02-16T07:50:47.889Z,1550303447.889 [Radio_Surface](INFO): Starting 2019-02-16T07:50:48.183Z,1550303448.183 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface 2019-02-16T07:50:48.294Z,1550303448.294 [Radio_Surface](INFO): Starting 2019-02-16T07:50:48.324Z,1550303448.324 [Rowe_600LCM](INFO): Started Rowe LCM interface with command:nohup ./lrauv-framework/onboard/bin/roweadcp -ldir /mnt/mmc/LRAUV/Logs/latest/ -dev /dev/ttyB4 -b 9600 >& /dev/null & 2019-02-16T07:50:48.698Z,1550303448.698 [Radio_Surface](INFO): Starting 2019-02-16T07:50:48.754Z,1550303448.754 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2019-02-16T07:50:48.755Z,1550303448.755 [BuoyancyServo] No Fault, FailCount= 1 2019-02-16T07:50:49.052Z,1550303449.052 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2019-02-16T07:50:49.102Z,1550303449.102 [Radio_Surface](INFO): Starting 2019-02-16T07:50:49.172Z,1550303449.172 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2019-02-16T07:50:49.506Z,1550303449.506 [Radio_Surface](INFO): Starting 2019-02-16T07:50:49.510Z,1550303449.510 [Aanderaa_O2](INFO): Powering down 2019-02-16T07:50:49.910Z,1550303449.910 [Radio_Surface](INFO): Runnable 2019-02-16T07:50:50.313Z,1550303450.313 [Radio_Surface](INFO): Runnable 2019-02-16T07:50:50.717Z,1550303450.717 [Radio_Surface](INFO): Runnable 2019-02-16T07:50:50.822Z,1550303450.822 [CTD_Seabird](ERROR): Device message queue exceeded the allowed limit. 2019-02-16T07:50:51.122Z,1550303451.122 [Radio_Surface](INFO): Runnable 2019-02-16T07:50:51.526Z,1550303451.526 [Radio_Surface](INFO): Runnable 2019-02-16T07:50:51.930Z,1550303451.930 [Radio_Surface](INFO): Runnable 2019-02-16T07:50:52.334Z,1550303452.334 [Radio_Surface](INFO): Runnable 2019-02-16T07:50:52.398Z,1550303452.398 [AcousticModem_Benthos_ATM900](DEBUG): 2019-02-16T07:50:52.738Z,1550303452.738 [Radio_Surface](INFO): Runnable 2019-02-16T07:50:53.142Z,1550303453.142 [Radio_Surface](INFO): Runnable 2019-02-16T07:50:53.546Z,1550303453.546 [Radio_Surface](INFO): Runnable 2019-02-16T07:50:53.600Z,1550303453.600 [AcousticModem_Benthos_ATM900](DEBUG): Teledyne Benthos ATM-900 Series OEM w/burn wire 2019-02-16T07:50:53.600Z,1550303453.600 [AcousticModem_Benthos_ATM900](DEBUG): MF Frequency Band 2019-02-16T07:50:53.601Z,1550303453.601 [AcousticModem_Benthos_ATM900](DEBUG): Standard version 8.6.3 2019-02-16T07:50:53.601Z,1550303453.601 [AcousticModem_Benthos_ATM900](DEBUG): Feb 11 2019 22:23:05 2019-02-16T07:50:53.829Z,1550303453.829 [CBIT](CRITICAL): Environmental Failure. Press:14.846019 PSI. Humidity:29%. Temp:26 C. ABORTING MISSION 2019-02-16T07:50:53.830Z,1550303453.830 [Supervisor](INFO): Stop Mission called by CBIT::monitorEnvironmentals 2019-02-16T07:50:53.950Z,1550303453.950 [Radio_Surface](INFO): Runnable 2019-02-16T07:50:54.003Z,1550303454.003 [AcousticModem_Benthos_ATM900](DEBUG): WARNING: battery low 2019-02-16T07:50:54.329Z,1550303454.329 [CommandLine](FAULT): Scheduling is paused 2019-02-16T07:50:54.329Z,1550303454.329 [CBIT](INFO): Critical error at 20190216T075053 2019-02-16T07:50:54.354Z,1550303454.354 [Radio_Surface](INFO): Runnable 2019-02-16T07:50:54.758Z,1550303454.758 [Radio_Surface](INFO): Runnable 2019-02-16T07:50:54.810Z,1550303454.810 [AcousticModem_Benthos_ATM900](INFO): entering command mode 2019-02-16T07:50:55.162Z,1550303455.162 [Radio_Surface](INFO): Runnable 2019-02-16T07:50:55.214Z,1550303455.214 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment 2019-02-16T07:50:55.215Z,1550303455.215 [AcousticModem_Benthos_ATM900](DEBUG): read user prompt 1: user:1> 2019-02-16T07:50:55.215Z,1550303455.215 [AcousticModem_Benthos_ATM900](INFO): command mode acknowledged 2019-02-16T07:50:55.566Z,1550303455.566 [Radio_Surface](INFO): Runnable 2019-02-16T07:50:55.619Z,1550303455.619 [AcousticModem_Benthos_ATM900](INFO): setting local address to 3 2019-02-16T07:50:55.970Z,1550303455.970 [Radio_Surface](INFO): Runnable 2019-02-16T07:50:56.022Z,1550303456.022 [AcousticModem_Benthos_ATM900](DEBUG): checking for local address setting acknowledgment 2019-02-16T07:50:56.023Z,1550303456.023 [AcousticModem_Benthos_ATM900](INFO): set local address to 3 2019-02-16T07:50:56.374Z,1550303456.374 [Radio_Surface](INFO): Runnable 2019-02-16T07:50:56.427Z,1550303456.427 [AcousticModem_Benthos_ATM900](DEBUG): read user prompt 2: user:2> 2019-02-16T07:50:56.778Z,1550303456.778 [Radio_Surface](INFO): Runnable 2019-02-16T07:50:57.182Z,1550303457.182 [Radio_Surface](INFO): Runnable 2019-02-16T07:50:57.585Z,1550303457.585 [Radio_Surface](INFO): Runnable 2019-02-16T07:50:58.001Z,1550303458.001 [Radio_Surface](INFO): Runnable 2019-02-16T07:50:58.394Z,1550303458.394 [Radio_Surface](INFO): Runnable 2019-02-16T07:50:58.798Z,1550303458.798 [Radio_Surface](INFO): Runnable 2019-02-16T07:50:59.202Z,1550303459.202 [Radio_Surface](INFO): Runnable 2019-02-16T07:50:59.606Z,1550303459.606 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:00.010Z,1550303460.010 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:00.414Z,1550303460.414 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:00.818Z,1550303460.818 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:01.222Z,1550303461.222 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:01.626Z,1550303461.626 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:02.029Z,1550303462.029 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:02.434Z,1550303462.434 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:02.838Z,1550303462.838 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:03.242Z,1550303463.242 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:03.646Z,1550303463.646 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:04.050Z,1550303464.050 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:04.454Z,1550303464.454 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:04.858Z,1550303464.858 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:05.262Z,1550303465.262 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:05.665Z,1550303465.665 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:06.070Z,1550303466.070 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:06.474Z,1550303466.474 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:06.878Z,1550303466.878 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:07.282Z,1550303467.282 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:07.686Z,1550303467.686 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:08.090Z,1550303468.090 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:08.206Z,1550303468.206 [SBIT](IMPORTANT): Beginning Startup BIT 2019-02-16T07:51:08.218Z,1550303468.218 [CBIT](IMPORTANT): Beginning ground fault scan 2019-02-16T07:51:08.493Z,1550303468.493 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:08.898Z,1550303468.898 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:09.302Z,1550303469.302 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:09.706Z,1550303469.706 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:10.110Z,1550303470.110 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:10.514Z,1550303470.514 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:10.918Z,1550303470.918 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:11.131Z,1550303471.131 [NAL9602](INFO): Powering up NAL9602 2019-02-16T07:51:11.321Z,1550303471.321 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:11.726Z,1550303471.726 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:12.130Z,1550303472.130 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:12.534Z,1550303472.534 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:12.938Z,1550303472.938 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:13.342Z,1550303473.342 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:13.746Z,1550303473.746 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:14.150Z,1550303474.150 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:14.554Z,1550303474.554 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:14.958Z,1550303474.958 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:15.361Z,1550303475.361 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:15.766Z,1550303475.766 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:16.170Z,1550303476.170 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:16.573Z,1550303476.573 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:16.978Z,1550303476.978 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:17.382Z,1550303477.382 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:17.458Z,1550303477.458 [CommandLine](IMPORTANT): got command report touch Radio_Surface.radio_surface_power 2019-02-16T07:51:17.786Z,1550303477.786 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:18.190Z,1550303478.190 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:18.594Z,1550303478.594 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:18.997Z,1550303478.997 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:19.331Z,1550303479.331 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): -0.009563 CHAN A1 (24V): -0.011728 CHAN A2 (12V): -0.005007 CHAN A3 (5V): -0.002589 CHAN B0 (3.3V): -0.001201 CHAN B1 (3.15aV): -0.001199 CHAN B2 (3.15bV): -0.000944 CHAN B3 (GND): 0.000137 OPEN: 0.004664 Full Scale Calc: 4.765 mA, -1.589 mA 2019-02-16T07:51:19.402Z,1550303479.402 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:19.806Z,1550303479.806 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:20.210Z,1550303480.210 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:20.614Z,1550303480.614 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:21.018Z,1550303481.018 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:21.422Z,1550303481.422 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:21.826Z,1550303481.826 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:22.039Z,1550303482.039 [NAL9602](INFO): NAL9602 initialized 2019-02-16T07:51:22.230Z,1550303482.230 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:22.634Z,1550303482.634 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:22.870Z,1550303482.870 [NAL9602](DEBUG): Fix Requested 2019-02-16T07:51:23.038Z,1550303483.038 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:23.442Z,1550303483.442 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:23.845Z,1550303483.845 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:24.250Z,1550303484.250 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:24.654Z,1550303484.654 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:25.057Z,1550303485.057 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:25.461Z,1550303485.461 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:25.866Z,1550303485.866 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:26.269Z,1550303486.269 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:26.673Z,1550303486.673 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:27.078Z,1550303487.078 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:27.481Z,1550303487.481 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:27.885Z,1550303487.885 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:28.290Z,1550303488.290 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:28.693Z,1550303488.693 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:29.097Z,1550303489.097 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:29.502Z,1550303489.502 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:29.906Z,1550303489.906 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:30.309Z,1550303490.309 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:30.713Z,1550303490.713 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:31.118Z,1550303491.118 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:31.521Z,1550303491.521 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:31.925Z,1550303491.925 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:32.329Z,1550303492.329 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:32.733Z,1550303492.733 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:33.137Z,1550303493.137 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:33.542Z,1550303493.542 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:33.945Z,1550303493.945 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:34.349Z,1550303494.349 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:34.753Z,1550303494.753 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:35.157Z,1550303495.157 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:35.561Z,1550303495.561 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:35.965Z,1550303495.965 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:36.369Z,1550303496.369 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:36.773Z,1550303496.773 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:37.177Z,1550303497.177 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:37.581Z,1550303497.581 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:37.985Z,1550303497.985 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:38.389Z,1550303498.389 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:38.793Z,1550303498.793 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:39.198Z,1550303499.198 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:39.601Z,1550303499.601 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:40.005Z,1550303500.005 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:40.409Z,1550303500.409 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:40.814Z,1550303500.814 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:41.190Z,1550303501.190 [CommandLine](IMPORTANT): got command maintain sensor Depth_Keller.depth 4.000000 2019-02-16T07:51:41.191Z,1550303501.191 [CommandLine](FAULT): Incomplete syntax. Try: help maintain 2019-02-16T07:51:41.217Z,1550303501.217 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:41.622Z,1550303501.622 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:42.026Z,1550303502.026 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:42.429Z,1550303502.429 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:42.834Z,1550303502.834 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:43.238Z,1550303503.238 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:43.641Z,1550303503.641 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:44.046Z,1550303504.046 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:44.450Z,1550303504.450 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:44.854Z,1550303504.854 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:45.258Z,1550303505.258 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:45.661Z,1550303505.661 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:46.065Z,1550303506.065 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:46.470Z,1550303506.470 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:46.874Z,1550303506.874 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:47.277Z,1550303507.277 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:47.682Z,1550303507.682 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:48.086Z,1550303508.086 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:48.489Z,1550303508.489 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:48.894Z,1550303508.894 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:49.298Z,1550303509.298 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:49.701Z,1550303509.701 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:50.106Z,1550303510.106 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:50.510Z,1550303510.510 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:50.914Z,1550303510.914 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:51.318Z,1550303511.318 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:51.722Z,1550303511.722 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:52.126Z,1550303512.126 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:52.530Z,1550303512.530 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:52.934Z,1550303512.934 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:53.338Z,1550303513.338 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:53.743Z,1550303513.743 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:54.146Z,1550303514.146 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:54.550Z,1550303514.550 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:54.954Z,1550303514.954 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:55.357Z,1550303515.357 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:55.761Z,1550303515.761 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:56.167Z,1550303516.167 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:56.570Z,1550303516.570 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:56.973Z,1550303516.973 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:57.378Z,1550303517.378 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:57.563Z,1550303517.563 [BPC1](FAULT): Failed to parse data from all battery packs. 2019-02-16T07:51:57.563Z,1550303517.563 [BPC1] Data Fault, FailCount= 1 2019-02-16T07:51:57.563Z,1550303517.563 [BPC1](ERROR): Data Fault 2019-02-16T07:51:57.590Z,1550303517.590 [CBIT](ERROR): Data Fault in component: BPC1 2019-02-16T07:51:57.782Z,1550303517.782 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:58.185Z,1550303518.185 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:58.590Z,1550303518.590 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:58.993Z,1550303518.993 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:59.398Z,1550303519.398 [Radio_Surface](INFO): Runnable 2019-02-16T07:51:59.801Z,1550303519.801 [Radio_Surface](INFO): Runnable 2019-02-16T07:52:00.206Z,1550303520.205 [Radio_Surface](INFO): Runnable 2019-02-16T07:52:00.610Z,1550303520.610 [Radio_Surface](INFO): Runnable 2019-02-16T07:52:01.014Z,1550303521.014 [Radio_Surface](INFO): Runnable 2019-02-16T07:52:01.418Z,1550303521.418 [Radio_Surface](INFO): Runnable 2019-02-16T07:52:01.821Z,1550303521.821 [Radio_Surface](INFO): Runnable 2019-02-16T07:52:02.020Z,1550303522.020 [SBIT](IMPORTANT): SBIT PASSED 2019-02-16T07:52:02.038Z,1550303522.038 [CommandLine](IMPORTANT): got command configSet list 2019-02-16T07:52:02.039Z,1550303522.039 [CommandLine](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2019-02-16T07:52:02.039Z,1550303522.039 [CommandLine](IMPORTANT): DropWeight.loadAtStartup=0 bool; 2019-02-16T07:52:02.226Z,1550303522.226 [Radio_Surface](INFO): Runnable 2019-02-16T07:52:02.418Z,1550303522.418 [MissionManager](IMPORTANT): Started mission Startup 2019-02-16T07:52:02.418Z,1550303522.418 [Startup] Running Loop=1 2019-02-16T07:52:02.418Z,1550303522.418 [Startup](DEBUG): Aggregate::initialize Startup 2019-02-16T07:52:02.418Z,1550303522.418 [Startup:A.GoToSurface] Running Loop=1 2019-02-16T07:52:02.418Z,1550303522.418 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2019-02-16T07:52:02.419Z,1550303522.419 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2019-02-16T07:52:02.420Z,1550303522.420 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2019-02-16T07:52:02.420Z,1550303522.420 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2019-02-16T07:52:02.420Z,1550303522.420 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2019-02-16T07:52:02.421Z,1550303522.421 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2019-02-16T07:52:02.439Z,1550303522.439 [Startup:StartupSatComms] Running Loop=1 2019-02-16T07:52:02.439Z,1550303522.439 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2019-02-16T07:52:02.439Z,1550303522.439 [Startup:StartupSatComms:A] Running Loop=1 2019-02-16T07:52:02.630Z,1550303522.630 [Radio_Surface](INFO): Runnable 2019-02-16T07:52:02.831Z,1550303522.831 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2019-02-16T07:52:03.033Z,1550303523.033 [Radio_Surface](INFO): Runnable 2019-02-16T07:52:03.438Z,1550303523.438 [Radio_Surface](INFO): Runnable 2019-02-16T07:52:03.842Z,1550303523.842 [Radio_Surface](INFO): Runnable 2019-02-16T07:52:04.245Z,1550303524.245 [Radio_Surface](INFO): Runnable 2019-02-16T07:52:04.650Z,1550303524.650 [Radio_Surface](INFO): Runnable 2019-02-16T07:52:05.054Z,1550303525.054 [Radio_Surface](INFO): Runnable 2019-02-16T07:52:05.458Z,1550303525.458 [Radio_Surface](INFO): Runnable 2019-02-16T07:52:05.862Z,1550303525.862 [Radio_Surface](INFO): Runnable 2019-02-16T07:52:06.265Z,1550303526.265 [Radio_Surface](INFO): Runnable 2019-02-16T07:52:06.669Z,1550303526.669 [Radio_Surface](INFO): Runnable 2019-02-16T07:52:07.075Z,1550303527.075 [Radio_Surface](INFO): Runnable 2019-02-16T07:52:07.478Z,1550303527.478 [Radio_Surface](INFO): Runnable 2019-02-16T07:52:07.881Z,1550303527.881 [Radio_Surface](INFO): Runnable 2019-02-16T07:52:08.286Z,1550303528.286 [Radio_Surface](INFO): Runnable 2019-02-16T07:52:08.690Z,1550303528.690 [Radio_Surface](INFO): Runnable 2019-02-16T07:52:09.093Z,1550303529.093 [Radio_Surface](INFO): Runnable 2019-02-16T07:52:09.498Z,1550303529.498 [Radio_Surface](INFO): Runnable 2019-02-16T07:52:09.901Z,1550303529.901 [Radio_Surface](INFO): Runnable 2019-02-16T07:52:10.307Z,1550303530.307 [Radio_Surface](INFO): Runnable 2019-02-16T07:52:10.710Z,1550303530.710 [Radio_Surface](INFO): Runnable 2019-02-16T07:52:11.113Z,1550303531.113 [Radio_Surface](INFO): Runnable 2019-02-16T07:52:11.517Z,1550303531.517 [Radio_Surface](INFO): Runnable 2019-02-16T07:52:11.702Z,1550303531.702 [CommandLine](IMPORTANT): got command maintain clear 2019-02-16T07:52:11.922Z,1550303531.922 [Radio_Surface](INFO): Runnable 2019-02-16T07:52:12.326Z,1550303532.326 [Radio_Surface](INFO): Runnable 2019-02-16T07:52:12.729Z,1550303532.729 [Radio_Surface](INFO): Runnable 2019-02-16T07:52:13.134Z,1550303533.134 [Radio_Surface](INFO): Runnable 2019-02-16T07:52:13.539Z,1550303533.539 [Radio_Surface](INFO): Runnable 2019-02-16T07:52:13.942Z,1550303533.942 [Radio_Surface](INFO): Runnable 2019-02-16T07:52:14.346Z,1550303534.346 [Radio_Surface](INFO): Runnable 2019-02-16T07:52:14.751Z,1550303534.751 [Radio_Surface](INFO): Runnable 2019-02-16T07:52:15.154Z,1550303535.154 [Radio_Surface](INFO): Runnable 2019-02-16T07:52:15.558Z,1550303535.558 [Radio_Surface](INFO): Runnable 2019-02-16T07:52:15.961Z,1550303535.961 [Radio_Surface](INFO): Runnable 2019-02-16T07:52:16.366Z,1550303536.366 [Radio_Surface](INFO): Runnable 2019-02-16T07:52:16.770Z,1550303536.770 [Radio_Surface](INFO): Runnable 2019-02-16T07:52:17.174Z,1550303537.174 [Radio_Surface](INFO): Runnable 2019-02-16T07:52:17.578Z,1550303537.578 [Radio_Surface](INFO): Runnable 2019-02-16T07:52:17.983Z,1550303537.983 [Radio_Surface](INFO): Runnable 2019-02-16T07:52:18.386Z,1550303538.386 [Radio_Surface](INFO): Runnable 2019-02-16T07:52:18.789Z,1550303538.789 [Radio_Surface](INFO): Runnable 2019-02-16T07:52:19.194Z,1550303539.194 [Radio_Surface](INFO): Runnable 2019-02-16T07:52:19.597Z,1550303539.597 [Radio_Surface](INFO): Runnable 2019-02-16T07:52:20.001Z,1550303540.001 [Radio_Surface](INFO): Runnable 2019-02-16T07:52:20.407Z,1550303540.407 [Radio_Surface](INFO): Runnable 2019-02-16T07:52:20.809Z,1550303540.809 [Radio_Surface](INFO): Runnable 2019-02-16T07:52:21.213Z,1550303541.213 [Radio_Surface](INFO): Runnable 2019-02-16T07:52:21.618Z,1550303541.618 [Radio_Surface](INFO): Runnable 2019-02-16T07:52:22.022Z,1550303542.022 [Radio_Surface](INFO): Runnable 2019-02-16T07:52:22.426Z,1550303542.426 [Radio_Surface](INFO): Runnable 2019-02-16T07:52:22.830Z,1550303542.830 [Radio_Surface](INFO): Runnable 2019-02-16T07:52:23.234Z,1550303543.234 [Radio_Surface](INFO): Runnable 2019-02-16T07:52:23.638Z,1550303543.638 [Radio_Surface](INFO): Runnable 2019-02-16T07:52:24.042Z,1550303544.042 [Radio_Surface](INFO): Runnable 2019-02-16T07:52:24.445Z,1550303544.445 [Radio_Surface](INFO): Runnable 2019-02-16T07:52:24.850Z,1550303544.850 [Radio_Surface](INFO): Runnable 2019-02-16T07:52:25.254Z,1550303545.254 [Radio_Surface](INFO): Runnable 2019-02-16T07:52:25.662Z,1550303545.662 [Radio_Surface](INFO): Runnable 2019-02-16T07:52:26.062Z,1550303546.062 [Radio_Surface](INFO): Runnable 2019-02-16T07:52:26.466Z,1550303546.466 [Radio_Surface](INFO): Runnable 2019-02-16T07:52:26.870Z,1550303546.870 [Radio_Surface](INFO): Runnable 2019-02-16T07:52:27.274Z,1550303547.274 [Radio_Surface](INFO): Runnable 2019-02-16T07:52:27.678Z,1550303547.678 [Radio_Surface](INFO): Runnable 2019-02-16T07:52:28.082Z,1550303548.082 [Radio_Surface](INFO): Runnable 2019-02-16T07:52:28.489Z,1550303548.489 [Radio_Surface](INFO): Runnable 2019-02-16T07:52:28.890Z,1550303548.890 [Radio_Surface](INFO): Runnable 2019-02-16T07:52:29.294Z,1550303549.294 [Radio_Surface](INFO): Runnable 2019-02-16T07:52:29.562Z,1550303549.562 [CommandLine](IMPORTANT): got command maintain sensor Depth_Keller.depth 3.000000 meter 2019-02-16T07:52:29.564Z,1550303549.564 [ComponentRegistry](DEBUG): SyncComponent "Maintain_Depth_Keller.depth" handled in the control thread. 2019-02-16T07:52:29.697Z,1550303549.697 [Radio_Surface](INFO): Runnable 2019-02-16T07:52:29.871Z,1550303549.871 [controlThread](DEBUG): Component order: CycleStarter,Aanderaa_O2,ESPComponent,PAR_Licor,AcousticModem_Benthos_ATM900,DataOverHttps,Depth_Keller,NAL9602,Onboard,PNI_TCM,BPC1,PAR_Licor,Depth_Keller,Maintain_Depth_Keller.depth,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,DeadReckonWithRespectToSeafloor,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter, 2019-02-16T07:52:30.102Z,1550303550.102 [Radio_Surface](INFO): Runnable 2019-02-16T07:52:30.507Z,1550303550.507 [Radio_Surface](INFO): Runnable 2019-02-16T07:52:30.676Z,1550303550.676 [ElevatorOffsetCalculator](INFO): New estimator for commanded vars: speed 1.00 m/s, pitch 30.00 deg, mass-position -13.00 mm (1 active estimators). 2019-02-16T07:52:30.910Z,1550303550.910 [Radio_Surface](INFO): Stop 2019-02-16T07:52:30.910Z,1550303550.910 [Radio_Surface](INFO): Powering down 2019-02-16T07:52:31.174Z,1550303551.174 [Reporter](INFO): Radio_Surface.radio_surface_power no_value 2019-02-16T07:52:31.314Z,1550303551.314 [Radio_Surface](INFO): Stopping 2019-02-16T07:52:31.718Z,1550303551.718 [Radio_Surface](INFO): Stopped 2019-02-16T07:52:32.122Z,1550303552.122 [Radio_Surface](INFO): Stopped 2019-02-16T07:52:32.526Z,1550303552.526 [Radio_Surface](INFO): Stopped 2019-02-16T07:52:32.930Z,1550303552.930 [Radio_Surface](INFO): Stopped 2019-02-16T07:52:33.334Z,1550303553.334 [Radio_Surface](INFO): Stopped 2019-02-16T07:52:33.742Z,1550303553.742 [Radio_Surface](INFO): Stopped 2019-02-16T07:52:33.746Z,1550303553.746 [ThrusterServo](FAULT): Overload Error 2019-02-16T07:52:33.746Z,1550303553.746 [ThrusterServo] Hardware Fault, FailCount= 1 2019-02-16T07:52:33.746Z,1550303553.746 [ThrusterServo](ERROR): Hardware Fault 2019-02-16T07:52:33.750Z,1550303553.750 [CBIT](ERROR): Hardware Fault in component: ThrusterServo 2019-02-16T07:52:34.095Z,1550303554.095 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2019-02-16T07:52:34.095Z,1550303554.095 [ThrusterServo](INFO): Powering down 2019-02-16T07:52:34.146Z,1550303554.146 [Radio_Surface](INFO): Stopped 2019-02-16T07:52:34.550Z,1550303554.550 [Radio_Surface](INFO): Stopped 2019-02-16T07:52:34.955Z,1550303554.955 [Radio_Surface](INFO): Stopped 2019-02-16T07:52:34.983Z,1550303554.983 [ThrusterServo](DEBUG): Initializing EZServoServo. 2019-02-16T07:52:35.098Z,1550303555.098 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2019-02-16T07:52:35.103Z,1550303555.103 [CBIT](INFO): Clearing failed state for component ThrusterServo 2019-02-16T07:52:35.103Z,1550303555.103 [ThrusterServo] No Fault, FailCount= 1 2019-02-16T07:52:35.358Z,1550303555.358 [Radio_Surface](INFO): Stopped 2019-02-16T07:52:35.762Z,1550303555.762 [Radio_Surface](INFO): Stopped 2019-02-16T07:52:36.166Z,1550303556.166 [Radio_Surface](INFO): Stopped 2019-02-16T07:52:36.570Z,1550303556.570 [Radio_Surface](INFO): Stopped 2019-02-16T07:52:36.973Z,1550303556.973 [Radio_Surface](INFO): Stopped 2019-02-16T07:52:37.378Z,1550303557.378 [Radio_Surface](INFO): Stopped 2019-02-16T07:52:37.782Z,1550303557.782 [Radio_Surface](INFO): Stopped 2019-02-16T07:52:38.186Z,1550303558.186 [Radio_Surface](INFO): Stopped 2019-02-16T07:52:38.590Z,1550303558.590 [Radio_Surface](INFO): Stopped 2019-02-16T07:52:38.994Z,1550303558.994 [Radio_Surface](INFO): Stopped 2019-02-16T07:52:39.398Z,1550303559.398 [Radio_Surface](INFO): Stopped 2019-02-16T07:52:39.802Z,1550303559.802 [Radio_Surface](INFO): Stopped 2019-02-16T07:52:40.138Z,1550303560.138 [ThrusterServo](FAULT): Overload Error 2019-02-16T07:52:40.138Z,1550303560.138 [ThrusterServo] Hardware Fault, FailCount= 2 2019-02-16T07:52:40.138Z,1550303560.138 [ThrusterServo](ERROR): Hardware Fault 2019-02-16T07:52:40.142Z,1550303560.142 [CBIT](ERROR): Hardware Fault in component: ThrusterServo 2019-02-16T07:52:40.206Z,1550303560.206 [Radio_Surface](INFO): Stopped 2019-02-16T07:52:40.523Z,1550303560.523 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2019-02-16T07:52:40.523Z,1550303560.523 [ThrusterServo](INFO): Powering down 2019-02-16T07:52:40.610Z,1550303560.610 [Radio_Surface](INFO): Stopped 2019-02-16T07:52:41.014Z,1550303561.014 [Radio_Surface](INFO): Stopped 2019-02-16T07:52:41.327Z,1550303561.327 [ThrusterServo](DEBUG): Initializing EZServoServo. 2019-02-16T07:52:41.418Z,1550303561.418 [Radio_Surface](INFO): Stopped 2019-02-16T07:52:41.442Z,1550303561.442 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2019-02-16T07:52:41.447Z,1550303561.447 [CBIT](INFO): Clearing failed state for component ThrusterServo 2019-02-16T07:52:41.447Z,1550303561.447 [ThrusterServo] No Fault, FailCount= 2 2019-02-16T07:52:41.821Z,1550303561.821 [Radio_Surface](INFO): Stopped 2019-02-16T07:52:42.226Z,1550303562.226 [Radio_Surface](INFO): Stopped 2019-02-16T07:52:42.630Z,1550303562.630 [Radio_Surface](INFO): Stopped 2019-02-16T07:52:43.033Z,1550303563.033 [Radio_Surface](INFO): Stopped 2019-02-16T07:52:43.438Z,1550303563.438 [Radio_Surface](INFO): Stopped 2019-02-16T07:52:43.842Z,1550303563.842 [Radio_Surface](INFO): Stopped 2019-02-16T07:52:44.021Z,1550303564.021 [Rowe_600LCM](FAULT): Did not receive valid device response within the specified allowable sample time. 2019-02-16T07:52:44.021Z,1550303564.021 [Rowe_600LCM] Communications Fault, FailCount= 1 2019-02-16T07:52:44.022Z,1550303564.022 [Rowe_600LCM](ERROR): Communications Fault 2019-02-16T07:52:44.187Z,1550303564.187 [CBIT](ERROR): Communications Fault in component: Rowe_600LCM 2019-02-16T07:52:44.246Z,1550303564.246 [Radio_Surface](INFO): Stopped 2019-02-16T07:52:44.426Z,1550303564.426 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface 2019-02-16T07:52:44.614Z,1550303564.614 [Rowe_600LCM](INFO): Powering down 2019-02-16T07:52:44.650Z,1550303564.650 [Radio_Surface](INFO): Stopped 2019-02-16T07:52:45.054Z,1550303565.054 [Radio_Surface](INFO): Stopped 2019-02-16T07:52:45.458Z,1550303565.458 [Radio_Surface](INFO): Stopped 2019-02-16T07:52:45.862Z,1550303565.862 [Radio_Surface](INFO): Stopped 2019-02-16T07:52:46.210Z,1550303566.210 [CBIT](INFO): Clearing failed state for component Rowe_600LCM 2019-02-16T07:52:46.210Z,1550303566.210 [Rowe_600LCM] No Fault, FailCount= 1 2019-02-16T07:52:46.230Z,1550303566.230 [Rowe_600LCM](INFO): Initializing 2019-02-16T07:52:46.230Z,1550303566.230 [Rowe_600LCM](INFO): Powering up 2019-02-16T07:52:46.266Z,1550303566.266 [Radio_Surface](INFO): Stopped 2019-02-16T07:52:46.670Z,1550303566.670 [Radio_Surface](INFO): Stopped 2019-02-16T07:52:47.010Z,1550303567.010 [ThrusterServo](FAULT): Overload Error 2019-02-16T07:52:47.010Z,1550303567.010 [ThrusterServo] Hardware Fault, FailCount= 3 2019-02-16T07:52:47.010Z,1550303567.010 [ThrusterServo](ERROR): Hardware Fault 2019-02-16T07:52:47.014Z,1550303567.014 [CBIT](ERROR): Hardware Fault in component: ThrusterServo 2019-02-16T07:52:47.075Z,1550303567.075 [Radio_Surface](INFO): Stopped 2019-02-16T07:52:47.383Z,1550303567.383 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2019-02-16T07:52:47.383Z,1550303567.383 [ThrusterServo](INFO): Powering down 2019-02-16T07:52:47.478Z,1550303567.478 [Radio_Surface](INFO): Stopped 2019-02-16T07:52:47.881Z,1550303567.881 [Radio_Surface](INFO): Stopped 2019-02-16T07:52:48.282Z,1550303568.282 [ThrusterServo](DEBUG): Initializing EZServoServo. 2019-02-16T07:52:48.286Z,1550303568.286 [Radio_Surface](INFO): Stopped 2019-02-16T07:52:48.398Z,1550303568.398 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2019-02-16T07:52:48.403Z,1550303568.403 [CBIT](INFO): Clearing failed state for component ThrusterServo 2019-02-16T07:52:48.403Z,1550303568.403 [ThrusterServo] No Fault, FailCount= 3 2019-02-16T07:52:48.690Z,1550303568.690 [Radio_Surface](INFO): Stopped 2019-02-16T07:52:49.094Z,1550303569.094 [Radio_Surface](INFO): Stopped 2019-02-16T07:52:49.498Z,1550303569.498 [Radio_Surface](INFO): Stopped 2019-02-16T07:52:49.902Z,1550303569.902 [Radio_Surface](INFO): Stopped 2019-02-16T07:52:50.306Z,1550303570.306 [Radio_Surface](INFO): Stopped 2019-02-16T07:52:50.363Z,1550303570.363 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface 2019-02-16T07:52:50.430Z,1550303570.430 [Rowe_600LCM](INFO): Started Rowe LCM interface with command:nohup ./lrauv-framework/onboard/bin/roweadcp -ldir /mnt/mmc/LRAUV/Logs/latest/ -dev /dev/ttyB4 -b 9600 >& /dev/null & 2019-02-16T07:52:50.710Z,1550303570.710 [Radio_Surface](INFO): Stopped 2019-02-16T07:52:51.114Z,1550303571.114 [Radio_Surface](INFO): Stopped 2019-02-16T07:52:51.518Z,1550303571.518 [Radio_Surface](INFO): Stopped 2019-02-16T07:52:51.598Z,1550303571.598 [CommandLine](IMPORTANT): got command maintain clear 2019-02-16T07:52:51.840Z,1550303571.840 [controlThread](DEBUG): Component order: CycleStarter,Aanderaa_O2,ESPComponent,PAR_Licor,AcousticModem_Benthos_ATM900,DataOverHttps,Depth_Keller,NAL9602,Onboard,PNI_TCM,BPC1,PAR_Licor,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,DeadReckonWithRespectToSeafloor,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter, 2019-02-16T07:52:51.922Z,1550303571.922 [Radio_Surface](INFO): Stopped 2019-02-16T07:52:52.326Z,1550303572.326 [Radio_Surface](INFO): Stopped 2019-02-16T07:52:52.729Z,1550303572.729 [Radio_Surface](INFO): Start 2019-02-16T07:52:52.730Z,1550303572.730 [Radio_Surface](INFO): Powering up 2019-02-16T07:52:53.134Z,1550303573.134 [Radio_Surface](INFO): Starting 2019-02-16T07:52:53.537Z,1550303573.537 [Radio_Surface](INFO): Starting 2019-02-16T07:52:53.942Z,1550303573.942 [Radio_Surface](INFO): Starting 2019-02-16T07:52:54.346Z,1550303574.346 [Radio_Surface](INFO): Starting 2019-02-16T07:52:54.751Z,1550303574.751 [Radio_Surface](INFO): Starting 2019-02-16T07:52:55.154Z,1550303575.154 [Radio_Surface](INFO): Starting 2019-02-16T07:52:55.559Z,1550303575.559 [Radio_Surface](INFO): Starting 2019-02-16T07:52:55.962Z,1550303575.962 [Radio_Surface](INFO): Starting 2019-02-16T07:52:56.366Z,1550303576.366 [Radio_Surface](INFO): Starting 2019-02-16T07:52:56.770Z,1550303576.770 [Radio_Surface](INFO): Starting 2019-02-16T07:52:57.190Z,1550303577.190 [Radio_Surface](INFO): Starting 2019-02-16T07:52:57.594Z,1550303577.594 [Radio_Surface](INFO): Starting 2019-02-16T07:52:57.997Z,1550303577.997 [Radio_Surface](INFO): Starting 2019-02-16T07:52:58.388Z,1550303578.388 [Reporter](INFO): Radio_Surface.radio_surface_power 1 bool 2019-02-16T07:52:58.402Z,1550303578.402 [Radio_Surface](INFO): Runnable 2019-02-16T07:52:58.805Z,1550303578.805 [Radio_Surface](INFO): Runnable 2019-02-16T07:52:59.210Z,1550303579.210 [Radio_Surface](INFO): Runnable 2019-02-16T07:52:59.614Z,1550303579.614 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:00.018Z,1550303580.018 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:00.422Z,1550303580.422 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:00.826Z,1550303580.826 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:01.230Z,1550303581.230 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:01.634Z,1550303581.634 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:02.038Z,1550303582.038 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:02.441Z,1550303582.441 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:02.764Z,1550303582.764 [Startup:StartupSatComms:A](INFO): Timed out from 2019-02-16T07:52:02.4Z 2019-02-16T07:53:02.765Z,1550303582.765 [Startup:StartupSatComms:A] Stopped 2019-02-16T07:53:02.765Z,1550303582.765 [Startup:StartupSatComms:B] Running Loop=1 2019-02-16T07:53:02.846Z,1550303582.846 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:03.159Z,1550303583.159 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2019-02-16T07:53:03.250Z,1550303583.250 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:03.654Z,1550303583.654 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:04.058Z,1550303584.058 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:04.461Z,1550303584.461 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:04.866Z,1550303584.866 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:05.270Z,1550303585.270 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:05.675Z,1550303585.675 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:06.078Z,1550303586.078 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:06.482Z,1550303586.482 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:06.886Z,1550303586.886 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:07.290Z,1550303587.290 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:07.694Z,1550303587.694 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:08.098Z,1550303588.098 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:08.501Z,1550303588.501 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:08.906Z,1550303588.906 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:09.310Z,1550303589.310 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:09.714Z,1550303589.714 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:10.118Z,1550303590.118 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:10.522Z,1550303590.522 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:10.925Z,1550303590.925 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:11.330Z,1550303591.330 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:11.734Z,1550303591.734 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:12.137Z,1550303592.137 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:12.542Z,1550303592.542 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:12.946Z,1550303592.946 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:13.349Z,1550303593.349 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:13.754Z,1550303593.754 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:14.158Z,1550303594.158 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:14.562Z,1550303594.562 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:14.966Z,1550303594.966 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:15.370Z,1550303595.370 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:15.773Z,1550303595.773 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:16.178Z,1550303596.178 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:16.582Z,1550303596.582 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:16.985Z,1550303596.985 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:17.390Z,1550303597.390 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:17.793Z,1550303597.793 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:18.222Z,1550303598.222 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:18.626Z,1550303598.626 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:19.029Z,1550303599.029 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:19.433Z,1550303599.433 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:19.838Z,1550303599.838 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:20.242Z,1550303600.242 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:20.645Z,1550303600.645 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:21.050Z,1550303601.050 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:21.454Z,1550303601.454 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:21.857Z,1550303601.857 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:22.262Z,1550303602.262 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:22.666Z,1550303602.666 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:23.070Z,1550303603.070 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:23.473Z,1550303603.473 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:23.878Z,1550303603.878 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:24.281Z,1550303604.281 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:24.685Z,1550303604.685 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:25.089Z,1550303605.089 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:25.494Z,1550303605.494 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:25.898Z,1550303605.898 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:26.302Z,1550303606.302 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:26.706Z,1550303606.706 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:27.110Z,1550303607.110 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:27.514Z,1550303607.514 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:27.917Z,1550303607.917 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:28.322Z,1550303608.322 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:28.727Z,1550303608.727 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:29.129Z,1550303609.129 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:29.534Z,1550303609.534 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:29.938Z,1550303609.938 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:30.341Z,1550303610.341 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:30.746Z,1550303610.746 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:31.150Z,1550303611.150 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:31.554Z,1550303611.554 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:31.957Z,1550303611.957 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:32.362Z,1550303612.362 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:32.765Z,1550303612.765 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:33.170Z,1550303613.170 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:33.574Z,1550303613.574 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:33.978Z,1550303613.978 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:34.382Z,1550303614.382 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:34.786Z,1550303614.786 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:35.190Z,1550303615.190 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:35.594Z,1550303615.594 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:35.998Z,1550303615.998 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:36.402Z,1550303616.402 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:36.806Z,1550303616.806 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:37.210Z,1550303617.210 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:37.613Z,1550303617.613 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:38.018Z,1550303618.018 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:38.421Z,1550303618.421 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:38.825Z,1550303618.825 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:39.230Z,1550303619.230 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:39.634Z,1550303619.634 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:40.037Z,1550303620.037 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:40.442Z,1550303620.442 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:40.846Z,1550303620.846 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:41.250Z,1550303621.250 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:41.654Z,1550303621.654 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:42.057Z,1550303622.057 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:42.461Z,1550303622.461 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:42.866Z,1550303622.866 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:43.270Z,1550303623.270 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:43.673Z,1550303623.673 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:43.975Z,1550303623.975 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2019-02-16T07:53:43.975Z,1550303623.975 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2019-02-16T07:53:43.976Z,1550303623.976 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1 2019-02-16T07:53:43.976Z,1550303623.976 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2019-02-16T07:53:43.978Z,1550303623.978 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1 2019-02-16T07:53:43.978Z,1550303623.978 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault 2019-02-16T07:53:43.991Z,1550303623.991 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2019-02-16T07:53:43.991Z,1550303623.991 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2019-02-16T07:53:43.991Z,1550303623.991 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor 2019-02-16T07:53:44.078Z,1550303624.078 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:44.383Z,1550303624.383 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2019-02-16T07:53:44.383Z,1550303624.383 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2019-02-16T07:53:44.384Z,1550303624.384 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2019-02-16T07:53:44.384Z,1550303624.384 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1 2019-02-16T07:53:44.384Z,1550303624.384 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor 2019-02-16T07:53:44.384Z,1550303624.384 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1 2019-02-16T07:53:44.482Z,1550303624.482 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:44.790Z,1550303624.790 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2019-02-16T07:53:44.886Z,1550303624.886 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:45.291Z,1550303625.291 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:45.694Z,1550303625.694 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:46.097Z,1550303626.097 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:46.502Z,1550303626.502 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:46.906Z,1550303626.906 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:47.309Z,1550303627.309 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:47.714Z,1550303627.714 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:48.118Z,1550303628.118 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:48.521Z,1550303628.521 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:48.926Z,1550303628.926 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:49.330Z,1550303629.330 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:49.733Z,1550303629.733 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:50.138Z,1550303630.138 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:50.542Z,1550303630.542 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:50.945Z,1550303630.945 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:51.349Z,1550303631.349 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:51.753Z,1550303631.753 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:52.158Z,1550303632.158 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:52.562Z,1550303632.562 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:52.966Z,1550303632.966 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:53.369Z,1550303633.369 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:53.774Z,1550303633.774 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:54.178Z,1550303634.178 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:54.582Z,1550303634.582 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:54.986Z,1550303634.986 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:55.391Z,1550303635.391 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:55.793Z,1550303635.793 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:56.198Z,1550303636.198 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:56.602Z,1550303636.602 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:57.006Z,1550303637.006 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:57.410Z,1550303637.410 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:57.814Z,1550303637.814 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:58.218Z,1550303638.217 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:58.622Z,1550303638.622 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:59.026Z,1550303639.026 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:59.429Z,1550303639.429 [Radio_Surface](INFO): Runnable 2019-02-16T07:53:59.834Z,1550303639.834 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:00.238Z,1550303640.238 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:00.642Z,1550303640.642 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:01.046Z,1550303641.046 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:01.449Z,1550303641.449 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:01.854Z,1550303641.854 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:02.258Z,1550303642.258 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:02.662Z,1550303642.662 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:02.970Z,1550303642.970 [Startup:StartupSatComms:B](INFO): Timed out from 2019-02-16T07:53:02.8Z 2019-02-16T07:54:02.970Z,1550303642.970 [Startup:StartupSatComms:B] Stopped 2019-02-16T07:54:02.970Z,1550303642.970 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2019-02-16T07:54:02.970Z,1550303642.970 [Startup:StartupSatComms] Stopped 2019-02-16T07:54:02.970Z,1550303642.970 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2019-02-16T07:54:02.971Z,1550303642.971 [Startup](INFO): Completed Startup 2019-02-16T07:54:02.971Z,1550303642.971 [MissionManager](INFO): Startup is completed. 2019-02-16T07:54:02.971Z,1550303642.971 [MissionManager](INFO): Uninitializing Mission Startup 2019-02-16T07:54:02.971Z,1550303642.971 [Startup] Stopped 2019-02-16T07:54:02.972Z,1550303642.972 [Startup](DEBUG): Aggregate::uninitialize Startup 2019-02-16T07:54:02.972Z,1550303642.972 [Startup:A.GoToSurface] Stopped 2019-02-16T07:54:02.972Z,1550303642.972 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2019-02-16T07:54:03.065Z,1550303643.065 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:03.382Z,1550303643.382 [MissionManager](IMPORTANT): Started mission Default 2019-02-16T07:54:03.382Z,1550303643.382 [Default] Running Loop=1 2019-02-16T07:54:03.382Z,1550303643.382 [Default](DEBUG): Aggregate::initialize Default 2019-02-16T07:54:03.382Z,1550303643.382 [Default:B.GoToSurface] Running Loop=1 2019-02-16T07:54:03.382Z,1550303643.382 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2019-02-16T07:54:03.382Z,1550303643.382 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2019-02-16T07:54:03.383Z,1550303643.383 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2019-02-16T07:54:03.383Z,1550303643.383 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2019-02-16T07:54:03.383Z,1550303643.383 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2019-02-16T07:54:03.384Z,1550303643.384 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2019-02-16T07:54:03.384Z,1550303643.384 [Default:A.Wait] Running Loop=1 2019-02-16T07:54:03.384Z,1550303643.384 [Default:A.Wait](DEBUG): Initialize Wait Component. 2019-02-16T07:54:03.470Z,1550303643.470 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:03.874Z,1550303643.874 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:04.277Z,1550303644.277 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:04.682Z,1550303644.682 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:05.086Z,1550303645.086 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:05.489Z,1550303645.489 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:05.894Z,1550303645.894 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:06.298Z,1550303646.298 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:06.701Z,1550303646.701 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:07.106Z,1550303647.106 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:07.510Z,1550303647.510 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:07.914Z,1550303647.914 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:08.317Z,1550303648.317 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:08.722Z,1550303648.722 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:09.125Z,1550303649.125 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:09.530Z,1550303649.530 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:09.934Z,1550303649.934 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:10.337Z,1550303650.337 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:10.742Z,1550303650.742 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:11.146Z,1550303651.146 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:11.550Z,1550303651.550 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:11.954Z,1550303651.954 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:12.358Z,1550303652.358 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:12.761Z,1550303652.761 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:13.166Z,1550303653.166 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:13.570Z,1550303653.570 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:13.973Z,1550303653.973 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:14.378Z,1550303654.378 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:14.782Z,1550303654.782 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:15.185Z,1550303655.185 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:15.590Z,1550303655.590 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:15.994Z,1550303655.994 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:16.397Z,1550303656.397 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:16.691Z,1550303656.691 [Default:A.Wait](INFO): Done Waiting. 2019-02-16T07:54:16.691Z,1550303656.691 [Default:A.Wait] Stopped 2019-02-16T07:54:16.691Z,1550303656.691 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2019-02-16T07:54:16.802Z,1550303656.802 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:17.102Z,1550303657.102 [Default:CheckIn] Running Loop=1 2019-02-16T07:54:17.102Z,1550303657.102 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2019-02-16T07:54:17.102Z,1550303657.102 [Default:CheckIn:Read_GPS] Running Loop=1 2019-02-16T07:54:17.206Z,1550303657.206 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:17.510Z,1550303657.510 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2019-02-16T07:54:17.610Z,1550303657.610 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:18.014Z,1550303658.014 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:18.418Z,1550303658.418 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:18.821Z,1550303658.821 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:19.226Z,1550303659.226 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:19.630Z,1550303659.630 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:20.033Z,1550303660.033 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:20.438Z,1550303660.438 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:20.842Z,1550303660.842 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:21.246Z,1550303661.246 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:21.650Z,1550303661.650 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:22.058Z,1550303662.058 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:22.462Z,1550303662.462 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:22.866Z,1550303662.866 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:23.270Z,1550303663.270 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:23.673Z,1550303663.673 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:24.078Z,1550303664.078 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:24.482Z,1550303664.482 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:24.885Z,1550303664.885 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:25.291Z,1550303665.291 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:25.694Z,1550303665.694 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:26.097Z,1550303666.097 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:26.502Z,1550303666.502 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:26.906Z,1550303666.906 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:27.310Z,1550303667.310 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:27.714Z,1550303667.714 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:28.118Z,1550303668.118 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:28.533Z,1550303668.533 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:28.942Z,1550303668.942 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:29.342Z,1550303669.342 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:29.745Z,1550303669.745 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:30.150Z,1550303670.150 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:30.554Z,1550303670.554 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:30.957Z,1550303670.957 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:31.362Z,1550303671.362 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:31.766Z,1550303671.766 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:32.169Z,1550303672.169 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:32.574Z,1550303672.574 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:32.978Z,1550303672.978 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:33.381Z,1550303673.381 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:33.786Z,1550303673.786 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:34.190Z,1550303674.190 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:34.593Z,1550303674.593 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:34.998Z,1550303674.998 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:35.402Z,1550303675.402 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:35.806Z,1550303675.806 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:36.210Z,1550303676.210 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:36.614Z,1550303676.614 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:37.017Z,1550303677.017 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:37.422Z,1550303677.422 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:37.826Z,1550303677.826 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:38.229Z,1550303678.229 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:38.634Z,1550303678.634 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:39.037Z,1550303679.037 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:39.441Z,1550303679.441 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:39.846Z,1550303679.846 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:40.250Z,1550303680.250 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:40.653Z,1550303680.653 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:41.058Z,1550303681.058 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:41.462Z,1550303681.462 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:41.865Z,1550303681.865 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:42.270Z,1550303682.270 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:42.674Z,1550303682.674 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:43.078Z,1550303683.078 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:43.482Z,1550303683.482 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:43.886Z,1550303683.886 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:44.289Z,1550303684.289 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:44.694Z,1550303684.694 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:45.098Z,1550303685.098 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:45.502Z,1550303685.502 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:45.906Z,1550303685.906 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:46.310Z,1550303686.310 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:46.657Z,1550303686.657 [Rowe_600LCM](FAULT): Did not receive valid device response within the specified allowable sample time. 2019-02-16T07:54:46.657Z,1550303686.657 [Rowe_600LCM] Communications Fault, FailCount= 2 2019-02-16T07:54:46.657Z,1550303686.657 [Rowe_600LCM](ERROR): Communications Fault 2019-02-16T07:54:46.713Z,1550303686.713 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:47.006Z,1550303687.006 [CBIT](ERROR): Communications Fault in component: Rowe_600LCM 2019-02-16T07:54:47.062Z,1550303687.062 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface 2019-02-16T07:54:47.118Z,1550303687.118 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:47.182Z,1550303687.182 [Rowe_600LCM](INFO): Powering down 2019-02-16T07:54:47.522Z,1550303687.522 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:47.925Z,1550303687.925 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:48.330Z,1550303688.330 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:48.637Z,1550303688.637 [CBIT](INFO): Clearing failed state for component Rowe_600LCM 2019-02-16T07:54:48.637Z,1550303688.637 [Rowe_600LCM] No Fault, FailCount= 2 2019-02-16T07:54:48.734Z,1550303688.734 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:48.798Z,1550303688.798 [Rowe_600LCM](INFO): Initializing 2019-02-16T07:54:48.798Z,1550303688.798 [Rowe_600LCM](INFO): Powering up 2019-02-16T07:54:49.137Z,1550303689.137 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:49.542Z,1550303689.542 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:49.946Z,1550303689.946 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:50.350Z,1550303690.350 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:50.754Z,1550303690.754 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:51.158Z,1550303691.158 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:51.561Z,1550303691.561 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:51.966Z,1550303691.966 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:52.371Z,1550303692.371 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:52.773Z,1550303692.773 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:52.922Z,1550303692.922 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface 2019-02-16T07:54:52.982Z,1550303692.982 [Rowe_600LCM](INFO): Started Rowe LCM interface with command:nohup ./lrauv-framework/onboard/bin/roweadcp -ldir /mnt/mmc/LRAUV/Logs/latest/ -dev /dev/ttyB4 -b 9600 >& /dev/null & 2019-02-16T07:54:53.178Z,1550303693.178 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:53.582Z,1550303693.582 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:53.985Z,1550303693.985 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:54.390Z,1550303694.390 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:54.794Z,1550303694.794 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:55.198Z,1550303695.198 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:55.602Z,1550303695.602 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:56.006Z,1550303696.006 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:56.410Z,1550303696.410 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:56.814Z,1550303696.814 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:57.218Z,1550303697.218 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:57.621Z,1550303697.621 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:58.026Z,1550303698.026 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:58.430Z,1550303698.430 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:58.833Z,1550303698.833 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:59.239Z,1550303699.239 [Radio_Surface](INFO): Runnable 2019-02-16T07:54:59.642Z,1550303699.642 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:00.045Z,1550303700.045 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:00.450Z,1550303700.450 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:00.854Z,1550303700.854 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:01.257Z,1550303701.257 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:01.662Z,1550303701.662 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:02.066Z,1550303702.066 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:02.469Z,1550303702.469 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:02.873Z,1550303702.873 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:03.278Z,1550303703.278 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:03.681Z,1550303703.681 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:04.086Z,1550303704.086 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:04.490Z,1550303704.490 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:04.893Z,1550303704.893 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:05.298Z,1550303705.298 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:05.703Z,1550303705.703 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:06.105Z,1550303706.105 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:06.510Z,1550303706.510 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:06.914Z,1550303706.914 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:07.317Z,1550303707.317 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:07.722Z,1550303707.722 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:08.126Z,1550303708.126 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:08.530Z,1550303708.530 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:08.934Z,1550303708.934 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:09.338Z,1550303709.338 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:09.741Z,1550303709.741 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:10.146Z,1550303710.146 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:10.550Z,1550303710.550 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:10.953Z,1550303710.953 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:11.358Z,1550303711.358 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:11.762Z,1550303711.762 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:12.165Z,1550303712.165 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:12.570Z,1550303712.570 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:12.974Z,1550303712.974 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:13.378Z,1550303713.378 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:13.782Z,1550303713.782 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:14.186Z,1550303714.186 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:14.589Z,1550303714.589 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:14.994Z,1550303714.994 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:15.398Z,1550303715.398 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:15.802Z,1550303715.802 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:16.205Z,1550303716.205 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:16.610Z,1550303716.610 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:17.013Z,1550303717.013 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:17.418Z,1550303717.418 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:17.822Z,1550303717.822 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:18.041Z,1550303718.041 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004920 2019-02-16T07:55:18.226Z,1550303718.226 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:18.630Z,1550303718.630 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:19.033Z,1550303719.033 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:19.438Z,1550303719.438 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:19.842Z,1550303719.842 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:20.246Z,1550303720.246 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:20.650Z,1550303720.650 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:21.054Z,1550303721.054 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:21.458Z,1550303721.458 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:21.862Z,1550303721.862 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:22.266Z,1550303722.266 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:22.670Z,1550303722.670 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:23.074Z,1550303723.074 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:23.478Z,1550303723.478 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:23.882Z,1550303723.882 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:24.286Z,1550303724.286 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:24.690Z,1550303724.690 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:25.094Z,1550303725.094 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:25.498Z,1550303725.498 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:25.902Z,1550303725.902 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:26.306Z,1550303726.306 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:26.709Z,1550303726.709 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:27.114Z,1550303727.114 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:27.518Z,1550303727.518 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:27.921Z,1550303727.921 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:28.326Z,1550303728.326 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:28.730Z,1550303728.730 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:29.133Z,1550303729.133 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:29.538Z,1550303729.538 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:29.942Z,1550303729.942 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:30.345Z,1550303730.345 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:30.750Z,1550303730.750 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:31.154Z,1550303731.154 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:31.557Z,1550303731.557 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:31.962Z,1550303731.962 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:32.366Z,1550303732.366 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:32.769Z,1550303732.769 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:33.174Z,1550303733.174 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:33.578Z,1550303733.578 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:33.981Z,1550303733.981 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:34.386Z,1550303734.386 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:34.790Z,1550303734.790 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:35.194Z,1550303735.194 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:35.598Z,1550303735.598 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:36.002Z,1550303736.002 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:36.405Z,1550303736.405 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:36.810Z,1550303736.810 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:37.214Z,1550303737.214 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:37.617Z,1550303737.617 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:38.022Z,1550303738.022 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:38.426Z,1550303738.426 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:38.830Z,1550303738.830 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:39.234Z,1550303739.234 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:39.638Z,1550303739.638 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:40.041Z,1550303740.041 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:40.446Z,1550303740.446 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:40.850Z,1550303740.850 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:41.253Z,1550303741.253 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:41.658Z,1550303741.658 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:42.062Z,1550303742.062 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:42.465Z,1550303742.465 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:42.871Z,1550303742.871 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:43.273Z,1550303743.273 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:43.678Z,1550303743.678 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:44.082Z,1550303744.082 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:44.486Z,1550303744.486 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:44.889Z,1550303744.889 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:45.294Z,1550303745.294 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:45.698Z,1550303745.698 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:46.103Z,1550303746.103 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:46.506Z,1550303746.506 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:46.910Z,1550303746.910 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:47.314Z,1550303747.314 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:47.718Z,1550303747.718 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:48.122Z,1550303748.122 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:48.526Z,1550303748.526 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:48.930Z,1550303748.930 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:49.334Z,1550303749.334 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:49.738Z,1550303749.738 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:50.142Z,1550303750.142 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:50.546Z,1550303750.546 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:50.949Z,1550303750.949 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:51.354Z,1550303751.354 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:51.758Z,1550303751.758 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:52.161Z,1550303752.161 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:52.567Z,1550303752.567 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:52.969Z,1550303752.969 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:53.373Z,1550303753.373 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:53.778Z,1550303753.778 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:54.181Z,1550303754.181 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:54.590Z,1550303754.590 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:54.994Z,1550303754.994 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:55.398Z,1550303755.398 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:55.802Z,1550303755.802 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:56.207Z,1550303756.207 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:56.610Z,1550303756.610 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:57.013Z,1550303757.013 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:57.418Z,1550303757.418 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:57.787Z,1550303757.787 [CommandLine](IMPORTANT): got command restart application 2019-02-16T07:55:57.822Z,1550303757.822 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:58.225Z,1550303758.225 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:58.630Z,1550303758.630 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:58.797Z,1550303758.797 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2019-02-16T07:55:58.797Z,1550303758.797 [CommandLine ThreadHandler](INFO): Thread cancelled. 2019-02-16T07:55:58.865Z,1550303758.865 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2019-02-16T07:55:58.866Z,1550303758.866 [CommandLine ThreadHandler](INFO): Thread cancelled. 2019-02-16T07:55:58.866Z,1550303758.866 [CommandLine](INFO): Join timeout helper Thread ID is 7358 2019-02-16T07:55:58.867Z,1550303758.867 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2019-02-16T07:55:58.867Z,1550303758.867 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2019-02-16T07:55:58.871Z,1550303758.871 [NavChartDb](INFO): Join timeout helper Thread ID is 7359 2019-02-16T07:55:59.034Z,1550303759.034 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:59.218Z,1550303759.218 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2019-02-16T07:55:59.218Z,1550303759.218 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2019-02-16T07:55:59.229Z,1550303759.229 [ComponentRegistry](INFO): Shutting down Rowe_600LCM ThreadHandler 2019-02-16T07:55:59.229Z,1550303759.229 [Rowe_600LCM ThreadHandler](INFO): Thread cancelled. 2019-02-16T07:55:59.230Z,1550303759.230 [Rowe_600LCM](INFO): Join timeout helper Thread ID is 7360 2019-02-16T07:55:59.438Z,1550303759.438 [Radio_Surface](INFO): Runnable 2019-02-16T07:55:59.498Z,1550303759.498 [Rowe_600LCM ThreadHandler](INFO): Uninitializing protected caller thread. 2019-02-16T07:55:59.499Z,1550303759.499 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface 2019-02-16T07:55:59.589Z,1550303759.589 [Rowe_600LCM](INFO): Powering down 2019-02-16T07:55:59.590Z,1550303759.590 [Rowe_600LCM ThreadHandler](INFO): Thread cancelled. 2019-02-16T07:55:59.597Z,1550303759.597 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2019-02-16T07:55:59.598Z,1550303759.598 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2019-02-16T07:55:59.598Z,1550303759.598 [Radio_Surface](INFO): Join timeout helper Thread ID is 7362 2019-02-16T07:55:59.842Z,1550303759.842 [Radio_Surface](INFO): Stop 2019-02-16T07:55:59.842Z,1550303759.842 [Radio_Surface](INFO): Powering down 2019-02-16T07:55:59.843Z,1550303759.843 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2019-02-16T07:55:59.843Z,1550303759.843 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2019-02-16T07:55:59.861Z,1550303759.861 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2019-02-16T07:55:59.862Z,1550303759.862 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2019-02-16T07:55:59.862Z,1550303759.862 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 7363 2019-02-16T07:55:59.902Z,1550303759.902 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2019-02-16T07:55:59.902Z,1550303759.902 [WetLabsBB2FL](INFO): Powering down 2019-02-16T07:55:59.903Z,1550303759.903 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2019-02-16T07:55:59.922Z,1550303759.922 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2019-02-16T07:55:59.923Z,1550303759.923 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2019-02-16T07:55:59.923Z,1550303759.923 [CTD_Seabird](INFO): Join timeout helper Thread ID is 7364 2019-02-16T07:56:00.117Z,1550303760.117 [Reporter](INFO): Radio_Surface.radio_surface_power no_value 2019-02-16T07:56:00.294Z,1550303760.294 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2019-02-16T07:56:00.294Z,1550303760.294 [CTD_Seabird](INFO): Powering down 2019-02-16T07:56:00.305Z,1550303760.305 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2019-02-16T07:56:00.323Z,1550303760.323 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2019-02-16T07:56:00.323Z,1550303760.323 [logger ThreadHandler](INFO): Thread cancelled. 2019-02-16T07:56:00.324Z,1550303760.324 [logger](INFO): Join timeout helper Thread ID is 7365 2019-02-16T07:56:00.390Z,1550303760.390 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2019-02-16T07:56:00.390Z,1550303760.390 [logger ThreadHandler](INFO): Thread cancelled. 2019-02-16T07:56:00.402Z,1550303760.402 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2019-02-16T07:56:00.402Z,1550303760.402 [CommandLine ThreadHandler](INFO): Thread cancelled. 2019-02-16T07:56:00.402Z,1550303760.402 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2019-02-16T07:56:00.403Z,1550303760.403 [controlThread ThreadHandler](INFO): Thread cancelled. 2019-02-16T07:56:00.403Z,1550303760.403 [controlThread](INFO): Join timeout helper Thread ID is 7366 2019-02-16T07:56:00.445Z,1550303760.445 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2019-02-16T07:56:00.446Z,1550303760.446 [controlThread](DEBUG): Uninitializing ControlThread 2019-02-16T07:56:00.446Z,1550303760.446 [Aanderaa_O2](INFO): Powering down 2019-02-16T07:56:00.449Z,1550303760.449 [AcousticModem_Benthos_ATM900](INFO): Powering down 2019-02-16T07:56:00.570Z,1550303760.570 [NAL9602](INFO): Powering down 2019-02-16T07:56:00.571Z,1550303760.571 [PNI_TCM](INFO): Powering down 2019-02-16T07:56:00.658Z,1550303760.658 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2019-02-16T07:56:00.659Z,1550303760.659 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2019-02-16T07:56:00.660Z,1550303760.660 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2019-02-16T07:56:00.660Z,1550303760.660 [MissionManager](INFO): Uninitializing Mission Default 2019-02-16T07:56:00.661Z,1550303760.661 [Default] Stopped 2019-02-16T07:56:00.661Z,1550303760.661 [Default](DEBUG): Aggregate::uninitialize Default 2019-02-16T07:56:00.661Z,1550303760.661 [Default:B.GoToSurface] Stopped 2019-02-16T07:56:00.661Z,1550303760.661 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2019-02-16T07:56:00.661Z,1550303760.661 [Default:CheckIn] Stopped 2019-02-16T07:56:00.661Z,1550303760.661 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2019-02-16T07:56:00.661Z,1550303760.661 [Default:CheckIn:Read_GPS] Stopped 2019-02-16T07:56:00.664Z,1550303760.664 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2019-02-16T07:56:00.665Z,1550303760.665 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2019-02-16T07:56:00.665Z,1550303760.665 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2019-02-16T07:56:00.665Z,1550303760.665 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2019-02-16T07:56:00.666Z,1550303760.666 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2019-02-16T07:56:00.666Z,1550303760.666 [BuoyancyServo](INFO): Powering down 2019-02-16T07:56:00.677Z,1550303760.677 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2019-02-16T07:56:00.678Z,1550303760.678 [ElevatorServo](INFO): Powering down 2019-02-16T07:56:00.678Z,1550303760.678 [MassServo](DEBUG): Uninitialize Mass Servo. 2019-02-16T07:56:00.679Z,1550303760.679 [MassServo](INFO): Powering down 2019-02-16T07:56:00.679Z,1550303760.679 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2019-02-16T07:56:00.680Z,1550303760.680 [RudderServo](INFO): Powering down 2019-02-16T07:56:00.680Z,1550303760.680 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2019-02-16T07:56:00.681Z,1550303760.681 [ThrusterServo](INFO): Powering down 2019-02-16T07:56:00.682Z,1550303760.682 [SBIT](DEBUG): Uninitialize SBIT Component. 2019-02-16T07:56:00.682Z,1550303760.682 [IBIT](DEBUG): Uninitialize IBIT Component. 2019-02-16T07:56:00.682Z,1550303760.682 [CBIT](DEBUG): Uninitialize CBIT Component. 2019-02-16T07:56:00.682Z,1550303760.682 [CBIT](DEBUG): Powering off loads. 2019-02-16T07:56:00.693Z,1550303760.693 [CBIT](DEBUG): Disabling WDT. 2019-02-16T07:56:00.705Z,1550303760.705 [CBIT](DEBUG): Opening all GF detection circuits. 2019-02-16T07:56:00.706Z,1550303760.706 [controlThread ThreadHandler](INFO): Thread cancelled. 2019-02-16T07:56:00.764Z,1550303760.764 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2019-02-16T07:56:00.769Z,1550303760.769 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2019-02-16T07:56:00.850Z,1550303760.850 [Rowe_600LCM ThreadHandler](INFO): Thread cancelled. 2019-02-16T07:56:00.855Z,1550303760.855 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2019-02-16T07:56:00.918Z,1550303760.918 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2019-02-16T07:56:00.977Z,1550303760.977 [logger ThreadHandler](INFO): Thread cancelled.