2019-07-09T23:15:04.443Z,1562714104.443 [Supervisor](DEBUG): Initializing supervisor.
2019-07-09T23:15:04.446Z,1562714104.446 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2019-07-09T23:15:04.446Z,1562714104.446 [SyncHandler](INFO): Protected caller Thread ID is 6118
2019-07-09T23:15:04.447Z,1562714104.447 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2019-07-09T23:15:04.448Z,1562714104.448 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2019-07-09T23:15:04.448Z,1562714104.448 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 6119
2019-07-09T23:15:04.451Z,1562714104.451 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2019-07-09T23:15:04.462Z,1562714104.462 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2019-07-09T23:15:04.463Z,1562714104.463 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2019-07-09T23:15:04.463Z,1562714104.463 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 6120
2019-07-09T23:15:04.464Z,1562714104.464 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2019-07-09T23:15:04.465Z,1562714104.465 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2019-07-09T23:15:04.466Z,1562714104.466 [logger ThreadHandler](INFO): Protected caller Thread ID is 6121
2019-07-09T23:15:04.468Z,1562714104.468 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2019-07-09T23:15:04.468Z,1562714104.468 [Supervisor](INFO): Looking for Config files in directory: Config/
2019-07-09T23:15:04.470Z,1562714104.470 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2019-07-09T23:15:04.565Z,1562714104.565 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2019-07-09T23:15:04.565Z,1562714104.565 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2019-07-09T23:15:05.090Z,1562714105.090 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2019-07-09T23:15:05.091Z,1562714105.091 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2019-07-09T23:15:05.189Z,1562714105.189 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2019-07-09T23:15:05.190Z,1562714105.190 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2019-07-09T23:15:05.292Z,1562714105.292 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2019-07-09T23:15:05.293Z,1562714105.293 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2019-07-09T23:15:05.374Z,1562714105.374 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2019-07-09T23:15:05.513Z,1562714105.513 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2019-07-09T23:15:05.514Z,1562714105.514 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2019-07-09T23:15:05.811Z,1562714105.811 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2019-07-09T23:15:05.812Z,1562714105.812 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2019-07-09T23:15:06.276Z,1562714106.276 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2019-07-09T23:15:06.277Z,1562714106.277 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2019-07-09T23:15:06.422Z,1562714106.422 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2019-07-09T23:15:06.423Z,1562714106.423 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2019-07-09T23:15:06.619Z,1562714106.619 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2019-07-09T23:15:06.619Z,1562714106.619 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2019-07-09T23:15:07.149Z,1562714107.149 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2019-07-09T23:15:07.150Z,1562714107.150 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2019-07-09T23:15:07.368Z,1562714107.368 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2019-07-09T23:15:07.369Z,1562714107.369 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2019-07-09T23:15:07.571Z,1562714107.571 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2019-07-09T23:15:07.572Z,1562714107.572 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2019-07-09T23:15:07.954Z,1562714107.954 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2019-07-09T23:15:07.955Z,1562714107.955 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2019-07-09T23:15:08.289Z,1562714108.289 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2019-07-09T23:15:08.291Z,1562714108.291 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-pontus/
2019-07-09T23:15:08.292Z,1562714108.292 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/secure.cfg
2019-07-09T23:15:08.375Z,1562714108.375 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Sensor.cfg
2019-07-09T23:15:08.452Z,1562714108.452 [Config/Sensor](ERROR): Could not find unit: boo following DVL_micro.simulatedHardware = 0
2019-07-09T23:15:08.525Z,1562714108.525 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Servo.cfg
2019-07-09T23:15:08.634Z,1562714108.634 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Simulator.cfg
2019-07-09T23:15:08.720Z,1562714108.720 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/logger.cfg
2019-07-09T23:15:08.815Z,1562714108.815 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/vehicle.cfg
2019-07-09T23:15:08.997Z,1562714108.997 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Battery.cfg
2019-07-09T23:15:09.312Z,1562714109.312 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2019-07-09T23:15:09.312Z,1562714109.312 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Navigation.cfg
2019-07-09T23:15:09.407Z,1562714109.407 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/BIT.cfg
2019-07-09T23:15:09.571Z,1562714109.571 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Science.cfg
2019-07-09T23:15:09.691Z,1562714109.691 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Control.cfg
2019-07-09T23:15:09.878Z,1562714109.878 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-pontus/root/
2019-07-09T23:15:09.878Z,1562714109.878 [Supervisor](FAULT): Ignoring configuration overrides from Data/persisted.cfg
2019-07-09T23:15:09.879Z,1562714109.879 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2019-07-09T23:15:09.944Z,1562714109.944 [VerticalControl](DEBUG): Construct VerticalControl.
2019-07-09T23:15:10.056Z,1562714110.056 [VerticalControl] Loaded
2019-07-09T23:15:10.056Z,1562714110.056 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2019-07-09T23:15:10.057Z,1562714110.057 [HorizontalControl](DEBUG): Construct HorizontalControl.
2019-07-09T23:15:10.125Z,1562714110.125 [HorizontalControl] Loaded
2019-07-09T23:15:10.125Z,1562714110.125 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2019-07-09T23:15:10.126Z,1562714110.126 [SpeedControl](DEBUG): Construct SpeedControl.
2019-07-09T23:15:10.131Z,1562714110.131 [SpeedControl] Loaded
2019-07-09T23:15:10.132Z,1562714110.132 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2019-07-09T23:15:10.132Z,1562714110.132 [LoopControl](DEBUG): Construct LoopControl.
2019-07-09T23:15:10.133Z,1562714110.133 [LoopControl] Loaded
2019-07-09T23:15:10.133Z,1562714110.133 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2019-07-09T23:15:10.134Z,1562714110.134 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2019-07-09T23:15:10.134Z,1562714110.134 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2019-07-09T23:15:10.173Z,1562714110.173 [DepthRateCalculator] Loaded
2019-07-09T23:15:10.174Z,1562714110.174 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2019-07-09T23:15:10.179Z,1562714110.179 [PitchRateCalculator] Loaded
2019-07-09T23:15:10.179Z,1562714110.179 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2019-07-09T23:15:10.195Z,1562714110.195 [SpeedCalculator] Loaded
2019-07-09T23:15:10.195Z,1562714110.195 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2019-07-09T23:15:10.216Z,1562714110.216 [TempGradientCalculator] Loaded
2019-07-09T23:15:10.216Z,1562714110.216 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2019-07-09T23:15:10.221Z,1562714110.221 [YawRateCalculator] Loaded
2019-07-09T23:15:10.221Z,1562714110.221 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2019-07-09T23:15:10.251Z,1562714110.251 [ElevatorOffsetCalculator] Loaded
2019-07-09T23:15:10.251Z,1562714110.251 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2019-07-09T23:15:10.251Z,1562714110.251 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2019-07-09T23:15:10.252Z,1562714110.252 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2019-07-09T23:15:10.277Z,1562714110.277 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2019-07-09T23:15:10.278Z,1562714110.278 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2019-07-09T23:15:10.343Z,1562714110.343 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2019-07-09T23:15:10.344Z,1562714110.344 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2019-07-09T23:15:10.621Z,1562714110.621 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2019-07-09T23:15:10.622Z,1562714110.622 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2019-07-09T23:15:10.714Z,1562714110.714 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2019-07-09T23:15:10.715Z,1562714110.715 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2019-07-09T23:15:11.052Z,1562714111.052 [AHRS_M2] Loaded
2019-07-09T23:15:11.053Z,1562714111.053 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2019-07-09T23:15:11.128Z,1562714111.128 [DataOverHttps] Loaded
2019-07-09T23:15:11.129Z,1562714111.129 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2019-07-09T23:15:11.130Z,1562714111.130 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 408C74E0
2019-07-09T23:15:11.130Z,1562714111.130 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 6201
2019-07-09T23:15:11.143Z,1562714111.143 [Depth_Keller] Loaded
2019-07-09T23:15:11.144Z,1562714111.144 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2019-07-09T23:15:11.148Z,1562714111.148 [DropWeight] Loaded
2019-07-09T23:15:11.149Z,1562714111.149 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2019-07-09T23:15:11.276Z,1562714111.276 [DVL_micro] Loaded
2019-07-09T23:15:11.277Z,1562714111.277 [ComponentRegistry](DEBUG): SyncComponent "DVL_micro" handled in the control thread.
2019-07-09T23:15:11.373Z,1562714111.373 [NAL9602] Loaded
2019-07-09T23:15:11.374Z,1562714111.374 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2019-07-09T23:15:11.389Z,1562714111.389 [Onboard] Loaded
2019-07-09T23:15:11.390Z,1562714111.390 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2019-07-09T23:15:11.393Z,1562714111.393 [Radio_Surface] Loaded
2019-07-09T23:15:11.393Z,1562714111.393 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2019-07-09T23:15:11.394Z,1562714111.394 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 408F74E0
2019-07-09T23:15:11.395Z,1562714111.395 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 6202
2019-07-09T23:15:12.854Z,1562714112.854 [BPC1] Loaded
2019-07-09T23:15:12.854Z,1562714112.854 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2019-07-09T23:15:12.855Z,1562714112.855 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2019-07-09T23:15:12.855Z,1562714112.855 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2019-07-09T23:15:12.956Z,1562714112.956 [DeadReckonUsingMultipleVelocitySources] Loaded
2019-07-09T23:15:12.956Z,1562714112.956 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2019-07-09T23:15:12.977Z,1562714112.977 [NavChart] Loaded
2019-07-09T23:15:12.977Z,1562714112.977 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2019-07-09T23:15:12.981Z,1562714112.981 [UniversalFixResidualReporter] Loaded
2019-07-09T23:15:12.981Z,1562714112.981 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2019-07-09T23:15:12.982Z,1562714112.982 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2019-07-09T23:15:12.982Z,1562714112.982 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2019-07-09T23:15:13.109Z,1562714113.109 [SBIT](DEBUG): Construct Startup Built In Test.
2019-07-09T23:15:13.120Z,1562714113.120 [SBIT] Loaded
2019-07-09T23:15:13.121Z,1562714113.121 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2019-07-09T23:15:13.122Z,1562714113.122 [IBIT](DEBUG): Construct Initiated Built In Test.
2019-07-09T23:15:13.133Z,1562714113.133 [IBIT] Loaded
2019-07-09T23:15:13.133Z,1562714113.133 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2019-07-09T23:15:13.136Z,1562714113.136 [CBIT](DEBUG): Construct Continuous Built In Test.
2019-07-09T23:15:13.273Z,1562714113.273 [CBIT] Loaded
2019-07-09T23:15:13.273Z,1562714113.273 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2019-07-09T23:15:13.273Z,1562714113.273 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2019-07-09T23:15:13.274Z,1562714113.274 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2019-07-09T23:15:13.373Z,1562714113.373 [BuoyancyServo] Loaded
2019-07-09T23:15:13.374Z,1562714113.374 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2019-07-09T23:15:13.385Z,1562714113.385 [ElevatorServo] Loaded
2019-07-09T23:15:13.385Z,1562714113.385 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2019-07-09T23:15:13.396Z,1562714113.396 [MassServo] Loaded
2019-07-09T23:15:13.396Z,1562714113.396 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2019-07-09T23:15:13.408Z,1562714113.408 [RudderServo] Loaded
2019-07-09T23:15:13.408Z,1562714113.408 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2019-07-09T23:15:13.418Z,1562714113.418 [ThrusterServo] Loaded
2019-07-09T23:15:13.419Z,1562714113.419 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2019-07-09T23:15:13.419Z,1562714113.419 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2019-07-09T23:15:13.420Z,1562714113.420 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2019-07-09T23:15:13.432Z,1562714113.432 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2019-07-09T23:15:13.433Z,1562714113.433 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2019-07-09T23:15:13.675Z,1562714113.675 [CTD_NeilBrown] Loaded
2019-07-09T23:15:13.675Z,1562714113.675 [ComponentRegistry](DEBUG): Component "CTD_NeilBrown" handled in its own thread.
2019-07-09T23:15:13.676Z,1562714113.676 [CTD_NeilBrown ThreadHandler](DEBUG): Created PCaller Thread at 40A734E0
2019-07-09T23:15:13.677Z,1562714113.677 [CTD_NeilBrown ThreadHandler](INFO): Protected caller Thread ID is 6203
2019-07-09T23:15:13.686Z,1562714113.686 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_density
2019-07-09T23:15:13.691Z,1562714113.691 [CTD_Seabird](INFO): created writer for : sea_water_density
2019-07-09T23:15:13.692Z,1562714113.692 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): depth
2019-07-09T23:15:13.697Z,1562714113.697 [CTD_Seabird](INFO): created writer for : depth
2019-07-09T23:15:13.697Z,1562714113.697 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_pressure
2019-07-09T23:15:13.702Z,1562714113.702 [CTD_Seabird](INFO): created writer for : sea_water_pressure
2019-07-09T23:15:13.703Z,1562714113.703 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_salinity
2019-07-09T23:15:13.708Z,1562714113.708 [CTD_Seabird](INFO): created writer for : sea_water_salinity
2019-07-09T23:15:13.708Z,1562714113.708 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_temperature
2019-07-09T23:15:13.713Z,1562714113.713 [CTD_Seabird](INFO): created writer for : sea_water_temperature
2019-07-09T23:15:13.714Z,1562714113.714 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_electrical_conductivity
2019-07-09T23:15:13.719Z,1562714113.719 [CTD_Seabird](INFO): created writer for : sea_water_electrical_conductivity
2019-07-09T23:15:13.719Z,1562714113.719 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): speed_of_sound_in_sea_water
2019-07-09T23:15:13.724Z,1562714113.724 [CTD_Seabird](INFO): created writer for : speed_of_sound_in_sea_water
2019-07-09T23:15:13.751Z,1562714113.751 [CTD_Seabird] Loaded
2019-07-09T23:15:13.751Z,1562714113.751 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2019-07-09T23:15:13.752Z,1562714113.752 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40AA34E0
2019-07-09T23:15:13.752Z,1562714113.752 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 6204
2019-07-09T23:15:13.767Z,1562714113.767 [PAR_Licor] Loaded
2019-07-09T23:15:13.767Z,1562714113.767 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2019-07-09T23:15:13.815Z,1562714113.815 [WetLabsBB2FL] Loaded
2019-07-09T23:15:13.815Z,1562714113.815 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2019-07-09T23:15:13.816Z,1562714113.816 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40AD34E0
2019-07-09T23:15:13.816Z,1562714113.816 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 6205
2019-07-09T23:15:13.817Z,1562714113.817 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2019-07-09T23:15:13.821Z,1562714113.821 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2019-07-09T23:15:13.822Z,1562714113.822 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2019-07-09T23:15:13.828Z,1562714113.828 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2019-07-09T23:15:13.829Z,1562714113.829 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40B034E0
2019-07-09T23:15:13.830Z,1562714113.830 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 6206
2019-07-09T23:15:13.834Z,1562714113.834 [Supervisor](INFO): Main Thread ID is 6117
2019-07-09T23:15:13.834Z,1562714113.834 [Supervisor](DEBUG): Running supervisor.
2019-07-09T23:15:13.835Z,1562714113.835 [CommandLine ThreadHandler](INFO): Handler Thread ID is 6207
2019-07-09T23:15:13.838Z,1562714113.838 [controlThread ThreadHandler](INFO): Handler Thread ID is 6208
2019-07-09T23:15:13.838Z,1562714113.838 [controlThread](DEBUG): Initializing ControlThread
2019-07-09T23:15:13.839Z,1562714113.839 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2019-07-09T23:15:13.840Z,1562714113.840 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2019-07-09T23:15:13.841Z,1562714113.841 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2019-07-09T23:15:13.842Z,1562714113.842 [LoopControl](DEBUG): Initialize LoopControlComponent.
2019-07-09T23:15:13.842Z,1562714113.842 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2019-07-09T23:15:13.842Z,1562714113.842 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2019-07-09T23:15:13.843Z,1562714113.843 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2019-07-09T23:15:13.843Z,1562714113.843 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2019-07-09T23:15:13.843Z,1562714113.843 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2019-07-09T23:15:13.844Z,1562714113.844 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2019-07-09T23:15:13.849Z,1562714113.849 [NavChart](DEBUG): Initialize NavChart Navigation.
2019-07-09T23:15:13.849Z,1562714113.849 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2019-07-09T23:15:13.849Z,1562714113.849 [SBIT](INFO): Initialize SBIT Component.
2019-07-09T23:15:13.850Z,1562714113.850 [SBIT](IMPORTANT): git: 2019-05-01-10-gcab12ce
2019-07-09T23:15:13.850Z,1562714113.850 [SBIT](INFO): git hash: cab12ce958be6da2bb158d8a74bde728d70637cd
2019-07-09T23:15:13.850Z,1562714113.850 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2019-07-09T23:15:13.850Z,1562714113.850 [SBIT](IMPORTANT): Kernel Version:#1 PREEMPT Thu Feb 21 11:17:40 PST 2019
2019-07-09T23:15:13.852Z,1562714113.852 [SBIT](INFO): Beginning SBIT in 28.000000 seconds.
2019-07-09T23:15:13.852Z,1562714113.852 [IBIT](INFO): Initialize IBIT Component.
2019-07-09T23:15:13.853Z,1562714113.853 [CBIT](DEBUG): Initialize CBIT Component.
2019-07-09T23:15:13.854Z,1562714113.854 [logger ThreadHandler](INFO): Handler Thread ID is 6209
2019-07-09T23:15:13.866Z,1562714113.866 [CBIT](DEBUG): Initialized mux pins.
2019-07-09T23:15:13.866Z,1562714113.866 [CBIT](FAULT): LAST RESTART WAS UNINTENTIONAL.
2019-07-09T23:15:13.866Z,1562714113.866 [CBIT](DEBUG): Initializing the watchdog timer.
2019-07-09T23:15:13.874Z,1562714113.874 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 6210
2019-07-09T23:15:13.875Z,1562714113.875 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2019-07-09T23:15:13.886Z,1562714113.886 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 6211
2019-07-09T23:15:13.890Z,1562714113.890 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2019-07-09T23:15:13.890Z,1562714113.890 [CBIT](DEBUG): Initializing heartbeat.
2019-07-09T23:15:13.898Z,1562714113.898 [CTD_NeilBrown ThreadHandler](INFO): Handler Thread ID is 6212
2019-07-09T23:15:13.910Z,1562714113.910 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 6213
2019-07-09T23:15:13.911Z,1562714113.911 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2019-07-09T23:15:13.914Z,1562714113.914 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2019-07-09T23:15:13.915Z,1562714113.915 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 6215
2019-07-09T23:15:13.917Z,1562714113.917 [WetLabsBB2FL](INFO): Powering down
2019-07-09T23:15:13.943Z,1562714113.943 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 6216
2019-07-09T23:15:13.946Z,1562714113.946 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2019-07-09T23:15:13.947Z,1562714113.947 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2019-07-09T23:15:13.947Z,1562714113.947 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2019-07-09T23:15:13.947Z,1562714113.947 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2019-07-09T23:15:13.947Z,1562714113.947 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2019-07-09T23:15:13.947Z,1562714113.947 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2019-07-09T23:15:13.948Z,1562714113.948 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2019-07-09T23:15:13.948Z,1562714113.948 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2019-07-09T23:15:13.948Z,1562714113.948 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2019-07-09T23:15:13.948Z,1562714113.948 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2019-07-09T23:15:13.948Z,1562714113.948 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2019-07-09T23:15:13.949Z,1562714113.949 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2019-07-09T23:15:13.949Z,1562714113.949 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2019-07-09T23:15:13.949Z,1562714113.949 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2019-07-09T23:15:13.949Z,1562714113.949 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2019-07-09T23:15:13.950Z,1562714113.950 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2019-07-09T23:15:13.962Z,1562714113.962 [CBIT](DEBUG): Deactivating GF circuits.
2019-07-09T23:15:13.962Z,1562714113.962 [CBIT](DEBUG): Deactivating emergency mode.
2019-07-09T23:15:13.998Z,1562714113.998 [CBIT](DEBUG): Backplane powered.
2019-07-09T23:15:14.003Z,1562714114.003 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2019-07-09T23:15:14.027Z,1562714114.027 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2019-07-09T23:15:14.064Z,1562714114.064 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns="Tethys"
       xmlns:Control="Tethys/Control"
       xmlns:Guidance="Tethys/Guidance" 
       xmlns:Units="Tethys/Units"
       xmlns:Universal="Tethys/Universal"
       xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
       xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                           Tethys/Control http://okeanids.mbari.org/tethys/Xml/Control.xsd
                           Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                           Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                           Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
       Id="Startup">

    <Guidance:GoToSurface>
        <Progression/>
    </Guidance:GoToSurface>

    <Aggregate Id="StartupSatComms">

        <Sequence/>

        <ReadDatum>
            <Timeout Duration="P1M" />
            <Universal:latitude_fix/>
        </ReadDatum>

        <ReadDatum>
            <Timeout Duration="P1M" />
            <Universal:platform_communications/>
        </ReadDatum>

    </Aggregate>

