2019-10-17T01:03:04.394Z,1571274184.394 [Supervisor](DEBUG): Initializing supervisor.
2019-10-17T01:03:04.397Z,1571274184.397 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2019-10-17T01:03:04.398Z,1571274184.398 [SyncHandler](INFO): Protected caller Thread ID is 1405
2019-10-17T01:03:04.398Z,1571274184.398 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2019-10-17T01:03:04.399Z,1571274184.399 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2019-10-17T01:03:04.399Z,1571274184.399 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 1406
2019-10-17T01:03:04.402Z,1571274184.402 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2019-10-17T01:03:04.413Z,1571274184.413 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2019-10-17T01:03:04.414Z,1571274184.414 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2019-10-17T01:03:04.414Z,1571274184.414 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 1407
2019-10-17T01:03:04.415Z,1571274184.415 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2019-10-17T01:03:04.416Z,1571274184.416 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2019-10-17T01:03:04.416Z,1571274184.416 [logger ThreadHandler](INFO): Protected caller Thread ID is 1408
2019-10-17T01:03:04.418Z,1571274184.418 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2019-10-17T01:03:04.418Z,1571274184.418 [Supervisor](INFO): Looking for Config files in directory: Config/
2019-10-17T01:03:04.420Z,1571274184.420 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2019-10-17T01:03:04.612Z,1571274184.612 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2019-10-17T01:03:04.613Z,1571274184.613 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2019-10-17T01:03:04.691Z,1571274184.691 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2019-10-17T01:03:05.110Z,1571274185.110 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2019-10-17T01:03:05.110Z,1571274185.110 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2019-10-17T01:03:05.426Z,1571274185.426 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2019-10-17T01:03:05.427Z,1571274185.427 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2019-10-17T01:03:05.519Z,1571274185.519 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2019-10-17T01:03:05.520Z,1571274185.520 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2019-10-17T01:03:05.807Z,1571274185.807 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2019-10-17T01:03:05.808Z,1571274185.808 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2019-10-17T01:03:05.996Z,1571274185.996 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2019-10-17T01:03:05.997Z,1571274185.997 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2019-10-17T01:03:06.435Z,1571274186.435 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2019-10-17T01:03:06.436Z,1571274186.436 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2019-10-17T01:03:06.539Z,1571274186.539 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2019-10-17T01:03:06.539Z,1571274186.539 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2019-10-17T01:03:06.638Z,1571274186.638 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2019-10-17T01:03:06.638Z,1571274186.638 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2019-10-17T01:03:07.292Z,1571274187.292 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2019-10-17T01:03:07.292Z,1571274187.292 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2019-10-17T01:03:07.675Z,1571274187.675 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2019-10-17T01:03:07.675Z,1571274187.675 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2019-10-17T01:03:07.861Z,1571274187.861 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2019-10-17T01:03:07.862Z,1571274187.862 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2019-10-17T01:03:08.003Z,1571274188.003 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2019-10-17T01:03:08.003Z,1571274188.003 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2019-10-17T01:03:08.148Z,1571274188.148 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2019-10-17T01:03:08.150Z,1571274188.150 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-daphne/
2019-10-17T01:03:08.151Z,1571274188.151 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Navigation.cfg
2019-10-17T01:03:08.239Z,1571274188.239 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Simulator.cfg
2019-10-17T01:03:08.323Z,1571274188.323 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Control.cfg
2019-10-17T01:03:08.424Z,1571274188.424 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/secure.cfg
2019-10-17T01:03:08.506Z,1571274188.506 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Servo.cfg
2019-10-17T01:03:08.599Z,1571274188.599 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/BIT.cfg
2019-10-17T01:03:08.697Z,1571274188.697 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/vehicle.cfg
2019-10-17T01:03:08.900Z,1571274188.900 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/workSite.cfg
2019-10-17T01:03:08.975Z,1571274188.975 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Sensor.cfg
2019-10-17T01:03:09.156Z,1571274189.156 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Science.cfg
2019-10-17T01:03:09.815Z,1571274189.815 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/logger.cfg
2019-10-17T01:03:10.063Z,1571274190.063 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Battery.cfg
2019-10-17T01:03:10.468Z,1571274190.468 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2019-10-17T01:03:10.470Z,1571274190.470 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-daphne/root/
2019-10-17T01:03:10.470Z,1571274190.470 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2019-10-17T01:03:10.475Z,1571274190.475 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2019-10-17T01:03:10.542Z,1571274190.542 [VerticalControl](DEBUG): Construct VerticalControl.
2019-10-17T01:03:10.653Z,1571274190.653 [VerticalControl] Loaded
2019-10-17T01:03:10.653Z,1571274190.653 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2019-10-17T01:03:10.654Z,1571274190.654 [HorizontalControl](DEBUG): Construct HorizontalControl.
2019-10-17T01:03:10.721Z,1571274190.721 [HorizontalControl] Loaded
2019-10-17T01:03:10.722Z,1571274190.722 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2019-10-17T01:03:10.722Z,1571274190.722 [SpeedControl](DEBUG): Construct SpeedControl.
2019-10-17T01:03:10.728Z,1571274190.728 [SpeedControl] Loaded
2019-10-17T01:03:10.728Z,1571274190.728 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2019-10-17T01:03:10.729Z,1571274190.729 [LoopControl](DEBUG): Construct LoopControl.
2019-10-17T01:03:10.729Z,1571274190.729 [LoopControl] Loaded
2019-10-17T01:03:10.730Z,1571274190.730 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2019-10-17T01:03:10.730Z,1571274190.730 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2019-10-17T01:03:10.731Z,1571274190.731 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2019-10-17T01:03:10.743Z,1571274190.743 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2019-10-17T01:03:10.744Z,1571274190.744 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2019-10-17T01:03:10.842Z,1571274190.842 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2019-10-17T01:03:10.843Z,1571274190.843 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2019-10-17T01:03:10.943Z,1571274190.943 [BuoyancyServo] Loaded
2019-10-17T01:03:10.943Z,1571274190.943 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2019-10-17T01:03:10.955Z,1571274190.955 [ElevatorServo] Loaded
2019-10-17T01:03:10.955Z,1571274190.955 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2019-10-17T01:03:10.966Z,1571274190.966 [MassServo] Loaded
2019-10-17T01:03:10.966Z,1571274190.966 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2019-10-17T01:03:10.977Z,1571274190.977 [RudderServo] Loaded
2019-10-17T01:03:10.977Z,1571274190.977 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2019-10-17T01:03:10.988Z,1571274190.988 [ThrusterServo] Loaded
2019-10-17T01:03:10.988Z,1571274190.988 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2019-10-17T01:03:10.989Z,1571274190.989 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2019-10-17T01:03:10.989Z,1571274190.989 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2019-10-17T01:03:11.095Z,1571274191.095 [DeadReckonUsingMultipleVelocitySources] Loaded
2019-10-17T01:03:11.096Z,1571274191.096 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2019-10-17T01:03:11.116Z,1571274191.116 [NavChart] Loaded
2019-10-17T01:03:11.116Z,1571274191.116 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2019-10-17T01:03:11.120Z,1571274191.120 [UniversalFixResidualReporter] Loaded
2019-10-17T01:03:11.120Z,1571274191.120 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2019-10-17T01:03:11.121Z,1571274191.121 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2019-10-17T01:03:11.121Z,1571274191.121 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2019-10-17T01:03:11.192Z,1571274191.192 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2019-10-17T01:03:11.192Z,1571274191.192 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2019-10-17T01:03:11.451Z,1571274191.451 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_orientation
2019-10-17T01:03:11.456Z,1571274191.456 [AHRS_M2](INFO): created writer for : platform_orientation
2019-10-17T01:03:11.458Z,1571274191.458 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_magnetic_orientation
2019-10-17T01:03:11.463Z,1571274191.463 [AHRS_M2](INFO): created writer for : platform_magnetic_orientation
2019-10-17T01:03:11.463Z,1571274191.463 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_pitch_angle
2019-10-17T01:03:11.468Z,1571274191.468 [AHRS_M2](INFO): created writer for : platform_pitch_angle
2019-10-17T01:03:11.469Z,1571274191.469 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_roll_angle
2019-10-17T01:03:11.474Z,1571274191.474 [AHRS_M2](INFO): created writer for : platform_roll_angle
2019-10-17T01:03:11.544Z,1571274191.544 [AHRS_M2] Loaded
2019-10-17T01:03:11.544Z,1571274191.544 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2019-10-17T01:03:11.621Z,1571274191.621 [DataOverHttps] Loaded
2019-10-17T01:03:11.621Z,1571274191.621 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2019-10-17T01:03:11.622Z,1571274191.622 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 4087D4E0
2019-10-17T01:03:11.623Z,1571274191.623 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 1491
2019-10-17T01:03:11.636Z,1571274191.636 [Depth_Keller] Loaded
2019-10-17T01:03:11.636Z,1571274191.636 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2019-10-17T01:03:11.641Z,1571274191.641 [DropWeight] Loaded
2019-10-17T01:03:11.641Z,1571274191.641 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2019-10-17T01:03:11.736Z,1571274191.736 [NAL9602] Loaded
2019-10-17T01:03:11.737Z,1571274191.737 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2019-10-17T01:03:11.752Z,1571274191.752 [Onboard] Loaded
2019-10-17T01:03:11.752Z,1571274191.752 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2019-10-17T01:03:11.755Z,1571274191.755 [Radio_Surface] Loaded
2019-10-17T01:03:11.756Z,1571274191.756 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2019-10-17T01:03:11.757Z,1571274191.757 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 408AD4E0
2019-10-17T01:03:11.757Z,1571274191.757 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 1492
2019-10-17T01:03:13.246Z,1571274193.246 [BPC1] Loaded
2019-10-17T01:03:13.246Z,1571274193.246 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2019-10-17T01:03:13.246Z,1571274193.246 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2019-10-17T01:03:13.247Z,1571274193.247 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2019-10-17T01:03:13.288Z,1571274193.288 [DepthRateCalculator] Loaded
2019-10-17T01:03:13.288Z,1571274193.288 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2019-10-17T01:03:13.293Z,1571274193.293 [PitchRateCalculator] Loaded
2019-10-17T01:03:13.294Z,1571274193.294 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2019-10-17T01:03:13.305Z,1571274193.305 [SpeedCalculator] Loaded
2019-10-17T01:03:13.305Z,1571274193.305 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2019-10-17T01:03:13.326Z,1571274193.326 [TempGradientCalculator] Loaded
2019-10-17T01:03:13.327Z,1571274193.327 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2019-10-17T01:03:13.332Z,1571274193.332 [YawRateCalculator] Loaded
2019-10-17T01:03:13.332Z,1571274193.332 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2019-10-17T01:03:13.361Z,1571274193.361 [ElevatorOffsetCalculator] Loaded
2019-10-17T01:03:13.361Z,1571274193.361 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2019-10-17T01:03:13.362Z,1571274193.362 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2019-10-17T01:03:13.362Z,1571274193.362 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2019-10-17T01:03:13.545Z,1571274193.545 [Aanderaa_O2] Loaded
2019-10-17T01:03:13.545Z,1571274193.545 [ComponentRegistry](DEBUG): SyncComponent "Aanderaa_O2" handled in the control thread.
2019-10-17T01:03:13.554Z,1571274193.554 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_density
2019-10-17T01:03:13.560Z,1571274193.560 [CTD_Seabird](INFO): created writer for : sea_water_density
2019-10-17T01:03:13.560Z,1571274193.560 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): depth
2019-10-17T01:03:13.565Z,1571274193.565 [CTD_Seabird](INFO): created writer for : depth
2019-10-17T01:03:13.565Z,1571274193.565 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_pressure
2019-10-17T01:03:13.570Z,1571274193.570 [CTD_Seabird](INFO): created writer for : sea_water_pressure
2019-10-17T01:03:13.571Z,1571274193.571 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_salinity
2019-10-17T01:03:13.576Z,1571274193.576 [CTD_Seabird](INFO): created writer for : sea_water_salinity
2019-10-17T01:03:13.577Z,1571274193.577 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_temperature
2019-10-17T01:03:13.582Z,1571274193.582 [CTD_Seabird](INFO): created writer for : sea_water_temperature
2019-10-17T01:03:13.583Z,1571274193.583 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_electrical_conductivity
2019-10-17T01:03:13.588Z,1571274193.588 [CTD_Seabird](INFO): created writer for : sea_water_electrical_conductivity
2019-10-17T01:03:13.588Z,1571274193.588 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): speed_of_sound_in_sea_water
2019-10-17T01:03:13.594Z,1571274193.594 [CTD_Seabird](INFO): created writer for : speed_of_sound_in_sea_water
2019-10-17T01:03:13.620Z,1571274193.620 [CTD_Seabird] Loaded
2019-10-17T01:03:13.620Z,1571274193.620 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2019-10-17T01:03:13.621Z,1571274193.621 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 409B04E0
2019-10-17T01:03:13.622Z,1571274193.622 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 1493
2019-10-17T01:03:13.636Z,1571274193.636 [PAR_Licor] Loaded
2019-10-17T01:03:13.636Z,1571274193.636 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2019-10-17T01:03:13.683Z,1571274193.683 [WetLabsBB2FL] Loaded
2019-10-17T01:03:13.684Z,1571274193.684 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2019-10-17T01:03:13.685Z,1571274193.685 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 409E04E0
2019-10-17T01:03:13.685Z,1571274193.685 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 1494
2019-10-17T01:03:13.686Z,1571274193.686 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2019-10-17T01:03:13.686Z,1571274193.686 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2019-10-17T01:03:13.719Z,1571274193.719 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2019-10-17T01:03:13.720Z,1571274193.720 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2019-10-17T01:03:14.008Z,1571274194.008 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2019-10-17T01:03:14.008Z,1571274194.008 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2019-10-17T01:03:14.138Z,1571274194.138 [SBIT](DEBUG): Construct Startup Built In Test.
2019-10-17T01:03:14.149Z,1571274194.149 [SBIT] Loaded
2019-10-17T01:03:14.150Z,1571274194.150 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2019-10-17T01:03:14.150Z,1571274194.150 [IBIT](DEBUG): Construct Initiated Built In Test.
2019-10-17T01:03:14.162Z,1571274194.162 [IBIT] Loaded
2019-10-17T01:03:14.162Z,1571274194.162 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2019-10-17T01:03:14.165Z,1571274194.165 [CBIT](DEBUG): Construct Continuous Built In Test.
2019-10-17T01:03:14.302Z,1571274194.302 [CBIT] Loaded
2019-10-17T01:03:14.302Z,1571274194.302 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2019-10-17T01:03:14.303Z,1571274194.303 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2019-10-17T01:03:14.340Z,1571274194.340 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2019-10-17T01:03:14.340Z,1571274194.340 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2019-10-17T01:03:14.403Z,1571274194.403 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2019-10-17T01:03:14.404Z,1571274194.404 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40ADF4E0
2019-10-17T01:03:14.404Z,1571274194.404 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 1495
2019-10-17T01:03:14.417Z,1571274194.417 [Supervisor](INFO): Main Thread ID is 1404
2019-10-17T01:03:14.417Z,1571274194.417 [Supervisor](DEBUG): Running supervisor.
2019-10-17T01:03:14.418Z,1571274194.418 [CommandLine ThreadHandler](INFO): Handler Thread ID is 1496
2019-10-17T01:03:14.421Z,1571274194.421 [logger ThreadHandler](INFO): Handler Thread ID is 1498
2019-10-17T01:03:14.445Z,1571274194.445 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 1499
2019-10-17T01:03:14.447Z,1571274194.447 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2019-10-17T01:03:14.453Z,1571274194.453 [controlThread ThreadHandler](INFO): Handler Thread ID is 1497
2019-10-17T01:03:14.453Z,1571274194.453 [controlThread](DEBUG): Initializing ControlThread
2019-10-17T01:03:14.454Z,1571274194.454 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2019-10-17T01:03:14.455Z,1571274194.455 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2019-10-17T01:03:14.456Z,1571274194.456 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2019-10-17T01:03:14.456Z,1571274194.456 [LoopControl](DEBUG): Initialize LoopControlComponent.
2019-10-17T01:03:14.458Z,1571274194.458 [NavChart](DEBUG): Initialize NavChart Navigation.
2019-10-17T01:03:14.459Z,1571274194.459 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2019-10-17T01:03:14.470Z,1571274194.470 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 1500
2019-10-17T01:03:14.471Z,1571274194.471 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 1501
2019-10-17T01:03:14.472Z,1571274194.472 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2019-10-17T01:03:14.474Z,1571274194.474 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 1503
2019-10-17T01:03:14.476Z,1571274194.476 [WetLabsBB2FL](INFO): Powering down
2019-10-17T01:03:14.480Z,1571274194.480 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 1504
2019-10-17T01:03:14.484Z,1571274194.484 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2019-10-17T01:03:14.484Z,1571274194.484 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2019-10-17T01:03:14.484Z,1571274194.484 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2019-10-17T01:03:14.484Z,1571274194.484 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2019-10-17T01:03:14.484Z,1571274194.484 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2019-10-17T01:03:14.486Z,1571274194.486 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2019-10-17T01:03:14.487Z,1571274194.487 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2019-10-17T01:03:14.487Z,1571274194.487 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2019-10-17T01:03:14.487Z,1571274194.487 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2019-10-17T01:03:14.487Z,1571274194.487 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2019-10-17T01:03:14.487Z,1571274194.487 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2019-10-17T01:03:14.488Z,1571274194.488 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2019-10-17T01:03:14.488Z,1571274194.488 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2019-10-17T01:03:14.488Z,1571274194.488 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2019-10-17T01:03:14.488Z,1571274194.488 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2019-10-17T01:03:14.488Z,1571274194.488 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2019-10-17T01:03:14.488Z,1571274194.488 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2019-10-17T01:03:14.498Z,1571274194.498 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2019-10-17T01:03:14.499Z,1571274194.499 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2019-10-17T01:03:14.499Z,1571274194.499 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2019-10-17T01:03:14.499Z,1571274194.499 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2019-10-17T01:03:14.500Z,1571274194.500 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2019-10-17T01:03:14.500Z,1571274194.500 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2019-10-17T01:03:14.509Z,1571274194.509 [SBIT](INFO): Initialize SBIT Component.
2019-10-17T01:03:14.510Z,1571274194.510 [SBIT](IMPORTANT): git: 2019-09-10
2019-10-17T01:03:14.510Z,1571274194.510 [SBIT](INFO): git hash: e950883795b57abbf97d89589ea0268241928c93
2019-10-17T01:03:14.510Z,1571274194.510 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2019-10-17T01:03:14.511Z,1571274194.511 [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-10-17T01:03:14.512Z,1571274194.512 [SBIT](INFO): Beginning SBIT in 23.000000 seconds.
2019-10-17T01:03:14.527Z,1571274194.527 [IBIT](INFO): Initialize IBIT Component.
2019-10-17T01:03:14.528Z,1571274194.528 [CBIT](DEBUG): Initialize CBIT Component.
2019-10-17T01:03:14.541Z,1571274194.541 [CBIT](DEBUG): Initialized mux pins.
2019-10-17T01:03:14.541Z,1571274194.541 [CBIT](DEBUG): Initializing the watchdog timer.
2019-10-17T01:03:14.565Z,1571274194.565 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2019-10-17T01:03:14.565Z,1571274194.565 [CBIT](DEBUG): Initializing heartbeat.
2019-10-17T01:03:14.637Z,1571274194.637 [CBIT](DEBUG): Deactivating GF circuits.
2019-10-17T01:03:14.637Z,1571274194.637 [CBIT](DEBUG): Deactivating emergency mode.
2019-10-17T01:03:14.673Z,1571274194.673 [CBIT](DEBUG): Backplane powered.
2019-10-17T01:03:14.674Z,1571274194.674 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2019-10-17T01:03:14.684Z,1571274194.684 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2019-10-17T01:03:14.695Z,1571274194.695 [MissionManager](DEBUG):
2019-10-17T01:03:14.696Z,1571274194.696 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2019-10-17T01:03:14.763Z,1571274194.763 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2019-10-17T01:03:14.764Z,1571274194.764 [Default:A.Wait](DEBUG): Construct Wait.
2019-10-17T01:03:14.782Z,1571274194.782 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2019-10-17T01:03:14.806Z,1571274194.806 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2019-10-17T01:03:14.825Z,1571274194.825 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2019-10-17T01:03:14.830Z,1571274194.830 [Default:E.Execute](DEBUG): Construct Execute.
2019-10-17T01:03:14.852Z,1571274194.852 [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-10-17T01:03:14.870Z,1571274194.870 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,Depth_Keller,DropWeight,NAL9602,Onboard,BPC1,Aanderaa_O2,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2019-10-17T01:03:14.873Z,1571274194.873 [Radio_Surface](INFO): Powering up
2019-10-17T01:03:14.878Z,1571274194.878 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2019-10-17T01:03:14.915Z,1571274194.915 [Depth_Keller](ERROR): Pressure reading out of range: 1831.023193 decibar
2019-10-17T01:03:15.009Z,1571274195.009 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-10-17T01:03:15.042Z,1571274195.042 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2019-10-17T01:03:15.049Z,1571274195.049 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2019-10-17T01:03:15.050Z,1571274195.050 [ElevatorServo](DEBUG): Initializing EZServoServo.
2019-10-17T01:03:15.057Z,1571274195.057 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2019-10-17T01:03:15.058Z,1571274195.058 [MassServo](DEBUG): Initializing EZServoServo.
2019-10-17T01:03:15.065Z,1571274195.065 [MassServo](DEBUG): Initializing MassServo.
2019-10-17T01:03:15.066Z,1571274195.066 [RudderServo](DEBUG): Initializing EZServoServo.
2019-10-17T01:03:15.073Z,1571274195.073 [RudderServo](DEBUG): Initializing RudderServo.
2019-10-17T01:03:15.074Z,1571274195.074 [ThrusterServo](DEBUG): Initializing EZServoServo.
2019-10-17T01:03:15.081Z,1571274195.081 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2019-10-17T01:03:15.295Z,1571274195.295 [DropWeight](CRITICAL): DROP WEIGHT MISSING.
2019-10-17T01:03:15.295Z,1571274195.295 [DropWeight] Hardware Fault, FailCount= 1
2019-10-17T01:03:15.295Z,1571274195.295 [DropWeight](ERROR): Hardware Fault
2019-10-17T01:03:15.350Z,1571274195.350 [CommandLine](FAULT): Scheduling is paused
2019-10-17T01:03:15.351Z,1571274195.351 [CBIT](INFO): Critical error at 20191017T010315
2019-10-17T01:03:15.351Z,1571274195.351 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2019-10-17T01:03:15.354Z,1571274195.354 [CBIT](ERROR): Hardware Fault in component: DropWeight
2019-10-17T01:03:15.354Z,1571274195.354 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2019-10-17T01:03:16.050Z,1571274196.050 [CBIT](INFO): Critical error at 20191017T010315
2019-10-17T01:03:18.429Z,1571274198.429 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-10-17T01:03:18.861Z,1571274198.861 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-10-17T01:03:19.421Z,1571274199.421 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-10-17T01:03:20.165Z,1571274200.165 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-10-17T01:03:20.789Z,1571274200.789 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-10-17T01:03:21.297Z,1571274201.297 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-10-17T01:03:21.853Z,1571274201.853 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-10-17T01:03:22.265Z,1571274202.265 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-10-17T01:03:22.669Z,1571274202.669 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-10-17T01:03:23.065Z,1571274203.065 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-10-17T01:03:23.589Z,1571274203.589 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-10-17T01:03:24.009Z,1571274204.009 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-10-17T01:03:24.433Z,1571274204.433 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-10-17T01:03:24.849Z,1571274204.849 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-10-17T01:03:25.277Z,1571274205.277 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-10-17T01:03:25.296Z,1571274205.296 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2019-10-17T01:03:25.296Z,1571274205.296 [Aanderaa_O2] Communications Fault, FailCount= 1
2019-10-17T01:03:25.296Z,1571274205.296 [Aanderaa_O2](ERROR): Communications Fault
2019-10-17T01:03:25.374Z,1571274205.374 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2019-10-17T01:03:25.725Z,1571274205.725 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-10-17T01:03:25.861Z,1571274205.861 [Aanderaa_O2](INFO): Powering down
2019-10-17T01:03:26.301Z,1571274206.301 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-10-17T01:03:26.697Z,1571274206.697 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-10-17T01:03:26.753Z,1571274206.753 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2019-10-17T01:03:26.753Z,1571274206.753 [Aanderaa_O2] No Fault, FailCount= 1
2019-10-17T01:03:27.101Z,1571274207.101 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-10-17T01:03:27.509Z,1571274207.509 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-10-17T01:03:27.522Z,1571274207.522 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2019-10-17T01:03:27.522Z,1571274207.522 [CTD_Seabird] Communications Fault, FailCount= 1
2019-10-17T01:03:27.522Z,1571274207.522 [CTD_Seabird](ERROR): Communications Fault
2019-10-17T01:03:27.589Z,1571274207.589 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2019-10-17T01:03:27.921Z,1571274207.921 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-10-17T01:03:27.921Z,1571274207.921 [AHRS_M2](FAULT): Failed to initialize within timeout.
2019-10-17T01:03:27.921Z,1571274207.921 [AHRS_M2] Communications Fault, FailCount= 1
2019-10-17T01:03:27.921Z,1571274207.921 [AHRS_M2](ERROR): Communications Fault
2019-10-17T01:03:27.925Z,1571274207.925 [CTD_Seabird](INFO): Powering down
2019-10-17T01:03:27.994Z,1571274207.994 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2019-10-17T01:03:28.004Z,1571274208.004 [AHRS_M2](INFO): Powering down
2019-10-17T01:03:28.157Z,1571274208.157 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004474
2019-10-17T01:03:28.896Z,1571274208.896 [CBIT](INFO): Clearing failed state for component AHRS_M2
2019-10-17T01:03:28.896Z,1571274208.896 [AHRS_M2] No Fault, FailCount= 1
2019-10-17T01:03:28.897Z,1571274208.897 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2019-10-17T01:03:28.897Z,1571274208.897 [CTD_Seabird] No Fault, FailCount= 1
2019-10-17T01:03:29.216Z,1571274209.216 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2019-10-17T01:03:29.285Z,1571274209.285 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2019-10-17T01:03:29.293Z,1571274209.293 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2019-10-17T01:03:32.761Z,1571274212.761 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-10-17T01:03:33.177Z,1571274213.177 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-10-17T01:03:33.581Z,1571274213.581 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-10-17T01:03:33.973Z,1571274213.973 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-10-17T01:03:34.389Z,1571274214.389 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-10-17T01:03:34.781Z,1571274214.781 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-10-17T01:03:35.185Z,1571274215.185 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-10-17T01:03:35.601Z,1571274215.601 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-10-17T01:03:36.005Z,1571274216.005 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-10-17T01:03:36.425Z,1571274216.425 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-10-17T01:03:36.821Z,1571274216.821 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-10-17T01:03:37.233Z,1571274217.233 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-10-17T01:03:37.253Z,1571274217.253 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2019-10-17T01:03:37.253Z,1571274217.253 [Aanderaa_O2] Communications Fault, FailCount= 2
2019-10-17T01:03:37.253Z,1571274217.253 [Aanderaa_O2](ERROR): Communications Fault
2019-10-17T01:03:37.341Z,1571274217.341 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2019-10-17T01:03:37.685Z,1571274217.685 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-10-17T01:03:37.821Z,1571274217.821 [Aanderaa_O2](INFO): Powering down
2019-10-17T01:03:38.209Z,1571274218.209 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-10-17T01:03:38.341Z,1571274218.341 [SBIT](IMPORTANT): Beginning Startup BIT
2019-10-17T01:03:38.353Z,1571274218.353 [CBIT](IMPORTANT): Beginning ground fault scan
2019-10-17T01:03:38.689Z,1571274218.689 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-10-17T01:03:38.811Z,1571274218.811 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2019-10-17T01:03:38.811Z,1571274218.811 [Aanderaa_O2] No Fault, FailCount= 2
2019-10-17T01:03:39.149Z,1571274219.149 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-10-17T01:03:40.233Z,1571274220.233 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-10-17T01:03:41.305Z,1571274221.305 [AHRS_M2](ERROR): Clear channel UART error: serial timeout
2019-10-17T01:03:41.393Z,1571274221.393 [AHRS_M2](ERROR): Subscribe Pitch UART error: serial timeout
2019-10-17T01:03:41.717Z,1571274221.717 [AHRS_M2](ERROR): Clear channel UART error: serial timeout
2019-10-17T01:03:41.813Z,1571274221.813 [AHRS_M2](ERROR): Subscribe Pitch UART error: serial timeout
2019-10-17T01:03:41.826Z,1571274221.826 [NAL9602](INFO): Powering up NAL9602
2019-10-17T01:03:42.141Z,1571274222.141 [AHRS_M2](ERROR): Clear channel UART error: serial timeout
2019-10-17T01:03:42.229Z,1571274222.229 [AHRS_M2](ERROR): Subscribe Pitch UART error: serial timeout
2019-10-17T01:03:42.229Z,1571274222.229 [AHRS_M2](FAULT): Failed to initialize within timeout.
2019-10-17T01:03:42.229Z,1571274222.229 [AHRS_M2] Communications Fault, FailCount= 2
2019-10-17T01:03:42.229Z,1571274222.229 [AHRS_M2](ERROR): Communications Fault
2019-10-17T01:03:42.337Z,1571274222.337 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2019-10-17T01:03:42.337Z,1571274222.337 [CTD_Seabird] Communications Fault, FailCount= 2
2019-10-17T01:03:42.337Z,1571274222.337 [CTD_Seabird](ERROR): Communications Fault
2019-10-17T01:03:42.389Z,1571274222.389 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2019-10-17T01:03:42.390Z,1571274222.390 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2019-10-17T01:03:42.507Z,1571274222.507 [AHRS_M2](INFO): Powering down
2019-10-17T01:03:42.741Z,1571274222.741 [CTD_Seabird](INFO): Powering down
2019-10-17T01:03:43.546Z,1571274223.546 [CBIT](INFO): Clearing failed state for component AHRS_M2
2019-10-17T01:03:43.546Z,1571274223.546 [AHRS_M2] No Fault, FailCount= 2
2019-10-17T01:03:43.713Z,1571274223.713 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2019-10-17T01:03:43.826Z,1571274223.826 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2019-10-17T01:03:43.826Z,1571274223.826 [CTD_Seabird] No Fault, FailCount= 2
2019-10-17T01:03:44.085Z,1571274224.085 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2019-10-17T01:03:44.093Z,1571274224.093 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2019-10-17T01:03:47.273Z,1571274227.273 [AHRS_M2](ERROR): Clear channel UART error: serial timeout
2019-10-17T01:03:47.597Z,1571274227.597 [AHRS_M2](ERROR): Subscribe Pitch UART error: serial timeout
2019-10-17T01:03:48.153Z,1571274228.153 [AHRS_M2](ERROR): Clear channel UART error: serial timeout
2019-10-17T01:03:48.465Z,1571274228.465 [AHRS_M2](ERROR): Subscribe Pitch UART error: serial timeout
2019-10-17T01:03:49.009Z,1571274229.009 [AHRS_M2](ERROR): Clear channel UART error: serial timeout
2019-10-17T01:03:49.333Z,1571274229.333 [AHRS_M2](ERROR): Subscribe Pitch UART error: serial timeout
2019-10-17T01:03:49.352Z,1571274229.352 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2019-10-17T01:03:49.352Z,1571274229.352 [Aanderaa_O2] Communications Fault, FailCount= 3
2019-10-17T01:03:49.352Z,1571274229.352 [Aanderaa_O2](ERROR): Communications Fault
2019-10-17T01:03:49.423Z,1571274229.423 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2019-10-17T01:03:49.423Z,1571274229.423 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2
2019-10-17T01:03:49.853Z,1571274229.853 [AHRS_M2](ERROR): Clear channel UART error: serial timeout
2019-10-17T01:03:50.177Z,1571274230.177 [AHRS_M2](ERROR): Subscribe Pitch UART error: serial timeout
2019-10-17T01:03:50.317Z,1571274230.317 [Aanderaa_O2](INFO): Powering down
2019-10-17T01:03:50.397Z,1571274230.397 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.012297
CHAN A1 (24V): 0.000743
CHAN A2 (12V): -0.001956
CHAN A3 (5V): -0.001368
CHAN B0 (3.3V): 0.000194
CHAN B1 (3.15aV): -0.000055
CHAN B2 (3.15bV): -0.000681
CHAN B3 (GND): 0.000205
OPEN: -0.000800
Full Scale Calc: 4.765 mA, -1.589 mA
2019-10-17T01:03:50.749Z,1571274230.749 [AHRS_M2](ERROR): Clear channel UART error: serial timeout
2019-10-17T01:03:51.073Z,1571274231.073 [AHRS_M2](ERROR): Subscribe Pitch UART error: serial timeout
2019-10-17T01:03:51.497Z,1571274231.497 [AHRS_M2](ERROR): Clear channel UART error: serial timeout
2019-10-17T01:03:51.821Z,1571274231.821 [AHRS_M2](ERROR): Subscribe Pitch UART error: serial timeout
2019-10-17T01:03:52.281Z,1571274232.281 [AHRS_M2](ERROR): Clear channel UART error: serial timeout
2019-10-17T01:03:52.605Z,1571274232.605 [AHRS_M2](ERROR): Subscribe Pitch UART error: serial timeout
2019-10-17T01:03:53.013Z,1571274233.013 [AHRS_M2](ERROR): Clear channel UART error: serial timeout
2019-10-17T01:03:53.325Z,1571274233.325 [AHRS_M2](ERROR): Subscribe Pitch UART error: serial timeout
2019-10-17T01:03:53.789Z,1571274233.789 [AHRS_M2](ERROR): Clear channel UART error: serial timeout
2019-10-17T01:03:53.818Z,1571274233.818 [NAL9602](INFO): NAL9602 initialized
2019-10-17T01:03:54.373Z,1571274234.373 [NAL9602](DEBUG): Fix Requested
2019-10-17T01:03:56.910Z,1571274236.910 [AHRS_M2](FAULT): Failed to initialize within timeout.
2019-10-17T01:03:56.910Z,1571274236.910 [AHRS_M2] Communications Fault, FailCount= 3
2019-10-17T01:03:56.910Z,1571274236.910 [AHRS_M2](ERROR): Communications Fault
2019-10-17T01:03:57.098Z,1571274237.098 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2019-10-17T01:03:57.137Z,1571274237.137 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2019-10-17T01:03:57.137Z,1571274237.137 [CTD_Seabird] Communications Fault, FailCount= 3
2019-10-17T01:03:57.137Z,1571274237.137 [CTD_Seabird](ERROR): Communications Fault
2019-10-17T01:03:57.288Z,1571274237.288 [AHRS_M2](INFO): Powering down
2019-10-17T01:03:57.522Z,1571274237.522 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2019-10-17T01:03:57.522Z,1571274237.522 [CBIT](FAULT): Communications Fault in component: CTD_Seabird
2019-10-17T01:03:57.541Z,1571274237.541 [CTD_Seabird](INFO): Powering down
2019-10-17T01:03:58.229Z,1571274238.229 [CBIT](INFO): Clearing failed state for component AHRS_M2
2019-10-17T01:03:58.229Z,1571274238.229 [AHRS_M2] No Fault, FailCount= 3
2019-10-17T01:03:58.500Z,1571274238.500 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2019-10-17T01:04:02.065Z,1571274242.065 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2019-10-17T01:04:02.513Z,1571274242.513 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2019-10-17T01:04:02.957Z,1571274242.957 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2019-10-17T01:04:03.397Z,1571274243.397 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2019-10-17T01:04:03.841Z,1571274243.841 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2019-10-17T01:04:04.269Z,1571274244.269 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2019-10-17T01:04:04.701Z,1571274244.701 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2019-10-17T01:04:05.141Z,1571274245.141 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2019-10-17T01:04:05.557Z,1571274245.557 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2019-10-17T01:04:05.997Z,1571274245.997 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2019-10-17T01:04:06.441Z,1571274246.441 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2019-10-17T01:04:06.881Z,1571274246.881 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2019-10-17T01:04:07.329Z,1571274247.329 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2019-10-17T01:04:07.781Z,1571274247.781 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2019-10-17T01:04:08.209Z,1571274248.209 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2019-10-17T01:04:08.649Z,1571274248.649 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2019-10-17T01:04:09.093Z,1571274249.093 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2019-10-17T01:04:09.509Z,1571274249.509 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2019-10-17T01:04:09.949Z,1571274249.949 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2019-10-17T01:04:10.381Z,1571274250.381 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2019-10-17T01:04:10.809Z,1571274250.809 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2019-10-17T01:04:11.249Z,1571274251.249 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2019-10-17T01:04:11.769Z,1571274251.769 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2019-10-17T01:04:11.769Z,1571274251.769 [AHRS_M2](FAULT): Failed to initialize within timeout.
2019-10-17T01:04:11.769Z,1571274251.769 [AHRS_M2] Communications Fault, FailCount= 4
2019-10-17T01:04:11.769Z,1571274251.769 [AHRS_M2](ERROR): Communications Fault
2019-10-17T01:04:11.806Z,1571274251.806 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2019-10-17T01:04:11.851Z,1571274251.851 [AHRS_M2](INFO): Powering down
2019-10-17T01:04:12.698Z,1571274252.698 [CBIT](INFO): Clearing failed state for component AHRS_M2
2019-10-17T01:04:12.698Z,1571274252.698 [AHRS_M2] No Fault, FailCount= 4
2019-10-17T01:04:13.057Z,1571274253.057 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2019-10-17T01:04:16.613Z,1571274256.613 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2019-10-17T01:04:17.017Z,1571274257.017 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2019-10-17T01:04:17.421Z,1571274257.421 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2019-10-17T01:04:17.837Z,1571274257.837 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2019-10-17T01:04:18.265Z,1571274258.265 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2019-10-17T01:04:18.729Z,1571274258.729 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2019-10-17T01:04:19.189Z,1571274259.189 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2019-10-17T01:04:19.463Z,1571274259.463 [CommandLine](IMPORTANT): got command report mod Onboard.Pressure
2019-10-17T01:04:19.613Z,1571274259.613 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2019-10-17T01:04:19.672Z,1571274259.672 [Reporter](INFO): Onboard.Pressure 55195.324219 Pa
2019-10-17T01:04:20.017Z,1571274260.017 [AHRS_M2](ERROR): Start data-stream UART error: serial timeout
2019-10-17T01:04:20.112Z,1571274260.112 [Reporter](INFO): Onboard.Pressure 54876.312500 Pa
2019-10-17T01:04:20.231Z,1571274260.231 [Reporter](INFO): Onboard.Pressure 55116.832031 Pa
2019-10-17T01:04:20.775Z,1571274260.775 [Reporter](INFO): Onboard.Pressure 54876.312500 Pa
2019-10-17T01:04:21.091Z,1571274261.091 [Reporter](INFO): Onboard.Pressure 54798.417969 Pa
2019-10-17T01:04:21.863Z,1571274261.863 [Reporter](INFO): Onboard.Pressure 54939.441406 Pa
2019-10-17T01:04:22.067Z,1571274262.067 [Reporter](INFO): Onboard.Pressure 54824.378906 Pa
2019-10-17T01:04:22.547Z,1571274262.547 [Reporter](INFO): Onboard.Pressure 55116.832031 Pa
2019-10-17T01:04:22.851Z,1571274262.851 [Reporter](INFO): Onboard.Pressure 54876.312500 Pa
2019-10-17T01:04:23.259Z,1571274263.259 [Reporter](INFO): Onboard.Pressure 54798.417969 Pa
2019-10-17T01:04:24.311Z,1571274264.311 [Reporter](INFO): Onboard.Pressure 54939.441406 Pa
2019-10-17T01:04:24.459Z,1571274264.459 [Reporter](INFO): Onboard.Pressure 55142.992188 Pa
2019-10-17T01:04:24.815Z,1571274264.815 [Reporter](INFO): Onboard.Pressure 55195.324219 Pa
2019-10-17T01:04:25.639Z,1571274265.639 [Reporter](INFO): Onboard.Pressure 54876.312500 Pa
2019-10-17T01:04:26.023Z,1571274266.023 [Reporter](INFO): Onboard.Pressure 54798.417969 Pa
2019-10-17T01:04:26.854Z,1571274266.854 [Reporter](INFO): Onboard.Pressure 54976.066406 Pa
2019-10-17T01:04:27.235Z,1571274267.235 [Reporter](INFO): Onboard.Pressure 55169.156250 Pa
2019-10-17T01:04:27.681Z,1571274267.681 [Reporter](INFO): Onboard.Pressure 54876.312500 Pa
2019-10-17T01:04:28.047Z,1571274268.047 [Reporter](INFO): Onboard.Pressure 55116.832031 Pa
2019-10-17T01:04:28.464Z,1571274268.464 [Reporter](INFO): Onboard.Pressure 54876.312500 Pa
2019-10-17T01:04:28.874Z,1571274268.874 [Reporter](INFO): Onboard.Pressure 55116.832031 Pa
2019-10-17T01:04:29.272Z,1571274269.272 [Reporter](INFO): Onboard.Pressure 55017.535156 Pa
2019-10-17T01:04:29.671Z,1571274269.671 [Reporter](INFO): Onboard.Pressure 55142.992188 Pa
2019-10-17T01:04:30.004Z,1571274270.004 [CommandLine](IMPORTANT): got command report mod Onboard.Humidity
2019-10-17T01:04:30.096Z,1571274270.096 [Reporter](INFO): Onboard.Pressure 55195.324219 Pa
2019-10-17T01:04:30.097Z,1571274270.097 [Reporter](INFO): Onboard.Humidity 5.188622 %
2019-10-17T01:04:30.385Z,1571274270.385 [AHRS_M2](FAULT): Failed to acquire valid data within timeout.
2019-10-17T01:04:30.385Z,1571274270.385 [AHRS_M2] Data Fault, FailCount= 5
2019-10-17T01:04:30.385Z,1571274270.385 [AHRS_M2](ERROR): Data Fault
2019-10-17T01:04:30.462Z,1571274270.462 [CBIT](ERROR): Data Fault in component: AHRS_M2
2019-10-17T01:04:30.462Z,1571274270.462 [CBIT](CRITICAL): Data Fault in component: AHRS_M2
2019-10-17T01:04:30.464Z,1571274270.464 [Reporter](INFO): Onboard.Pressure 54876.312500 Pa
2019-10-17T01:04:30.776Z,1571274270.776 [AHRS_M2](INFO): Powering down
2019-10-17T01:04:30.932Z,1571274270.932 [CBIT](INFO): Critical error at 20191017T010430
2019-10-17T01:04:30.936Z,1571274270.936 [Reporter](INFO): Onboard.Pressure 55116.832031 Pa
2019-10-17T01:04:31.343Z,1571274271.343 [Reporter](INFO): Onboard.Pressure 55195.324219 Pa
2019-10-17T01:04:32.431Z,1571274272.431 [Reporter](INFO): Onboard.Pressure 54876.312500 Pa
2019-10-17T01:04:32.832Z,1571274272.832 [SBIT](IMPORTANT): SBIT PASSED
2019-10-17T01:04:32.854Z,1571274272.854 [Reporter](INFO): Onboard.Pressure 55116.832031 Pa
2019-10-17T01:04:32.925Z,1571274272.925 [CommandLine](IMPORTANT): got command configSet list
2019-10-17T01:04:32.925Z,1571274272.925 [CommandLine](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2019-10-17T01:04:32.931Z,1571274272.931 [CommandLine](IMPORTANT): CBIT.gf24Offset=154 microampere;
2019-10-17T01:04:32.931Z,1571274272.931 [CommandLine](IMPORTANT): CTD_NeilBrown.loadAtStartup=0 bool;
2019-10-17T01:04:32.931Z,1571274272.931 [CommandLine](IMPORTANT): DAT.loadAtStartup=0 bool;
2019-10-17T01:04:32.931Z,1571274272.931 [CommandLine](IMPORTANT): DVL_micro.loadAtStartup=0 bool;
2019-10-17T01:04:33.239Z,1571274273.239 [MissionManager](IMPORTANT): Started mission Startup
2019-10-17T01:04:33.240Z,1571274273.240 [Startup] Running Loop=1
2019-10-17T01:04:33.240Z,1571274273.240 [Startup](DEBUG): Aggregate::initialize Startup
2019-10-17T01:04:33.240Z,1571274273.240 [Startup:A.GoToSurface] Running Loop=1
2019-10-17T01:04:33.240Z,1571274273.240 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2019-10-17T01:04:33.240Z,1571274273.240 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2019-10-17T01:04:33.241Z,1571274273.241 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2019-10-17T01:04:33.241Z,1571274273.241 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2019-10-17T01:04:33.242Z,1571274273.242 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2019-10-17T01:04:33.242Z,1571274273.242 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2019-10-17T01:04:33.243Z,1571274273.243 [Startup:StartupSatComms] Running Loop=1
2019-10-17T01:04:33.243Z,1571274273.243 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2019-10-17T01:04:33.243Z,1571274273.243 [Startup:StartupSatComms:A] Running Loop=1
2019-10-17T01:04:33.254Z,1571274273.254 [Reporter](INFO): Onboard.Pressure 55195.324219 Pa
2019-10-17T01:04:33.254Z,1571274273.254 [Reporter](INFO): Onboard.Humidity 5.213039 %
2019-10-17T01:04:33.656Z,1571274273.656 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2019-10-17T01:04:34.080Z,1571274274.080 [Reporter](INFO): Onboard.Humidity 5.188622 %
2019-10-17T01:04:34.464Z,1571274274.464 [Reporter](INFO): Onboard.Pressure 54876.312500 Pa
2019-10-17T01:04:34.924Z,1571274274.924 [Reporter](INFO): Onboard.Pressure 55116.832031 Pa
2019-10-17T01:04:35.289Z,1571274275.289 [Reporter](INFO): Onboard.Pressure 54876.312500 Pa
2019-10-17T01:04:35.743Z,1571274275.743 [Reporter](INFO): Onboard.Pressure 54798.417969 Pa
2019-10-17T01:04:35.744Z,1571274275.744 [Reporter](INFO): Onboard.Humidity 5.213039 %
2019-10-17T01:04:36.889Z,1571274276.889 [Reporter](INFO): Onboard.Pressure 55116.832031 Pa
2019-10-17T01:04:37.277Z,1571274277.277 [Reporter](INFO): Onboard.Pressure 55195.324219 Pa
2019-10-17T01:04:38.089Z,1571274278.089 [Reporter](INFO): Onboard.Pressure 54876.312500 Pa
2019-10-17T01:04:38.090Z,1571274278.090 [Reporter](INFO): Onboard.Humidity 5.188622 %
2019-10-17T01:04:38.501Z,1571274278.501 [Reporter](INFO): Onboard.Pressure 54798.417969 Pa
2019-10-17T01:04:38.919Z,1571274278.919 [Reporter](INFO): Onboard.Pressure 55116.832031 Pa
2019-10-17T01:04:39.312Z,1571274279.312 [Reporter](INFO): Onboard.Pressure 55017.535156 Pa
2019-10-17T01:04:39.716Z,1571274279.716 [Reporter](INFO): Onboard.Pressure 54824.378906 Pa
2019-10-17T01:04:40.119Z,1571274280.119 [Reporter](INFO): Onboard.Pressure 55116.832031 Pa
2019-10-17T01:04:40.512Z,1571274280.512 [Reporter](INFO): Onboard.Pressure 55195.324219 Pa
2019-10-17T01:04:41.732Z,1571274281.732 [Reporter](INFO): Onboard.Pressure 54876.312500 Pa
2019-10-17T01:04:42.125Z,1571274282.125 [Reporter](INFO): Onboard.Pressure 54798.417969 Pa
2019-10-17T01:04:42.532Z,1571274282.532 [Reporter](INFO): Onboard.Pressure 55116.832031 Pa
2019-10-17T01:04:42.940Z,1571274282.940 [Reporter](INFO): Onboard.Pressure 55195.324219 Pa
2019-10-17T01:04:43.346Z,1571274283.346 [Reporter](INFO): Onboard.Pressure 54876.312500 Pa
2019-10-17T01:04:43.763Z,1571274283.763 [Reporter](INFO): Onboard.Pressure 54976.066406 Pa
2019-10-17T01:04:43.764Z,1571274283.764 [Reporter](INFO): Onboard.Humidity 5.213039 %
2019-10-17T01:04:44.179Z,1571274284.179 [Reporter](INFO): Onboard.Pressure 55169.156250 Pa
2019-10-17T01:04:44.560Z,1571274284.560 [Reporter](INFO): Onboard.Pressure 55195.324219 Pa
2019-10-17T01:04:44.561Z,1571274284.561 [Reporter](INFO): Onboard.Humidity 5.188622 %
2019-10-17T01:04:44.972Z,1571274284.972 [Reporter](INFO): Onboard.Pressure 54876.312500 Pa
2019-10-17T01:04:45.373Z,1571274285.373 [Reporter](INFO): Onboard.Pressure 55116.832031 Pa
2019-10-17T01:04:45.764Z,1571274285.764 [Reporter](INFO): Onboard.Pressure 55195.324219 Pa
2019-10-17T01:04:46.172Z,1571274286.172 [Reporter](INFO): Onboard.Pressure 54876.312500 Pa
2019-10-17T01:04:46.173Z,1571274286.173 [Reporter](INFO): Onboard.Humidity 5.213039 %
2019-10-17T01:04:46.572Z,1571274286.572 [Reporter](INFO): Onboard.Pressure 54798.417969 Pa
2019-10-17T01:04:46.987Z,1571274286.987 [Reporter](INFO): Onboard.Pressure 54939.441406 Pa
2019-10-17T01:04:47.378Z,1571274287.378 [Reporter](INFO): Onboard.Pressure 54861.335938 Pa
2019-10-17T01:04:47.784Z,1571274287.784 [Reporter](INFO): Onboard.Pressure 54824.378906 Pa
2019-10-17T01:04:47.785Z,1571274287.785 [Reporter](INFO): Onboard.Humidity 5.188622 %
2019-10-17T01:04:48.244Z,1571274288.244 [Reporter](INFO): Onboard.Pressure 55116.832031 Pa
2019-10-17T01:04:48.636Z,1571274288.636 [Reporter](INFO): Onboard.Pressure 54876.312500 Pa
2019-10-17T01:04:48.641Z,1571274288.641 [Reporter](INFO): Onboard.Humidity 5.213039 %
2019-10-17T01:04:49.140Z,1571274289.140 [Reporter](INFO): Onboard.Pressure 55116.832031 Pa
2019-10-17T01:04:49.456Z,1571274289.456 [Reporter](INFO): Onboard.Pressure 54876.312500 Pa
2019-10-17T01:04:49.457Z,1571274289.457 [Reporter](INFO): Onboard.Humidity 5.188622 %
2019-10-17T01:04:49.843Z,1571274289.843 [Reporter](INFO): Onboard.Pressure 55116.832031 Pa
2019-10-17T01:04:50.247Z,1571274290.247 [Reporter](INFO): Onboard.Pressure 55195.324219 Pa
2019-10-17T01:04:50.654Z,1571274290.654 [Reporter](INFO): Onboard.Pressure 55054.363281 Pa
2019-10-17T01:04:51.035Z,1571274291.035 [Reporter](INFO): Onboard.Pressure 55169.156250 Pa
2019-10-17T01:04:51.454Z,1571274291.454 [Reporter](INFO): Onboard.Pressure 55195.324219 Pa
2019-10-17T01:04:51.855Z,1571274291.855 [Reporter](INFO): Onboard.Pressure 54876.312500 Pa
2019-10-17T01:04:52.232Z,1571274292.232 [Reporter](INFO): Onboard.Pressure 55116.832031 Pa
2019-10-17T01:04:52.636Z,1571274292.636 [Reporter](INFO): Onboard.Pressure 55195.324219 Pa
2019-10-17T01:04:52.636Z,1571274292.636 [Reporter](INFO): Onboard.Humidity 5.213039 %
2019-10-17T01:04:53.037Z,1571274293.037 [Reporter](INFO): Onboard.Pressure 54876.312500 Pa
2019-10-17T01:04:53.458Z,1571274293.458 [Reporter](INFO): Onboard.Pressure 55116.832031 Pa
2019-10-17T01:04:53.458Z,1571274293.458 [Reporter](INFO): Onboard.Humidity 5.188622 %
2019-10-17T01:04:53.843Z,1571274293.843 [Reporter](INFO): Onboard.Pressure 54876.312500 Pa
2019-10-17T01:04:54.252Z,1571274294.252 [Reporter](INFO): Onboard.Pressure 55116.832031 Pa
2019-10-17T01:04:54.664Z,1571274294.664 [Reporter](INFO): Onboard.Pressure 54876.312500 Pa
2019-10-17T01:04:55.069Z,1571274295.069 [Reporter](INFO): Onboard.Pressure 55116.832031 Pa
2019-10-17T01:04:55.485Z,1571274295.485 [Reporter](INFO): Onboard.Pressure 55195.324219 Pa
2019-10-17T01:04:55.872Z,1571274295.872 [Reporter](INFO): Onboard.Pressure 54876.312500 Pa
2019-10-17T01:04:55.873Z,1571274295.873 [Reporter](INFO): Onboard.Humidity 5.213039 %
2019-10-17T01:04:56.268Z,1571274296.268 [Reporter](INFO): Onboard.Pressure 54798.417969 Pa
2019-10-17T01:04:56.683Z,1571274296.683 [Reporter](INFO): Onboard.Humidity 5.188622 %
2019-10-17T01:04:57.076Z,1571274297.076 [Reporter](INFO): Onboard.Pressure 55116.832031 Pa
2019-10-17T01:04:57.480Z,1571274297.480 [Reporter](INFO): Onboard.Pressure 55195.324219 Pa
2019-10-17T01:04:57.481Z,1571274297.481 [Reporter](INFO): Onboard.Humidity 5.213039 %
2019-10-17T01:04:58.294Z,1571274298.294 [Reporter](INFO): Onboard.Humidity 5.188622 %
2019-10-17T01:04:59.098Z,1571274299.098 [Reporter](INFO): Onboard.Humidity 5.213039 %
2019-10-17T01:04:59.920Z,1571274299.920 [Reporter](INFO): Onboard.Pressure 54876.312500 Pa
2019-10-17T01:04:59.920Z,1571274299.920 [Reporter](INFO): Onboard.Humidity 5.188622 %
2019-10-17T01:05:00.321Z,1571274300.321 [Reporter](INFO): Onboard.Pressure 54798.417969 Pa
2019-10-17T01:05:00.738Z,1571274300.738 [Reporter](INFO): Onboard.Pressure 54939.441406 Pa
2019-10-17T01:05:01.177Z,1571274301.177 [Reporter](INFO): Onboard.Pressure 55142.992188 Pa
2019-10-17T01:05:01.532Z,1571274301.532 [Reporter](INFO): Onboard.Pressure 55017.535156 Pa
2019-10-17T01:05:01.533Z,1571274301.533 [Reporter](INFO): Onboard.Humidity 5.213039 %
2019-10-17T01:05:01.940Z,1571274301.940 [Reporter](INFO): Onboard.Pressure 55142.992188 Pa
2019-10-17T01:05:02.398Z,1571274302.398 [Reporter](INFO): Onboard.Pressure 54876.312500 Pa
2019-10-17T01:05:02.399Z,1571274302.399 [Reporter](INFO): Onboard.Humidity 5.188622 %
2019-10-17T01:05:02.737Z,1571274302.737 [Reporter](INFO): Onboard.Pressure 55116.832031 Pa
2019-10-17T01:05:03.148Z,1571274303.148 [Reporter](INFO): Onboard.Pressure 54876.312500 Pa
2019-10-17T01:05:03.556Z,1571274303.556 [Reporter](INFO): Onboard.Pressure 54798.417969 Pa
2019-10-17T01:05:04.756Z,1571274304.756 [Reporter](INFO): Onboard.Humidity 5.213039 %
2019-10-17T01:05:05.168Z,1571274305.168 [Reporter](INFO): Onboard.Pressure 55116.832031 Pa
2019-10-17T01:05:05.578Z,1571274305.578 [Reporter](INFO): Onboard.Pressure 55195.324219 Pa
2019-10-17T01:05:05.579Z,1571274305.579 [Reporter](INFO): Onboard.Humidity 5.188622 %
2019-10-17T01:05:05.992Z,1571274305.992 [Reporter](INFO): Onboard.Pressure 55054.363281 Pa
2019-10-17T01:05:06.375Z,1571274306.375 [Reporter](INFO): Onboard.Pressure 55169.156250 Pa
2019-10-17T01:05:06.777Z,1571274306.777 [Reporter](INFO): Onboard.Pressure 54876.312500 Pa
2019-10-17T01:05:07.191Z,1571274307.191 [Reporter](INFO): Onboard.Pressure 54798.417969 Pa
2019-10-17T01:05:07.988Z,1571274307.988 [Reporter](INFO): Onboard.Pressure 54939.441406 Pa
2019-10-17T01:05:07.990Z,1571274307.990 [Reporter](INFO): Onboard.Humidity 5.213039 %
2019-10-17T01:05:08.387Z,1571274308.387 [Reporter](INFO): Onboard.Pressure 55142.992188 Pa
2019-10-17T01:05:08.803Z,1571274308.803 [Reporter](INFO): Onboard.Pressure 54876.312500 Pa
2019-10-17T01:05:09.189Z,1571274309.189 [Reporter](INFO): Onboard.Pressure 55116.832031 Pa
2019-10-17T01:05:09.604Z,1571274309.604 [Reporter](INFO): Onboard.Pressure 55195.324219 Pa
2019-10-17T01:05:10.008Z,1571274310.008 [Reporter](INFO): Onboard.Pressure 54876.312500 Pa
2019-10-17T01:05:10.429Z,1571274310.429 [Reporter](INFO): Onboard.Pressure 55116.832031 Pa
2019-10-17T01:05:10.834Z,1571274310.834 [Reporter](INFO): Onboard.Pressure 54876.312500 Pa
2019-10-17T01:05:11.228Z,1571274311.228 [Reporter](INFO): Onboard.Pressure 55116.832031 Pa
2019-10-17T01:05:11.228Z,1571274311.228 [Reporter](INFO): Onboard.Humidity 5.188622 %
2019-10-17T01:05:11.632Z,1571274311.632 [Reporter](INFO): Onboard.Pressure 55054.363281 Pa
2019-10-17T01:05:12.029Z,1571274312.029 [Reporter](INFO): Onboard.Pressure 54850.343750 Pa
2019-10-17T01:05:12.030Z,1571274312.030 [Reporter](INFO): Onboard.Humidity 5.213039 %
2019-10-17T01:05:12.446Z,1571274312.446 [Reporter](INFO): Onboard.Pressure 55116.832031 Pa
2019-10-17T01:05:12.836Z,1571274312.836 [Reporter](INFO): Onboard.Pressure 55195.324219 Pa
2019-10-17T01:05:12.837Z,1571274312.837 [Reporter](INFO): Onboard.Humidity 5.188622 %
2019-10-17T01:05:13.646Z,1571274313.646 [Reporter](INFO): Onboard.Pressure 55054.363281 Pa
2019-10-17T01:05:13.647Z,1571274313.647 [Reporter](INFO): Onboard.Humidity 5.213039 %
2019-10-17T01:05:14.059Z,1571274314.059 [Reporter](INFO): Onboard.Pressure 55169.156250 Pa
2019-10-17T01:05:14.497Z,1571274314.497 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-10-17T01:05:14.497Z,1571274314.497 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2019-10-17T01:05:14.497Z,1571274314.497 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-10-17T01:05:14.543Z,1571274314.543 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-10-17T01:05:14.550Z,1571274314.550 [Reporter](INFO): Onboard.Pressure 54876.312500 Pa
2019-10-17T01:05:14.550Z,1571274314.550 [Reporter](INFO): Onboard.Humidity 5.188622 %
2019-10-17T01:05:14.858Z,1571274314.858 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-10-17T01:05:14.858Z,1571274314.858 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2019-10-17T01:05:14.860Z,1571274314.860 [Reporter](INFO): Onboard.Pressure 55116.832031 Pa
2019-10-17T01:05:15.269Z,1571274315.269 [Reporter](INFO): Onboard.Pressure 55195.324219 Pa
2019-10-17T01:05:15.270Z,1571274315.270 [Reporter](INFO): Onboard.Humidity 5.213039 %
2019-10-17T01:05:15.754Z,1571274315.754 [Reporter](INFO): Onboard.Pressure 55618.199219 Pa
2019-10-17T01:05:16.164Z,1571274316.164 [Reporter](INFO): Onboard.Pressure 55169.156250 Pa
2019-10-17T01:05:16.165Z,1571274316.165 [Reporter](INFO): Onboard.Humidity 5.188622 %
2019-10-17T01:05:16.466Z,1571274316.466 [CommandLine](IMPORTANT): got command report clear
2019-10-17T01:05:20.630Z,1571274320.630 [CommandLine](IMPORTANT): got command quit
2019-10-17T01:05:21.633Z,1571274321.633 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2019-10-17T01:05:21.633Z,1571274321.633 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-10-17T01:05:21.713Z,1571274321.713 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye!
2019-10-17T01:05:21.713Z,1571274321.713 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-10-17T01:05:21.714Z,1571274321.714 [CommandLine](INFO): Join timeout helper Thread ID is 1533
2019-10-17T01:05:21.717Z,1571274321.717 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2019-10-17T01:05:21.717Z,1571274321.717 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-10-17T01:05:21.717Z,1571274321.717 [NavChartDb](INFO): Join timeout helper Thread ID is 1534
2019-10-17T01:05:21.873Z,1571274321.873 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2019-10-17T01:05:21.873Z,1571274321.873 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-10-17T01:05:21.881Z,1571274321.881 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2019-10-17T01:05:21.881Z,1571274321.881 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2019-10-17T01:05:21.881Z,1571274321.881 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 1535
2019-10-17T01:05:22.005Z,1571274322.005 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2019-10-17T01:05:22.005Z,1571274322.005 [WetLabsBB2FL](INFO): Powering down
2019-10-17T01:05:22.006Z,1571274322.006 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2019-10-17T01:05:22.017Z,1571274322.017 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2019-10-17T01:05:22.017Z,1571274322.017 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2019-10-17T01:05:22.017Z,1571274322.017 [CTD_Seabird](INFO): Join timeout helper Thread ID is 1536
2019-10-17T01:05:22.209Z,1571274322.209 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2019-10-17T01:05:22.209Z,1571274322.209 [CTD_Seabird](INFO): Powering down
2019-10-17T01:05:22.221Z,1571274322.221 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2019-10-17T01:05:22.233Z,1571274322.233 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2019-10-17T01:05:22.233Z,1571274322.233 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-10-17T01:05:22.233Z,1571274322.233 [Radio_Surface](INFO): Join timeout helper Thread ID is 1537
2019-10-17T01:05:22.625Z,1571274322.625 [Radio_Surface](INFO): Powering down
2019-10-17T01:05:22.626Z,1571274322.626 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2019-10-17T01:05:22.626Z,1571274322.626 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-10-17T01:05:22.630Z,1571274322.630 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2019-10-17T01:05:22.630Z,1571274322.630 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2019-10-17T01:05:22.630Z,1571274322.630 [DataOverHttps](INFO): Join timeout helper Thread ID is 1538
2019-10-17T01:05:23.606Z,1571274323.606 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2019-10-17T01:05:23.610Z,1571274323.610 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2019-10-17T01:05:23.630Z,1571274323.630 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2019-10-17T01:05:23.630Z,1571274323.630 [logger ThreadHandler](INFO): Thread cancelled.
2019-10-17T01:05:23.630Z,1571274323.630 [logger](INFO): Join timeout helper Thread ID is 1539
2019-10-17T01:05:23.653Z,1571274323.653 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2019-10-17T01:05:23.653Z,1571274323.653 [logger ThreadHandler](INFO): Thread cancelled.
2019-10-17T01:05:23.670Z,1571274323.670 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2019-10-17T01:05:23.670Z,1571274323.670 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-10-17T01:05:23.670Z,1571274323.670 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2019-10-17T01:05:23.670Z,1571274323.670 [controlThread ThreadHandler](INFO): Thread cancelled.
2019-10-17T01:05:23.670Z,1571274323.670 [controlThread](INFO): Join timeout helper Thread ID is 1540
2019-10-17T01:05:23.697Z,1571274323.697 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2019-10-17T01:05:23.697Z,1571274323.697 [controlThread](DEBUG): Uninitializing ControlThread
2019-10-17T01:05:23.698Z,1571274323.698 [AHRS_M2](INFO): Powering down
2019-10-17T01:05:23.699Z,1571274323.699 [NAL9602](INFO): Powering down
2019-10-17T01:05:23.701Z,1571274323.701 [Aanderaa_O2](INFO): Powering down
2019-10-17T01:05:23.702Z,1571274323.702 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2019-10-17T01:05:23.703Z,1571274323.703 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2019-10-17T01:05:23.704Z,1571274323.704 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2019-10-17T01:05:23.704Z,1571274323.704 [MissionManager](INFO): Uninitializing Mission Default
2019-10-17T01:05:23.706Z,1571274323.706 [MissionManager](INFO): Uninitializing Mission Startup
2019-10-17T01:05:23.706Z,1571274323.706 [Startup] Stopped
2019-10-17T01:05:23.706Z,1571274323.707 [Startup](DEBUG): Aggregate::uninitialize Startup
2019-10-17T01:05:23.707Z,1571274323.707 [Startup:A.GoToSurface] Stopped
2019-10-17T01:05:23.707Z,1571274323.707 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2019-10-17T01:05:23.707Z,1571274323.707 [Startup:StartupSatComms] Stopped
2019-10-17T01:05:23.707Z,1571274323.707 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2019-10-17T01:05:23.707Z,1571274323.707 [Startup:StartupSatComms:A] Stopped
2019-10-17T01:05:23.708Z,1571274323.708 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2019-10-17T01:05:23.709Z,1571274323.709 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2019-10-17T01:05:23.709Z,1571274323.709 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2019-10-17T01:05:23.709Z,1571274323.709 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2019-10-17T01:05:23.709Z,1571274323.709 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2019-10-17T01:05:23.710Z,1571274323.710 [BuoyancyServo](INFO): Powering down
2019-10-17T01:05:23.721Z,1571274323.721 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2019-10-17T01:05:23.721Z,1571274323.721 [ElevatorServo](INFO): Powering down
2019-10-17T01:05:23.722Z,1571274323.722 [MassServo](DEBUG): Uninitialize Mass Servo.
2019-10-17T01:05:23.722Z,1571274323.722 [MassServo](INFO): Powering down
2019-10-17T01:05:23.723Z,1571274323.723 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2019-10-17T01:05:23.723Z,1571274323.723 [RudderServo](INFO): Powering down
2019-10-17T01:05:23.724Z,1571274323.724 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2019-10-17T01:05:23.724Z,1571274323.724 [ThrusterServo](INFO): Powering down
2019-10-17T01:05:23.724Z,1571274323.724 [SBIT](DEBUG): Uninitialize SBIT Component.
2019-10-17T01:05:23.725Z,1571274323.725 [IBIT](DEBUG): Uninitialize IBIT Component.
2019-10-17T01:05:23.725Z,1571274323.725 [CBIT](DEBUG): Uninitialize CBIT Component.
2019-10-17T01:05:23.725Z,1571274323.725 [CBIT](DEBUG): Powering off loads.
2019-10-17T01:05:23.737Z,1571274323.737 [CBIT](DEBUG): Disabling WDT.
2019-10-17T01:05:23.749Z,1571274323.749 [CBIT](DEBUG): Opening all GF detection circuits.
2019-10-17T01:05:23.750Z,1571274323.750 [controlThread ThreadHandler](INFO): Thread cancelled.
2019-10-17T01:05:23.840Z,1571274323.840 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-10-17T01:05:23.846Z,1571274323.846 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2019-10-17T01:05:23.875Z,1571274323.875 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2019-10-17T01:05:23.878Z,1571274323.878 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2019-10-17T01:05:23.913Z,1571274323.913 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-10-17T01:05:23.971Z,1571274323.971 [logger ThreadHandler](INFO): Thread cancelled.