</Mission>


2019-07-09T23:15:14.065Z,1562714114.065 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2019-07-09T23:15:14.136Z,1562714114.136 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2019-07-09T23:15:14.137Z,1562714114.137 [Default:A.Wait](DEBUG): Construct Wait.
2019-07-09T23:15:14.139Z,1562714114.139 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2019-07-09T23:15:14.198Z,1562714114.198 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2019-07-09T23:15:14.201Z,1562714114.201 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2019-07-09T23:15:14.222Z,1562714114.222 [Default:E.Execute](DEBUG): Construct Execute.
2019-07-09T23:15:14.225Z,1562714114.225 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
         xmlns="Tethys"
         xmlns:Units="Tethys/Units"
         xmlns:Guidance="Tethys/Guidance"
         xmlns:Universal="Tethys/Universal"
         xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                             Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                             Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                             Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
         Id="Default">

    <DefineArg Name="ElapsedSinceDefaultStarted"><Units:minute/><Value>0</Value></DefineArg>

    <Guidance:Wait>
        <Description>
            Wait a moment to see if the scheduler starts a new mission before
            starting to actually run Default.
        </Description>
        <Sequence/>
        <Setting><Guidance:Wait.duration/><Units:second/><Value>13</Value></Setting>
    </Guidance:Wait>

    <Guidance:GoToSurface>
        <Progression/>
    </Guidance:GoToSurface>

    <Aggregate Id="CheckIn">

        <Sequence Repeat="288"/>

        <ReadDatum Id="Read_GPS">
            <Timeout Duration="P5M"/>
            <Universal:time_fix/>
        </ReadDatum>

        <ReadDatum Id="Read_Iridium">
            <Timeout Duration="P2H">
                <Guidance:Execute>
                    <Sequence/>
                    <Setting><Guidance:Execute.command/><String>Burn on</String></Setting>
                </Guidance:Execute>
                <Syslog Severity="Critical">Dropped weight due to communications timeout.</Syslog>
            </Timeout>
            <Universal:platform_communications/>
        </ReadDatum>

        <Guidance:Wait>
            <Sequence/>
            <Setting><Guidance:Wait.duration/><Units:minute/><Value>5</Value></Setting>
        </Guidance:Wait>

        <Assign><Sequence/><Arg Name="ElapsedSinceDefaultStarted"/><Elapsed><Universal:mission_started/></Elapsed></Assign>

        <Syslog Severity="Important">Default mission has been running for <Arg Name="ElapsedSinceDefaultStarted"/><Units:minute/></Syslog>

    </Aggregate>

    <Syslog Severity="Important">Restarting logs and Default mission.</Syslog>

    <Guidance:Execute>
        <Sequence/>
        <Setting><Guidance:Execute.command/><String>restart logs</String></Setting>
    </Guidance:Execute>

</Mission>


2019-07-09T23:15:14.246Z,1562714114.246 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,Depth_Keller,DropWeight,DVL_micro,NAL9602,Onboard,BPC1,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-07-09T23:15:14.251Z,1562714114.251 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2019-07-09T23:15:14.290Z,1562714114.290 [Radio_Surface](INFO): Powering up
2019-07-09T23:15:14.347Z,1562714114.347 [DVL_micro](INFO): Initializing
2019-07-09T23:15:14.454Z,1562714114.454 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2019-07-09T23:15:14.498Z,1562714114.498 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2019-07-09T23:15:14.499Z,1562714114.499 [ElevatorServo](DEBUG): Initializing EZServoServo.
2019-07-09T23:15:14.518Z,1562714114.518 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2019-07-09T23:15:14.519Z,1562714114.519 [MassServo](DEBUG): Initializing EZServoServo.
2019-07-09T23:15:14.526Z,1562714114.526 [MassServo](DEBUG): Initializing MassServo.
2019-07-09T23:15:14.527Z,1562714114.527 [RudderServo](DEBUG): Initializing EZServoServo.
2019-07-09T23:15:14.538Z,1562714114.538 [RudderServo](DEBUG): Initializing RudderServo.
2019-07-09T23:15:14.539Z,1562714114.539 [ThrusterServo](DEBUG): Initializing EZServoServo.
2019-07-09T23:15:14.546Z,1562714114.546 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2019-07-09T23:15:14.670Z,1562714114.670 [Depth_Keller](ERROR): Pressure reading out of range: 1925.893799 decibar
2019-07-09T23:15:14.671Z,1562714114.671 [DropWeight](CRITICAL): DROP WEIGHT MISSING.

2019-07-09T23:15:14.671Z,1562714114.671 [DropWeight] Hardware Fault, FailCount= 1
2019-07-09T23:15:14.671Z,1562714114.671 [DropWeight](ERROR): Hardware Fault
2019-07-09T23:15:14.762Z,1562714114.762 [CommandLine](FAULT): Scheduling is paused
2019-07-09T23:15:14.762Z,1562714114.762 [CBIT](INFO): Critical error at 20190709T231514
2019-07-09T23:15:14.762Z,1562714114.762 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2019-07-09T23:15:14.765Z,1562714114.765 [CBIT](ERROR): Hardware Fault in component: DropWeight
2019-07-09T23:15:14.786Z,1562714114.786 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2019-07-09T23:15:15.287Z,1562714115.287 [CBIT](INFO): Critical error at 20190709T231514
2019-07-09T23:15:17.806Z,1562714117.806 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:15:18.278Z,1562714118.278 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:15:19.042Z,1562714119.042 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:15:19.642Z,1562714119.642 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:15:20.090Z,1562714120.090 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:15:20.498Z,1562714120.498 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:15:20.942Z,1562714120.942 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:15:21.534Z,1562714121.534 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:15:22.034Z,1562714122.034 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:15:22.462Z,1562714122.462 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:15:22.878Z,1562714122.878 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:15:23.278Z,1562714123.278 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:15:23.698Z,1562714123.698 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:15:24.114Z,1562714124.114 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:15:24.174Z,1562714124.174 [CBIT](CRITICAL): Environmental Failure. Press:14.474517 PSI. Humidity:47%. Temp:24 C. ABORTING MISSION
2019-07-09T23:15:24.522Z,1562714124.522 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:15:24.595Z,1562714124.595 [CBIT](INFO): Critical error at 20190709T231524
2019-07-09T23:15:24.930Z,1562714124.930 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:15:24.935Z,1562714124.935 [DVL_micro](ERROR): No DVL communication! Re-initializing
2019-07-09T23:15:24.935Z,1562714124.935 [DVL_micro] Communications Fault, FailCount= 1
2019-07-09T23:15:24.935Z,1562714124.935 [DVL_micro](ERROR): Communications Fault
2019-07-09T23:15:24.994Z,1562714124.994 [CBIT](ERROR): Communications Fault in component: DVL_micro
2019-07-09T23:15:25.338Z,1562714125.338 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:15:25.426Z,1562714125.426 [DVL_micro](INFO): uninitialize:Powering down
2019-07-09T23:15:25.862Z,1562714125.862 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:15:26.250Z,1562714126.250 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:15:26.350Z,1562714126.350 [CBIT](INFO): Clearing failed state for component DVL_micro
2019-07-09T23:15:26.350Z,1562714126.350 [DVL_micro] No Fault, FailCount= 1
2019-07-09T23:15:26.686Z,1562714126.686 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:15:26.697Z,1562714126.697 [DVL_micro](INFO): Initializing
2019-07-09T23:15:26.962Z,1562714126.962 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2019-07-09T23:15:26.962Z,1562714126.962 [CTD_Seabird] Communications Fault, FailCount= 1
2019-07-09T23:15:26.962Z,1562714126.962 [CTD_Seabird](ERROR): Communications Fault
2019-07-09T23:15:27.098Z,1562714127.098 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:15:27.098Z,1562714127.098 [AHRS_M2](FAULT): Failed to initialize within timeout.
2019-07-09T23:15:27.098Z,1562714127.098 [AHRS_M2] Communications Fault, FailCount= 1
2019-07-09T23:15:27.098Z,1562714127.098 [AHRS_M2](ERROR): Communications Fault
2019-07-09T23:15:27.186Z,1562714127.186 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2019-07-09T23:15:27.186Z,1562714127.186 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2019-07-09T23:15:27.206Z,1562714127.206 [AHRS_M2](INFO): Powering down
2019-07-09T23:15:27.366Z,1562714127.366 [CTD_Seabird](INFO): Powering down
2019-07-09T23:15:28.058Z,1562714128.058 [CBIT](INFO): Clearing failed state for component AHRS_M2
2019-07-09T23:15:28.058Z,1562714128.058 [AHRS_M2] No Fault, FailCount= 1
2019-07-09T23:15:28.410Z,1562714128.410 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2019-07-09T23:15:28.486Z,1562714128.486 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2019-07-09T23:15:28.486Z,1562714128.486 [CTD_Seabird] No Fault, FailCount= 1
2019-07-09T23:15:28.726Z,1562714128.726 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2019-07-09T23:15:28.727Z,1562714128.727 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2019-07-09T23:15:31.966Z,1562714131.966 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:15:32.370Z,1562714132.370 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:15:32.802Z,1562714132.802 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:15:33.198Z,1562714133.198 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:15:33.606Z,1562714133.606 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:15:34.038Z,1562714134.038 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:15:34.438Z,1562714134.438 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:15:34.842Z,1562714134.842 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:15:35.294Z,1562714135.294 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:15:35.682Z,1562714135.682 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:15:36.090Z,1562714136.090 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:15:36.502Z,1562714136.502 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:15:36.894Z,1562714136.894 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:15:37.310Z,1562714137.310 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:15:37.315Z,1562714137.315 [DVL_micro](ERROR): No DVL communication! Re-initializing
2019-07-09T23:15:37.315Z,1562714137.315 [DVL_micro] Communications Fault, FailCount= 2
2019-07-09T23:15:37.315Z,1562714137.315 [DVL_micro](ERROR): Communications Fault
2019-07-09T23:15:37.418Z,1562714137.418 [CBIT](ERROR): Communications Fault in component: DVL_micro
2019-07-09T23:15:37.750Z,1562714137.750 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:15:37.826Z,1562714137.826 [DVL_micro](INFO): uninitialize:Powering down
2019-07-09T23:15:38.230Z,1562714138.230 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:15:38.630Z,1562714138.630 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:15:38.682Z,1562714138.682 [CBIT](INFO): Clearing failed state for component DVL_micro
2019-07-09T23:15:38.682Z,1562714138.682 [DVL_micro] No Fault, FailCount= 2
2019-07-09T23:15:39.014Z,1562714139.014 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:15:39.025Z,1562714139.025 [DVL_micro](INFO): Initializing
2019-07-09T23:15:39.438Z,1562714139.438 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:15:39.830Z,1562714139.830 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:15:40.222Z,1562714140.222 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:15:40.650Z,1562714140.650 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:15:41.054Z,1562714141.054 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:15:41.470Z,1562714141.470 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:15:41.470Z,1562714141.470 [AHRS_M2](FAULT): Failed to initialize within timeout.
2019-07-09T23:15:41.470Z,1562714141.470 [AHRS_M2] Communications Fault, FailCount= 2
2019-07-09T23:15:41.470Z,1562714141.470 [AHRS_M2](ERROR): Communications Fault
2019-07-09T23:15:41.475Z,1562714141.475 [NAL9602](INFO): Powering up NAL9602
2019-07-09T23:15:41.572Z,1562714141.572 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2019-07-09T23:15:41.586Z,1562714141.586 [AHRS_M2](INFO): Powering down
2019-07-09T23:15:41.782Z,1562714141.782 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2019-07-09T23:15:41.782Z,1562714141.782 [CTD_Seabird] Communications Fault, FailCount= 2
2019-07-09T23:15:41.782Z,1562714141.782 [CTD_Seabird](ERROR): Communications Fault
2019-07-09T23:15:42.058Z,1562714142.058 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2019-07-09T23:15:42.186Z,1562714142.186 [CTD_Seabird](INFO): Powering down
2019-07-09T23:15:42.442Z,1562714142.442 [SBIT](IMPORTANT): Beginning Startup BIT
2019-07-09T23:15:42.448Z,1562714142.448 [CBIT](INFO): Clearing failed state for component AHRS_M2
2019-07-09T23:15:42.448Z,1562714142.448 [AHRS_M2] No Fault, FailCount= 2
2019-07-09T23:15:42.449Z,1562714142.449 [CBIT](IMPORTANT): Beginning ground fault scan
2019-07-09T23:15:42.786Z,1562714142.786 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2019-07-09T23:15:43.295Z,1562714143.295 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2019-07-09T23:15:43.295Z,1562714143.295 [CTD_Seabird] No Fault, FailCount= 2
2019-07-09T23:15:43.530Z,1562714143.530 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2019-07-09T23:15:43.538Z,1562714143.538 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2019-07-09T23:15:46.462Z,1562714146.462 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:15:47.134Z,1562714147.134 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:15:47.626Z,1562714147.626 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:15:48.310Z,1562714148.310 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:15:48.766Z,1562714148.766 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:15:49.226Z,1562714149.226 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:15:49.674Z,1562714149.674 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:15:49.679Z,1562714149.679 [DVL_micro](ERROR): No DVL communication! Re-initializing
2019-07-09T23:15:49.679Z,1562714149.679 [DVL_micro] Communications Fault, FailCount= 3
2019-07-09T23:15:49.679Z,1562714149.679 [DVL_micro](ERROR): Communications Fault
2019-07-09T23:15:49.803Z,1562714149.803 [CBIT](ERROR): Communications Fault in component: DVL_micro
2019-07-09T23:15:50.258Z,1562714150.258 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:15:50.334Z,1562714150.334 [DVL_micro](INFO): uninitialize:Powering down
2019-07-09T23:15:50.766Z,1562714150.766 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:15:51.234Z,1562714151.234 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:15:51.342Z,1562714151.342 [CBIT](INFO): Clearing failed state for component DVL_micro
2019-07-09T23:15:51.342Z,1562714151.342 [DVL_micro] No Fault, FailCount= 3
2019-07-09T23:15:51.786Z,1562714151.786 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:15:51.797Z,1562714151.797 [DVL_micro](INFO): Initializing
2019-07-09T23:15:52.282Z,1562714152.282 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:15:52.742Z,1562714152.742 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:15:53.290Z,1562714153.290 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:15:53.758Z,1562714153.758 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:15:54.202Z,1562714154.202 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:15:54.734Z,1562714154.734 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:15:54.870Z,1562714154.870 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.028213
CHAN A1 (24V): 0.013554
CHAN A2 (12V): -0.007382
CHAN A3 (5V): -0.002151
CHAN B0 (3.3V): 0.000131
CHAN B1 (3.15aV): -0.000192
CHAN B2 (3.15bV): -0.000222
CHAN B3 (GND): 0.002259
OPEN: -0.000186
Full Scale Calc: 4.765 mA, -1.589 mA
2019-07-09T23:15:55.206Z,1562714155.206 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:15:55.670Z,1562714155.670 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:15:55.827Z,1562714155.827 [CommandLine](IMPORTANT): got command maintain control VerticalControl.massPositionAction 40.000000 millimeter
2019-07-09T23:15:55.828Z,1562714155.828 [ComponentRegistry](DEBUG): SyncComponent "Maintain_VerticalControl.massPositionAction" handled in the control thread.
2019-07-09T23:15:55.868Z,1562714155.868 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,Depth_Keller,DropWeight,DVL_micro,NAL9602,Onboard,BPC1,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,Maintain_VerticalControl.massPositionAction,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2019-07-09T23:15:56.190Z,1562714156.190 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:15:56.190Z,1562714156.190 [AHRS_M2](FAULT): Failed to initialize within timeout.
2019-07-09T23:15:56.190Z,1562714156.190 [AHRS_M2] Communications Fault, FailCount= 3
2019-07-09T23:15:56.190Z,1562714156.190 [AHRS_M2](ERROR): Communications Fault
2019-07-09T23:15:56.283Z,1562714156.283 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2019-07-09T23:15:56.289Z,1562714156.289 [AHRS_M2](INFO): Powering down
2019-07-09T23:15:57.148Z,1562714157.148 [CBIT](INFO): Clearing failed state for component AHRS_M2
2019-07-09T23:15:57.148Z,1562714157.148 [AHRS_M2] No Fault, FailCount= 3
2019-07-09T23:15:57.498Z,1562714157.498 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2019-07-09T23:15:57.586Z,1562714157.586 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2019-07-09T23:15:57.586Z,1562714157.586 [CTD_Seabird] Communications Fault, FailCount= 3
2019-07-09T23:15:57.586Z,1562714157.586 [CTD_Seabird](ERROR): Communications Fault
2019-07-09T23:15:57.747Z,1562714157.747 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2019-07-09T23:15:57.747Z,1562714157.747 [CBIT](FAULT): Communications Fault in component: CTD_Seabird
2019-07-09T23:15:57.990Z,1562714157.990 [CTD_Seabird](INFO): Powering down
2019-07-09T23:16:01.138Z,1562714161.138 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:16:01.630Z,1562714161.630 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:16:02.094Z,1562714162.094 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:16:02.558Z,1562714162.558 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:16:02.563Z,1562714162.563 [DVL_micro](ERROR): No DVL communication! Re-initializing
2019-07-09T23:16:02.563Z,1562714162.563 [DVL_micro] Communications Fault, FailCount= 4
2019-07-09T23:16:02.563Z,1562714162.563 [DVL_micro](ERROR): Communications Fault
2019-07-09T23:16:02.565Z,1562714162.565 [NAL9602](ERROR): NAL9602 initialization error.
2019-07-09T23:16:02.565Z,1562714162.565 [NAL9602] Communications Fault, FailCount= 1
2019-07-09T23:16:02.565Z,1562714162.565 [NAL9602](ERROR): Communications Fault
2019-07-09T23:16:02.743Z,1562714162.743 [CBIT](ERROR): Communications Fault in component: DVL_micro
2019-07-09T23:16:02.743Z,1562714162.743 [CBIT](ERROR): Communications Fault in component: NAL9602
2019-07-09T23:16:03.074Z,1562714163.074 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:16:03.150Z,1562714163.150 [DVL_micro](INFO): uninitialize:Powering down
2019-07-09T23:16:03.151Z,1562714163.151 [NAL9602](INFO): Powering down
2019-07-09T23:16:03.802Z,1562714163.802 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:16:04.234Z,1562714164.234 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:16:04.331Z,1562714164.331 [CBIT](INFO): Clearing failed state for component DVL_micro
2019-07-09T23:16:04.331Z,1562714164.331 [DVL_micro] No Fault, FailCount= 4
2019-07-09T23:16:04.331Z,1562714164.331 [CBIT](INFO): Clearing failed state for component NAL9602
2019-07-09T23:16:04.331Z,1562714164.331 [NAL9602] No Fault, FailCount= 1
2019-07-09T23:16:04.662Z,1562714164.662 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:16:04.680Z,1562714164.680 [DVL_micro](INFO): Initializing
2019-07-09T23:16:05.130Z,1562714165.130 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:16:05.562Z,1562714165.562 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:16:06.014Z,1562714166.014 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:16:06.442Z,1562714166.442 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:16:06.838Z,1562714166.838 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:16:07.250Z,1562714167.250 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:16:07.662Z,1562714167.662 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:16:08.066Z,1562714168.066 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:16:08.474Z,1562714168.474 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:16:08.878Z,1562714168.878 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:16:09.294Z,1562714169.294 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:16:09.698Z,1562714169.698 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:16:10.114Z,1562714170.114 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:16:10.530Z,1562714170.530 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:16:10.530Z,1562714170.530 [AHRS_M2](FAULT): Failed to initialize within timeout.
2019-07-09T23:16:10.530Z,1562714170.530 [AHRS_M2] Communications Fault, FailCount= 4
2019-07-09T23:16:10.530Z,1562714170.530 [AHRS_M2](ERROR): Communications Fault
2019-07-09T23:16:10.619Z,1562714170.619 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2019-07-09T23:16:10.635Z,1562714170.635 [AHRS_M2](INFO): Powering down
2019-07-09T23:16:11.511Z,1562714171.511 [CBIT](INFO): Clearing failed state for component AHRS_M2
2019-07-09T23:16:11.511Z,1562714171.511 [AHRS_M2] No Fault, FailCount= 4
2019-07-09T23:16:11.846Z,1562714171.846 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2019-07-09T23:16:15.402Z,1562714175.402 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:16:15.407Z,1562714175.407 [DVL_micro](ERROR): No DVL communication! Re-initializing
2019-07-09T23:16:15.407Z,1562714175.407 [DVL_micro] Communications Fault, FailCount= 5
2019-07-09T23:16:15.407Z,1562714175.407 [DVL_micro](ERROR): Communications Fault
2019-07-09T23:16:15.515Z,1562714175.515 [CBIT](ERROR): Communications Fault in component: DVL_micro
2019-07-09T23:16:15.515Z,1562714175.515 [CBIT](CRITICAL): Communications Fault in component: DVL_micro
2019-07-09T23:16:15.842Z,1562714175.842 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:16:15.918Z,1562714175.918 [DVL_micro](INFO): uninitialize:Powering down
2019-07-09T23:16:16.017Z,1562714176.017 [CBIT](INFO): Critical error at 20190709T231615
2019-07-09T23:16:16.358Z,1562714176.358 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:16:16.770Z,1562714176.770 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:16:17.186Z,1562714177.186 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:16:17.614Z,1562714177.614 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:16:18.026Z,1562714178.026 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:16:18.438Z,1562714178.438 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:16:18.854Z,1562714178.854 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:16:19.274Z,1562714179.274 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:16:19.682Z,1562714179.682 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:16:20.098Z,1562714180.098 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:16:20.522Z,1562714180.522 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:16:20.938Z,1562714180.938 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:16:21.354Z,1562714181.354 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:16:21.754Z,1562714181.754 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:16:22.178Z,1562714182.178 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:16:22.606Z,1562714182.606 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:16:22.680Z,1562714182.680 [SBIT](FAULT): Mass: EXPECTED:-0.002000 ACTUAL:0.029038
2019-07-09T23:16:22.680Z,1562714182.680 [SBIT](FAULT): Control surface position failure.
2019-07-09T23:16:23.006Z,1562714183.006 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:16:23.430Z,1562714183.430 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:16:23.846Z,1562714183.846 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:16:24.262Z,1562714184.262 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:16:24.666Z,1562714184.666 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:16:25.194Z,1562714185.194 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:16:25.194Z,1562714185.194 [AHRS_M2](FAULT): Failed to initialize within timeout.
2019-07-09T23:16:25.194Z,1562714185.194 [AHRS_M2] Communications Fault, FailCount= 5
2019-07-09T23:16:25.194Z,1562714185.194 [AHRS_M2](ERROR): Communications Fault
2019-07-09T23:16:25.327Z,1562714185.327 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2019-07-09T23:16:25.327Z,1562714185.327 [CBIT](CRITICAL): Communications Fault in component: AHRS_M2
2019-07-09T23:16:25.333Z,1562714185.333 [AHRS_M2](INFO): Powering down
2019-07-09T23:16:25.544Z,1562714185.544 [CBIT](INFO): Critical error at 20190709T231625
2019-07-09T23:16:33.415Z,1562714193.415 [NAL9602](INFO): Powering up NAL9602
2019-07-09T23:16:36.352Z,1562714196.352 [SBIT](FAULT): Mass: EXPECTED:0.002000 ACTUAL:0.039172
2019-07-09T23:16:36.352Z,1562714196.352 [SBIT](FAULT): Control surface position failure.
2019-07-09T23:16:36.759Z,1562714196.759 [SBIT](CRITICAL): SBIT FAILED
2019-07-09T23:16:36.778Z,1562714196.778 [CBIT](INFO): Critical error at 20190709T231636
2019-07-09T23:16:36.836Z,1562714196.836 [CommandLine](IMPORTANT): got command configSet list
2019-07-09T23:16:36.837Z,1562714196.837 [CommandLine](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2019-07-09T23:16:36.837Z,1562714196.837 [CommandLine](IMPORTANT): No configSet variables persisted
2019-07-09T23:16:37.081Z,1562714197.081 [MissionManager](IMPORTANT): Started mission Startup
2019-07-09T23:16:37.081Z,1562714197.081 [Startup] Running Loop=1
2019-07-09T23:16:37.081Z,1562714197.081 [Startup](DEBUG): Aggregate::initialize Startup
2019-07-09T23:16:37.081Z,1562714197.081 [Startup:A.GoToSurface] Running Loop=1
2019-07-09T23:16:37.081Z,1562714197.081 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2019-07-09T23:16:37.082Z,1562714197.082 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2019-07-09T23:16:37.083Z,1562714197.083 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2019-07-09T23:16:37.083Z,1562714197.083 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2019-07-09T23:16:37.084Z,1562714197.084 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2019-07-09T23:16:37.084Z,1562714197.084 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2019-07-09T23:16:37.085Z,1562714197.085 [Startup:StartupSatComms] Running Loop=1
2019-07-09T23:16:37.086Z,1562714197.086 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2019-07-09T23:16:37.086Z,1562714197.086 [Startup:StartupSatComms:A] Running Loop=1
2019-07-09T23:16:37.486Z,1562714197.486 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2019-07-09T23:16:40.006Z,1562714200.006 [CommandLine](IMPORTANT): got command burn
2019-07-09T23:16:40.007Z,1562714200.007 [CommandLine](FAULT): Incomplete syntax. Try: help burn
2019-07-09T23:16:51.731Z,1562714211.731 [CommandLine](IMPORTANT): got command ! echo 1 > /dev/loadB2
2019-07-09T23:16:54.023Z,1562714214.023 [NAL9602](ERROR): NAL9602 initialization error.
2019-07-09T23:16:54.023Z,1562714214.023 [NAL9602] Communications Fault, FailCount= 2
2019-07-09T23:16:54.023Z,1562714214.023 [NAL9602](ERROR): Communications Fault
2019-07-09T23:16:54.147Z,1562714214.147 [CBIT](ERROR): Communications Fault in component: NAL9602
2019-07-09T23:16:54.427Z,1562714214.427 [NAL9602](INFO): Powering down
2019-07-09T23:16:55.338Z,1562714215.338 [CBIT](INFO): Clearing failed state for component NAL9602
2019-07-09T23:16:55.338Z,1562714215.338 [NAL9602] No Fault, FailCount= 2
2019-07-09T23:17:13.611Z,1562714233.611 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004574
2019-07-09T23:17:14.242Z,1562714234.242 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-07-09T23:17:14.242Z,1562714234.242 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2019-07-09T23:17:14.242Z,1562714234.242 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-09T23:17:14.334Z,1562714234.334 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-09T23:17:14.750Z,1562714234.750 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-09T23:17:14.750Z,1562714234.750 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2019-07-09T23:17:24.727Z,1562714244.727 [NAL9602](INFO): Powering up NAL9602
2019-07-09T23:17:37.271Z,1562714257.271 [Startup:StartupSatComms:A](INFO): Timed out from 2019-07-09T23:16:37.1Z
2019-07-09T23:17:37.272Z,1562714257.272 [Startup:StartupSatComms:A] Stopped
2019-07-09T23:17:37.272Z,1562714257.272 [Startup:StartupSatComms:B] Running Loop=1
2019-07-09T23:17:37.708Z,1562714257.708 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2019-07-09T23:17:39.850Z,1562714259.850 [DataOverHttps](INFO): Sending 107 bytes from file Logs/20190709T223339/Courier0010.lzma
2019-07-09T23:17:40.659Z,1562714260.659 [DataOverHttps](INFO): Moved sent file to Logs/20190709T223339/Courier0010.lzma.bak
2019-07-09T23:17:40.660Z,1562714260.660 [DataOverHttps](INFO): SBD MOMSN=11436614
2019-07-09T23:17:45.476Z,1562714265.476 [NAL9602](ERROR): NAL9602 initialization error.
2019-07-09T23:17:45.476Z,1562714265.476 [NAL9602] Communications Fault, FailCount= 3
2019-07-09T23:17:45.476Z,1562714265.476 [NAL9602](ERROR): Communications Fault
2019-07-09T23:17:45.635Z,1562714265.635 [CBIT](ERROR): Communications Fault in component: NAL9602
2019-07-09T23:17:45.887Z,1562714265.887 [NAL9602](INFO): Powering down
2019-07-09T23:17:46.794Z,1562714266.794 [CBIT](INFO): Clearing failed state for component NAL9602
2019-07-09T23:17:46.794Z,1562714266.794 [NAL9602] No Fault, FailCount= 3
2019-07-09T23:17:52.868Z,1562714272.868 [DataOverHttps](INFO): Sending 2013 bytes from file Logs/20190709T230649/Courier0000.lzma
2019-07-09T23:17:53.663Z,1562714273.663 [DataOverHttps](INFO): Moved sent file to Logs/20190709T230649/Courier0000.lzma.bak
2019-07-09T23:17:53.663Z,1562714273.663 [DataOverHttps](INFO): SBD MOMSN=11436619
2019-07-09T23:18:05.190Z,1562714285.190 [DataOverHttps](INFO): Sending 273 bytes from file Logs/20190709T231504/Courier0000.lzma
2019-07-09T23:18:05.995Z,1562714285.995 [DataOverHttps](INFO): Moved sent file to Logs/20190709T231504/Courier0000.lzma.bak
2019-07-09T23:18:05.995Z,1562714285.995 [DataOverHttps](INFO): SBD MOMSN=11437312
2019-07-09T23:18:16.187Z,1562714296.187 [NAL9602](INFO): Powering up NAL9602
2019-07-09T23:18:18.442Z,1562714298.442 [DataOverHttps](INFO): Sending 344 bytes from file Logs/20190709T223339/Express0011.lzma
2019-07-09T23:18:19.247Z,1562714299.247 [DataOverHttps](INFO): Moved sent file to Logs/20190709T223339/Express0011.lzma.bak
2019-07-09T23:18:19.247Z,1562714299.247 [DataOverHttps](INFO): SBD MOMSN=11437321
2019-07-09T23:18:27.610Z,1562714307.610 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2019-07-09T23:18:27.611Z,1562714307.611 [CTD_Seabird] No Fault, FailCount= 3
2019-07-09T23:18:27.658Z,1562714307.658 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2019-07-09T23:18:27.660Z,1562714307.660 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2019-07-09T23:18:31.432Z,1562714311.432 [DataOverHttps](INFO): Sending 1898 bytes from file Logs/20190709T230649/Express0001.lzma
2019-07-09T23:18:32.235Z,1562714312.235 [DataOverHttps](INFO): Moved sent file to Logs/20190709T230649/Express0001.lzma.bak
2019-07-09T23:18:32.235Z,1562714312.235 [DataOverHttps](INFO): SBD MOMSN=11437341
2019-07-09T23:18:36.783Z,1562714316.783 [NAL9602](ERROR): NAL9602 initialization error.
2019-07-09T23:18:36.784Z,1562714316.784 [NAL9602] Communications Fault, FailCount= 4
2019-07-09T23:18:36.784Z,1562714316.784 [NAL9602](ERROR): Communications Fault
2019-07-09T23:18:36.911Z,1562714316.911 [CBIT](ERROR): Communications Fault in component: NAL9602
2019-07-09T23:18:37.191Z,1562714317.191 [NAL9602](INFO): Powering down
2019-07-09T23:18:37.623Z,1562714317.623 [Startup:StartupSatComms:B](INFO): Timed out from 2019-07-09T23:17:37.3Z
2019-07-09T23:18:37.623Z,1562714317.623 [Startup:StartupSatComms:B] Stopped
2019-07-09T23:18:37.623Z,1562714317.623 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2019-07-09T23:18:37.623Z,1562714317.623 [Startup:StartupSatComms] Stopped
2019-07-09T23:18:37.623Z,1562714317.623 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2019-07-09T23:18:37.624Z,1562714317.624 [Startup](INFO): Completed Startup
2019-07-09T23:18:37.624Z,1562714317.624 [MissionManager](INFO): Startup is completed.
2019-07-09T23:18:37.624Z,1562714317.624 [MissionManager](INFO): Uninitializing Mission Startup
2019-07-09T23:18:37.624Z,1562714317.624 [Startup] Stopped
2019-07-09T23:18:37.624Z,1562714317.624 [Startup](DEBUG): Aggregate::uninitialize Startup
2019-07-09T23:18:37.624Z,1562714317.624 [Startup:A.GoToSurface] Stopped
2019-07-09T23:18:37.624Z,1562714317.624 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2019-07-09T23:18:38.026Z,1562714318.026 [MissionManager](IMPORTANT): Started mission Default
2019-07-09T23:18:38.026Z,1562714318.026 [Default] Running Loop=1
2019-07-09T23:18:38.026Z,1562714318.026 [Default](DEBUG): Aggregate::initialize Default
2019-07-09T23:18:38.026Z,1562714318.026 [Default:B.GoToSurface] Running Loop=1
2019-07-09T23:18:38.026Z,1562714318.026 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2019-07-09T23:18:38.027Z,1562714318.027 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2019-07-09T23:18:38.027Z,1562714318.027 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2019-07-09T23:18:38.027Z,1562714318.027 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2019-07-09T23:18:38.028Z,1562714318.028 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2019-07-09T23:18:38.028Z,1562714318.028 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2019-07-09T23:18:38.028Z,1562714318.028 [Default:A.Wait] Running Loop=1
2019-07-09T23:18:38.028Z,1562714318.028 [Default:A.Wait](DEBUG): Initialize Wait Component.
2019-07-09T23:18:38.122Z,1562714318.122 [CBIT](INFO): Clearing failed state for component NAL9602
2019-07-09T23:18:38.122Z,1562714318.122 [NAL9602] No Fault, FailCount= 4
2019-07-09T23:18:40.710Z,1562714320.710 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2019-07-09T23:18:40.710Z,1562714320.710 [CTD_Seabird] Communications Fault, FailCount= 1
2019-07-09T23:18:40.710Z,1562714320.710 [CTD_Seabird](ERROR): Communications Fault
2019-07-09T23:18:40.939Z,1562714320.939 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2019-07-09T23:18:41.114Z,1562714321.114 [CTD_Seabird](INFO): Powering down
2019-07-09T23:18:42.159Z,1562714322.159 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2019-07-09T23:18:42.159Z,1562714322.159 [CTD_Seabird] No Fault, FailCount= 1
2019-07-09T23:18:42.458Z,1562714322.458 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2019-07-09T23:18:42.460Z,1562714322.460 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2019-07-09T23:18:44.954Z,1562714324.954 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20190709T231429/Express0001.lzma
2019-07-09T23:18:45.759Z,1562714325.759 [DataOverHttps](INFO): Moved sent file to Logs/20190709T231429/Express0001.lzma.bak
2019-07-09T23:18:45.760Z,1562714325.760 [DataOverHttps](INFO): SBD MOMSN=11437517
2019-07-09T23:18:51.355Z,1562714331.355 [Default:A.Wait](INFO): Done Waiting.
2019-07-09T23:18:51.355Z,1562714331.355 [Default:A.Wait] Stopped
2019-07-09T23:18:51.355Z,1562714331.355 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2019-07-09T23:18:51.802Z,1562714331.802 [Default:CheckIn] Running Loop=1
2019-07-09T23:18:51.802Z,1562714331.802 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-07-09T23:18:51.803Z,1562714331.803 [Default:CheckIn:Read_GPS] Running Loop=1
2019-07-09T23:18:52.303Z,1562714332.303 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2019-07-09T23:18:55.510Z,1562714335.510 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2019-07-09T23:18:55.510Z,1562714335.510 [CTD_Seabird] Communications Fault, FailCount= 2
2019-07-09T23:18:55.510Z,1562714335.510 [CTD_Seabird](ERROR): Communications Fault
2019-07-09T23:18:55.552Z,1562714335.552 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2019-07-09T23:18:55.914Z,1562714335.914 [CTD_Seabird](INFO): Powering down
2019-07-09T23:18:57.115Z,1562714337.115 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2019-07-09T23:18:57.115Z,1562714337.115 [CTD_Seabird] No Fault, FailCount= 2
2019-07-09T23:18:57.254Z,1562714337.254 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2019-07-09T23:18:57.256Z,1562714337.256 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2019-07-09T23:19:07.488Z,1562714347.488 [NAL9602](INFO): Powering up NAL9602
2019-07-09T23:19:10.306Z,1562714350.306 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2019-07-09T23:19:10.306Z,1562714350.306 [CTD_Seabird] Communications Fault, FailCount= 3
2019-07-09T23:19:10.306Z,1562714350.306 [CTD_Seabird](ERROR): Communications Fault
2019-07-09T23:19:10.443Z,1562714350.443 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2019-07-09T23:19:10.443Z,1562714350.443 [CBIT](FAULT): Communications Fault in component: CTD_Seabird
2019-07-09T23:19:10.722Z,1562714350.722 [CTD_Seabird](INFO): Powering down
2019-07-09T23:19:15.190Z,1562714355.190 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-07-09T23:19:15.190Z,1562714355.190 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2019-07-09T23:19:15.190Z,1562714355.190 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-09T23:19:15.279Z,1562714355.279 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-09T23:19:15.682Z,1562714355.682 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-09T23:19:15.683Z,1562714355.683 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2019-07-09T23:19:28.092Z,1562714368.092 [NAL9602](ERROR): NAL9602 initialization error.
2019-07-09T23:19:28.092Z,1562714368.092 [NAL9602] Communications Fault, FailCount= 5
2019-07-09T23:19:28.092Z,1562714368.092 [NAL9602](ERROR): Communications Fault
2019-07-09T23:19:28.223Z,1562714368.223 [CBIT](ERROR): Communications Fault in component: NAL9602
2019-07-09T23:19:28.223Z,1562714368.223 [CBIT](CRITICAL): Communications Fault in component: NAL9602
2019-07-09T23:19:28.499Z,1562714368.499 [NAL9602](INFO): Powering down
2019-07-09T23:19:28.616Z,1562714368.616 [CBIT](INFO): Critical error at 20190709T231928
2019-07-09T23:19:28.770Z,1562714368.770 [CommandLine](IMPORTANT): got command ! echo 0 > /dev/loadB2
2019-07-09T23:19:42.403Z,1562714382.403 [CommandLine](IMPORTANT): got command ! echo 0 > /dev/loadB2
2019-07-09T23:21:16.383Z,1562714476.383 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-07-09T23:21:16.383Z,1562714476.383 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2019-07-09T23:21:16.383Z,1562714476.383 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-09T23:21:16.475Z,1562714476.475 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-09T23:21:16.883Z,1562714476.883 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-09T23:21:16.883Z,1562714476.883 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2019-07-09T23:21:25.380Z,1562714485.380 [CBIT](INFO): Clearing failed state for component AHRS_M2
2019-07-09T23:21:25.380Z,1562714485.380 [AHRS_M2] No Fault, FailCount= 5
2019-07-09T23:21:25.650Z,1562714485.650 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2019-07-09T23:21:28.214Z,1562714488.214 [CBIT](INFO): Clearing failed state for component NAL9602
2019-07-09T23:21:28.214Z,1562714488.214 [NAL9602] No Fault, FailCount= 5
2019-07-09T23:21:28.485Z,1562714488.485 [NAL9602](INFO): Powering up NAL9602
2019-07-09T23:21:29.206Z,1562714489.206 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:21:29.670Z,1562714489.670 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:21:30.118Z,1562714490.118 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:21:30.567Z,1562714490.567 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:21:31.026Z,1562714491.026 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:21:31.470Z,1562714491.470 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:21:31.930Z,1562714491.930 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:21:32.374Z,1562714492.374 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:21:32.822Z,1562714492.822 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:21:33.334Z,1562714493.334 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:21:33.794Z,1562714493.794 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:21:34.250Z,1562714494.250 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:21:34.710Z,1562714494.710 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:21:35.178Z,1562714495.178 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:21:35.630Z,1562714495.630 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:21:36.082Z,1562714496.082 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:21:36.542Z,1562714496.542 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:21:36.986Z,1562714496.986 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:21:37.450Z,1562714497.450 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:21:37.894Z,1562714497.894 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:21:38.406Z,1562714498.406 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:21:38.862Z,1562714498.862 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:21:38.862Z,1562714498.862 [AHRS_M2](FAULT): Failed to initialize within timeout.
2019-07-09T23:21:38.862Z,1562714498.862 [AHRS_M2] Communications Fault, FailCount= 1
2019-07-09T23:21:38.862Z,1562714498.862 [AHRS_M2](ERROR): Communications Fault
2019-07-09T23:21:39.014Z,1562714499.014 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2019-07-09T23:21:39.020Z,1562714499.020 [AHRS_M2](INFO): Powering down
2019-07-09T23:21:39.974Z,1562714499.974 [CBIT](INFO): Clearing failed state for component AHRS_M2
2019-07-09T23:21:39.974Z,1562714499.974 [AHRS_M2] No Fault, FailCount= 1
2019-07-09T23:21:40.230Z,1562714500.230 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2019-07-09T23:21:40.398Z,1562714500.398 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2019-07-09T23:21:40.399Z,1562714500.399 [CTD_Seabird] No Fault, FailCount= 3
2019-07-09T23:21:40.746Z,1562714500.746 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2019-07-09T23:21:40.748Z,1562714500.748 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2019-07-09T23:21:43.786Z,1562714503.786 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:21:44.230Z,1562714504.230 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:21:44.682Z,1562714504.682 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:21:45.138Z,1562714505.138 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:21:45.590Z,1562714505.590 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:21:46.042Z,1562714506.042 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:21:46.494Z,1562714506.494 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:21:47.014Z,1562714507.014 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:21:47.474Z,1562714507.474 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:21:47.946Z,1562714507.946 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:21:48.410Z,1562714508.410 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:21:48.874Z,1562714508.874 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:21:49.330Z,1562714509.330 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:21:49.339Z,1562714509.339 [NAL9602](ERROR): NAL9602 initialization error.
2019-07-09T23:21:49.339Z,1562714509.339 [NAL9602] Communications Fault, FailCount= 1
2019-07-09T23:21:49.339Z,1562714509.339 [NAL9602](ERROR): Communications Fault
2019-07-09T23:21:49.443Z,1562714509.443 [CBIT](ERROR): Communications Fault in component: NAL9602
2019-07-09T23:21:49.774Z,1562714509.774 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:21:49.783Z,1562714509.783 [NAL9602](INFO): Powering down
2019-07-09T23:21:50.242Z,1562714510.242 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:21:50.694Z,1562714510.694 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:21:50.806Z,1562714510.806 [CBIT](INFO): Clearing failed state for component NAL9602
2019-07-09T23:21:50.806Z,1562714510.806 [NAL9602] No Fault, FailCount= 1
2019-07-09T23:21:51.130Z,1562714511.130 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:21:51.598Z,1562714511.598 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:21:52.050Z,1562714512.050 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:21:52.494Z,1562714512.494 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:21:52.962Z,1562714512.962 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:21:53.410Z,1562714513.410 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:21:53.410Z,1562714513.410 [AHRS_M2](FAULT): Failed to initialize within timeout.
2019-07-09T23:21:53.410Z,1562714513.410 [AHRS_M2] Communications Fault, FailCount= 2
2019-07-09T23:21:53.410Z,1562714513.410 [AHRS_M2](ERROR): Communications Fault
2019-07-09T23:21:53.530Z,1562714513.530 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2019-07-09T23:21:53.537Z,1562714513.537 [AHRS_M2](INFO): Powering down
2019-07-09T23:21:53.798Z,1562714513.798 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2019-07-09T23:21:53.798Z,1562714513.798 [CTD_Seabird] Communications Fault, FailCount= 1
2019-07-09T23:21:53.798Z,1562714513.798 [CTD_Seabird](ERROR): Communications Fault
2019-07-09T23:21:54.063Z,1562714514.063 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2019-07-09T23:21:54.202Z,1562714514.202 [CTD_Seabird](INFO): Powering down
2019-07-09T23:21:54.518Z,1562714514.518 [CBIT](INFO): Clearing failed state for component AHRS_M2
2019-07-09T23:21:54.518Z,1562714514.518 [AHRS_M2] No Fault, FailCount= 2
2019-07-09T23:21:54.747Z,1562714514.747 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2019-07-09T23:21:55.275Z,1562714515.275 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2019-07-09T23:21:55.275Z,1562714515.275 [CTD_Seabird] No Fault, FailCount= 1
2019-07-09T23:21:55.546Z,1562714515.546 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2019-07-09T23:21:55.547Z,1562714515.547 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2019-07-09T23:21:58.302Z,1562714518.302 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:21:58.750Z,1562714518.750 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:21:59.210Z,1562714519.210 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:21:59.662Z,1562714519.662 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:22:00.126Z,1562714520.126 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:22:00.586Z,1562714520.586 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:22:01.106Z,1562714521.106 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:22:01.129Z,1562714521.129 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6.
2019-07-09T23:22:01.133Z,1562714521.133 [BPC1](INFO): Received data from all battery sticks.
2019-07-09T23:22:01.554Z,1562714521.554 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:22:02.018Z,1562714522.018 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:22:02.458Z,1562714522.458 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:22:02.898Z,1562714522.898 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:22:03.342Z,1562714523.342 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:22:03.794Z,1562714523.794 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:22:04.242Z,1562714524.242 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:22:04.698Z,1562714524.698 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:22:05.138Z,1562714525.138 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:22:05.594Z,1562714525.594 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:22:06.066Z,1562714526.066 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:22:06.514Z,1562714526.514 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:22:06.958Z,1562714526.958 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:22:07.426Z,1562714527.426 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:22:07.866Z,1562714527.866 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:22:07.866Z,1562714527.866 [AHRS_M2](FAULT): Failed to initialize within timeout.
2019-07-09T23:22:07.866Z,1562714527.866 [AHRS_M2] Communications Fault, FailCount= 3
2019-07-09T23:22:07.866Z,1562714527.866 [AHRS_M2](ERROR): Communications Fault
2019-07-09T23:22:07.978Z,1562714527.978 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2019-07-09T23:22:07.984Z,1562714527.984 [AHRS_M2](INFO): Powering down
2019-07-09T23:22:08.598Z,1562714528.598 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2019-07-09T23:22:08.598Z,1562714528.598 [CTD_Seabird] Communications Fault, FailCount= 2
2019-07-09T23:22:08.598Z,1562714528.598 [CTD_Seabird](ERROR): Communications Fault
2019-07-09T23:22:08.902Z,1562714528.902 [CBIT](INFO): Clearing failed state for component AHRS_M2
2019-07-09T23:22:08.902Z,1562714528.902 [AHRS_M2] No Fault, FailCount= 3
2019-07-09T23:22:08.903Z,1562714528.903 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2019-07-09T23:22:09.002Z,1562714529.002 [CTD_Seabird](INFO): Powering down
2019-07-09T23:22:09.194Z,1562714529.194 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2019-07-09T23:22:10.122Z,1562714530.122 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2019-07-09T23:22:10.122Z,1562714530.122 [CTD_Seabird] No Fault, FailCount= 2
2019-07-09T23:22:10.346Z,1562714530.346 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2019-07-09T23:22:10.348Z,1562714530.348 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2019-07-09T23:22:12.746Z,1562714532.746 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:22:13.250Z,1562714533.250 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:22:13.726Z,1562714533.726 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:22:14.194Z,1562714534.194 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:22:14.662Z,1562714534.662 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:22:15.122Z,1562714535.122 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:22:15.594Z,1562714535.594 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:22:16.070Z,1562714536.070 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:22:16.522Z,1562714536.522 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:22:16.950Z,1562714536.950 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:22:17.406Z,1562714537.406 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:22:17.850Z,1562714537.850 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:22:18.286Z,1562714538.286 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:22:18.750Z,1562714538.750 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:22:19.198Z,1562714539.198 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:22:19.630Z,1562714539.630 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:22:20.070Z,1562714540.070 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:22:20.079Z,1562714540.079 [NAL9602](INFO): Powering up NAL9602
2019-07-09T23:22:20.542Z,1562714540.542 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:22:20.990Z,1562714540.990 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:22:21.439Z,1562714541.439 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:22:21.902Z,1562714541.902 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:22:22.346Z,1562714542.346 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:22:22.346Z,1562714542.346 [AHRS_M2](FAULT): Failed to initialize within timeout.
2019-07-09T23:22:22.346Z,1562714542.346 [AHRS_M2] Communications Fault, FailCount= 4
2019-07-09T23:22:22.346Z,1562714542.346 [AHRS_M2](ERROR): Communications Fault
2019-07-09T23:22:22.490Z,1562714542.490 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2019-07-09T23:22:22.496Z,1562714542.496 [AHRS_M2](INFO): Powering down
2019-07-09T23:22:23.399Z,1562714543.399 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2019-07-09T23:22:23.400Z,1562714543.400 [CTD_Seabird] Communications Fault, FailCount= 3
2019-07-09T23:22:23.400Z,1562714543.400 [CTD_Seabird](ERROR): Communications Fault
2019-07-09T23:22:23.442Z,1562714543.442 [CBIT](INFO): Clearing failed state for component AHRS_M2
2019-07-09T23:22:23.442Z,1562714543.442 [AHRS_M2] No Fault, FailCount= 4
2019-07-09T23:22:23.443Z,1562714543.443 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2019-07-09T23:22:23.443Z,1562714543.443 [CBIT](FAULT): Communications Fault in component: CTD_Seabird
2019-07-09T23:22:23.706Z,1562714543.706 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2019-07-09T23:22:23.803Z,1562714543.803 [CTD_Seabird](INFO): Powering down
2019-07-09T23:22:27.262Z,1562714547.262 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:22:27.726Z,1562714547.726 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:22:28.174Z,1562714548.174 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:22:28.646Z,1562714548.646 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:22:29.086Z,1562714549.086 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:22:29.530Z,1562714549.530 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:22:29.975Z,1562714549.975 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:22:30.422Z,1562714550.422 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:22:30.866Z,1562714550.866 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:22:31.342Z,1562714551.342 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:22:31.790Z,1562714551.790 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:22:32.242Z,1562714552.242 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:22:32.706Z,1562714552.706 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:22:33.154Z,1562714553.154 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:22:33.598Z,1562714553.598 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:22:34.062Z,1562714554.062 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:22:34.506Z,1562714554.506 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:22:34.962Z,1562714554.962 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:22:35.410Z,1562714555.410 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:22:35.858Z,1562714555.858 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:22:36.330Z,1562714556.330 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:22:36.782Z,1562714556.782 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout
2019-07-09T23:22:36.782Z,1562714556.782 [AHRS_M2](FAULT): Failed to initialize within timeout.
2019-07-09T23:22:36.782Z,1562714556.782 [AHRS_M2] Communications Fault, FailCount= 5
2019-07-09T23:22:36.782Z,1562714556.782 [AHRS_M2](ERROR): Communications Fault
2019-07-09T23:22:36.894Z,1562714556.894 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2019-07-09T23:22:36.895Z,1562714556.895 [CBIT](CRITICAL): Communications Fault in component: AHRS_M2
2019-07-09T23:22:36.901Z,1562714556.901 [AHRS_M2](INFO): Powering down
2019-07-09T23:22:37.100Z,1562714557.100 [CBIT](INFO): Critical error at 20190709T232236
2019-07-09T23:22:40.947Z,1562714560.947 [NAL9602](ERROR): NAL9602 initialization error.
2019-07-09T23:22:40.947Z,1562714560.947 [NAL9602] Communications Fault, FailCount= 2
2019-07-09T23:22:40.947Z,1562714560.947 [NAL9602](ERROR): Communications Fault
2019-07-09T23:22:41.051Z,1562714561.051 [CBIT](ERROR): Communications Fault in component: NAL9602
2019-07-09T23:22:41.347Z,1562714561.347 [NAL9602](INFO): Powering down
2019-07-09T23:22:42.266Z,1562714562.266 [CBIT](INFO): Clearing failed state for component NAL9602
2019-07-09T23:22:42.266Z,1562714562.266 [NAL9602] No Fault, FailCount= 2
2019-07-09T23:23:11.651Z,1562714591.651 [NAL9602](INFO): Powering up NAL9602
2019-07-09T23:23:17.322Z,1562714597.322 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-07-09T23:23:17.322Z,1562714597.322 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2019-07-09T23:23:17.322Z,1562714597.322 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-07-09T23:23:17.442Z,1562714597.442 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-07-09T23:23:17.826Z,1562714597.826 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-07-09T23:23:17.826Z,1562714597.826 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2019-07-09T23:23:32.255Z,1562714612.255 [NAL9602](ERROR): NAL9602 initialization error.
2019-07-09T23:23:32.255Z,1562714612.255 [NAL9602] Communications Fault, FailCount= 3
2019-07-09T23:23:32.255Z,1562714612.255 [NAL9602](ERROR): Communications Fault
2019-07-09T23:23:32.359Z,1562714612.359 [CBIT](ERROR): Communications Fault in component: NAL9602
2019-07-09T23:23:32.655Z,1562714612.655 [NAL9602](INFO): Powering down
2019-07-09T23:23:33.586Z,1562714613.586 [CBIT](INFO): Clearing failed state for component NAL9602
2019-07-09T23:23:33.586Z,1562714613.586 [NAL9602] No Fault, FailCount= 3
2019-07-09T23:23:52.066Z,1562714632.066 [Default:CheckIn:Read_GPS](INFO): Timed out from 2019-07-09T23:18:51.8Z
2019-07-09T23:23:52.067Z,1562714632.067 [Default:CheckIn:Read_GPS] Stopped
2019-07-09T23:23:52.067Z,1562714632.067 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-07-09T23:23:52.468Z,1562714632.468 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2019-07-09T23:23:55.262Z,1562714635.262 [CommandLine](IMPORTANT): got command quit
2019-07-09T23:23:56.266Z,1562714636.266 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2019-07-09T23:23:56.266Z,1562714636.266 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-07-09T23:23:56.418Z,1562714636.418 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2019-07-09T23:23:56.418Z,1562714636.418 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-07-09T23:23:56.419Z,1562714636.419 [CommandLine](INFO): Join timeout helper Thread ID is 6265
2019-07-09T23:23:56.420Z,1562714636.420 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2019-07-09T23:23:56.420Z,1562714636.420 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-07-09T23:23:56.420Z,1562714636.420 [NavChartDb](INFO): Join timeout helper Thread ID is 6266
2019-07-09T23:23:56.646Z,1562714636.646 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2019-07-09T23:23:56.646Z,1562714636.646 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-07-09T23:23:56.662Z,1562714636.662 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2019-07-09T23:23:56.662Z,1562714636.662 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2019-07-09T23:23:56.662Z,1562714636.662 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 6267
2019-07-09T23:23:56.718Z,1562714636.718 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2019-07-09T23:23:56.718Z,1562714636.718 [WetLabsBB2FL](INFO): Powering down
2019-07-09T23:23:56.719Z,1562714636.719 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2019-07-09T23:23:56.730Z,1562714636.730 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2019-07-09T23:23:56.730Z,1562714636.730 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2019-07-09T23:23:56.731Z,1562714636.731 [CTD_Seabird](INFO): Join timeout helper Thread ID is 6268
2019-07-09T23:23:56.854Z,1562714636.854 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2019-07-09T23:23:56.854Z,1562714636.854 [CTD_Seabird](INFO): Powering down
2019-07-09T23:23:56.866Z,1562714636.866 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2019-07-09T23:23:56.870Z,1562714636.870 [ComponentRegistry](INFO): Shutting down CTD_NeilBrown ThreadHandler
2019-07-09T23:23:56.870Z,1562714636.870 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2019-07-09T23:23:56.870Z,1562714636.870 [CTD_NeilBrown](INFO): Join timeout helper Thread ID is 6269
2019-07-09T23:23:56.978Z,1562714636.978 [CTD_NeilBrown ThreadHandler](INFO): Uninitializing protected caller thread.
2019-07-09T23:23:56.978Z,1562714636.978 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2019-07-09T23:23:56.991Z,1562714636.991 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2019-07-09T23:23:56.991Z,1562714636.991 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-07-09T23:23:56.991Z,1562714636.991 [Radio_Surface](INFO): Join timeout helper Thread ID is 6270
2019-07-09T23:23:57.158Z,1562714637.158 [Radio_Surface](INFO): Powering down
2019-07-09T23:23:57.159Z,1562714637.159 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2019-07-09T23:23:57.159Z,1562714637.159 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-07-09T23:23:57.162Z,1562714637.162 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2019-07-09T23:23:57.163Z,1562714637.163 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2019-07-09T23:23:57.163Z,1562714637.163 [DataOverHttps](INFO): Join timeout helper Thread ID is 6271
2019-07-09T23:23:57.858Z,1562714637.858 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2019-07-09T23:23:57.861Z,1562714637.861 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2019-07-09T23:23:57.866Z,1562714637.866 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2019-07-09T23:23:57.867Z,1562714637.867 [logger ThreadHandler](INFO): Thread cancelled.
2019-07-09T23:23:57.867Z,1562714637.867 [logger](INFO): Join timeout helper Thread ID is 6272
2019-07-09T23:23:57.918Z,1562714637.918 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2019-07-09T23:23:57.918Z,1562714637.918 [logger ThreadHandler](INFO): Thread cancelled.
2019-07-09T23:23:57.926Z,1562714637.926 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2019-07-09T23:23:57.927Z,1562714637.927 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-07-09T23:23:57.927Z,1562714637.927 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2019-07-09T23:23:57.927Z,1562714637.927 [controlThread ThreadHandler](INFO): Thread cancelled.
2019-07-09T23:23:57.927Z,1562714637.927 [controlThread](INFO): Join timeout helper Thread ID is 6273
2019-07-09T23:23:57.928Z,1562714637.928 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2019-07-09T23:23:57.928Z,1562714637.928 [controlThread](DEBUG): Uninitializing ControlThread
2019-07-09T23:23:57.928Z,1562714637.928 [AHRS_M2](INFO): Powering down
2019-07-09T23:23:57.930Z,1562714637.930 [DVL_micro](INFO): uninitialize:Powering down
2019-07-09T23:23:57.931Z,1562714637.931 [NAL9602](INFO): Powering down
2019-07-09T23:23:57.932Z,1562714637.932 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2019-07-09T23:23:57.933Z,1562714637.933 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2019-07-09T23:23:57.934Z,1562714637.934 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2019-07-09T23:23:57.934Z,1562714637.934 [MissionManager](INFO): Uninitializing Mission Default
2019-07-09T23:23:57.934Z,1562714637.934 [Default] Stopped
2019-07-09T23:23:57.935Z,1562714637.935 [Default](DEBUG): Aggregate::uninitialize Default
2019-07-09T23:23:57.935Z,1562714637.935 [Default:B.GoToSurface] Stopped
2019-07-09T23:23:57.935Z,1562714637.935 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2019-07-09T23:23:57.935Z,1562714637.935 [Default:CheckIn] Stopped
2019-07-09T23:23:57.935Z,1562714637.935 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-07-09T23:23:57.935Z,1562714637.935 [Default:CheckIn:Read_Iridium] Stopped
2019-07-09T23:23:57.937Z,1562714637.937 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2019-07-09T23:23:57.938Z,1562714637.938 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2019-07-09T23:23:57.938Z,1562714637.938 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2019-07-09T23:23:57.938Z,1562714637.938 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2019-07-09T23:23:57.939Z,1562714637.939 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2019-07-09T23:23:57.939Z,1562714637.939 [BuoyancyServo](INFO): Powering down
2019-07-09T23:23:57.954Z,1562714637.954 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2019-07-09T23:23:57.954Z,1562714637.954 [ElevatorServo](INFO): Powering down
2019-07-09T23:23:57.955Z,1562714637.955 [MassServo](DEBUG): Uninitialize Mass Servo.
2019-07-09T23:23:57.955Z,1562714637.955 [MassServo](INFO): Powering down
2019-07-09T23:23:57.956Z,1562714637.956 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2019-07-09T23:23:57.956Z,1562714637.956 [RudderServo](INFO): Powering down
2019-07-09T23:23:57.957Z,1562714637.957 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2019-07-09T23:23:57.957Z,1562714637.957 [ThrusterServo](INFO): Powering down
2019-07-09T23:23:57.957Z,1562714637.957 [SBIT](DEBUG): Uninitialize SBIT Component.
2019-07-09T23:23:57.958Z,1562714637.958 [IBIT](DEBUG): Uninitialize IBIT Component.
2019-07-09T23:23:57.958Z,1562714637.958 [CBIT](DEBUG): Uninitialize CBIT Component.
2019-07-09T23:23:57.958Z,1562714637.958 [CBIT](DEBUG): Powering off loads.
2019-07-09T23:23:57.970Z,1562714637.970 [CBIT](DEBUG): Disabling WDT.
2019-07-09T23:23:57.982Z,1562714637.982 [CBIT](DEBUG): Opening all GF detection circuits.
2019-07-09T23:23:57.982Z,1562714637.982 [controlThread ThreadHandler](INFO): Thread cancelled.
2019-07-09T23:23:58.070Z,1562714638.070 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-07-09T23:23:58.079Z,1562714638.079 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2019-07-09T23:23:58.252Z,1562714638.252 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2019-07-09T23:23:58.255Z,1562714638.255 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2019-07-09T23:23:58.260Z,1562714638.260 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2019-07-09T23:23:58.274Z,1562714638.274 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-07-09T23:23:58.338Z,1562714638.338 [logger ThreadHandler](INFO): Thread cancelled.