2019-08-16T12:41:49.107Z,1565959309.107 [Supervisor](DEBUG): Initializing supervisor.
2019-08-16T12:41:49.119Z,1565959309.119 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2019-08-16T12:41:49.119Z,1565959309.119 [SyncHandler](INFO): Protected caller Thread ID is 808
2019-08-16T12:41:49.120Z,1565959309.120 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2019-08-16T12:41:49.131Z,1565959309.131 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2019-08-16T12:41:49.131Z,1565959309.131 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 809
2019-08-16T12:41:49.134Z,1565959309.134 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2019-08-16T12:41:49.156Z,1565959309.156 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2019-08-16T12:41:49.167Z,1565959309.167 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2019-08-16T12:41:49.167Z,1565959309.167 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 810
2019-08-16T12:41:49.168Z,1565959309.168 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2019-08-16T12:41:49.179Z,1565959309.179 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2019-08-16T12:41:49.179Z,1565959309.179 [logger ThreadHandler](INFO): Protected caller Thread ID is 811
2019-08-16T12:41:49.181Z,1565959309.181 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2019-08-16T12:41:49.181Z,1565959309.181 [Supervisor](INFO): Looking for Config files in directory: Config/
2019-08-16T12:41:49.195Z,1565959309.195 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2019-08-16T12:41:49.375Z,1565959309.375 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2019-08-16T12:41:49.377Z,1565959309.377 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2019-08-16T12:41:49.772Z,1565959309.772 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2019-08-16T12:41:49.774Z,1565959309.774 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2019-08-16T12:41:50.055Z,1565959310.055 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2019-08-16T12:41:50.056Z,1565959310.056 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2019-08-16T12:41:51.165Z,1565959311.165 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2019-08-16T12:41:51.166Z,1565959311.166 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2019-08-16T12:41:52.066Z,1565959312.066 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2019-08-16T12:41:52.067Z,1565959312.067 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2019-08-16T12:41:52.797Z,1565959312.797 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2019-08-16T12:41:52.799Z,1565959312.799 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2019-08-16T12:41:53.104Z,1565959313.104 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2019-08-16T12:41:53.105Z,1565959313.105 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2019-08-16T12:41:53.437Z,1565959313.437 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2019-08-16T12:41:53.439Z,1565959313.439 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2019-08-16T12:41:53.834Z,1565959313.834 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2019-08-16T12:41:53.835Z,1565959313.835 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2019-08-16T12:41:53.987Z,1565959313.987 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2019-08-16T12:41:53.988Z,1565959313.988 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2019-08-16T12:41:54.093Z,1565959314.093 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2019-08-16T12:41:54.093Z,1565959314.093 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2019-08-16T12:41:54.176Z,1565959314.176 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2019-08-16T12:41:54.278Z,1565959314.278 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2019-08-16T12:41:54.280Z,1565959314.280 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2019-08-16T12:41:54.475Z,1565959314.475 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2019-08-16T12:41:54.477Z,1565959314.477 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2019-08-16T12:41:54.683Z,1565959314.683 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2019-08-16T12:41:54.685Z,1565959314.685 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/
2019-08-16T12:41:54.687Z,1565959314.687 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/secure.cfg
2019-08-16T12:41:54.772Z,1565959314.772 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Battery.cfg
2019-08-16T12:41:55.001Z,1565959315.001 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2019-08-16T12:41:55.002Z,1565959315.002 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Navigation.cfg
2019-08-16T12:41:55.099Z,1565959315.099 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Sensor.cfg
2019-08-16T12:41:55.271Z,1565959315.271 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/vehicle.cfg
2019-08-16T12:41:55.485Z,1565959315.485 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Simulator.cfg
2019-08-16T12:41:55.572Z,1565959315.572 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Servo.cfg
2019-08-16T12:41:55.675Z,1565959315.675 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Control.cfg
2019-08-16T12:41:55.770Z,1565959315.770 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Science.cfg
2019-08-16T12:41:55.931Z,1565959315.931 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/logger.cfg
2019-08-16T12:41:56.039Z,1565959316.039 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/BIT.cfg
2019-08-16T12:41:56.137Z,1565959316.137 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2019-08-16T12:41:56.151Z,1565959316.151 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2019-08-16T12:41:56.277Z,1565959316.277 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2019-08-16T12:41:56.279Z,1565959316.279 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2019-08-16T12:41:56.433Z,1565959316.433 [BuoyancyServo] Loaded
2019-08-16T12:41:56.433Z,1565959316.433 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2019-08-16T12:41:56.448Z,1565959316.448 [ElevatorServo] Loaded
2019-08-16T12:41:56.448Z,1565959316.448 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2019-08-16T12:41:56.462Z,1565959316.462 [MassServo] Loaded
2019-08-16T12:41:56.462Z,1565959316.462 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2019-08-16T12:41:56.477Z,1565959316.477 [RudderServo] Loaded
2019-08-16T12:41:56.478Z,1565959316.478 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2019-08-16T12:41:56.492Z,1565959316.492 [ThrusterServo] Loaded
2019-08-16T12:41:56.492Z,1565959316.492 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2019-08-16T12:41:56.493Z,1565959316.493 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2019-08-16T12:41:56.494Z,1565959316.494 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2019-08-16T12:41:56.661Z,1565959316.661 [SBIT](DEBUG): Construct Startup Built In Test.
2019-08-16T12:41:56.690Z,1565959316.690 [SBIT] Loaded
2019-08-16T12:41:56.690Z,1565959316.690 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2019-08-16T12:41:56.691Z,1565959316.691 [IBIT](DEBUG): Construct Initiated Built In Test.
2019-08-16T12:41:56.718Z,1565959316.718 [IBIT] Loaded
2019-08-16T12:41:56.719Z,1565959316.719 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2019-08-16T12:41:56.722Z,1565959316.722 [CBIT](DEBUG): Construct Continuous Built In Test.
2019-08-16T12:41:57.107Z,1565959317.107 [CBIT] Loaded
2019-08-16T12:41:57.108Z,1565959317.108 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2019-08-16T12:41:57.108Z,1565959317.108 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2019-08-16T12:41:57.109Z,1565959317.109 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2019-08-16T12:41:58.168Z,1565959318.168 [Aanderaa_O2] Loaded
2019-08-16T12:41:58.169Z,1565959318.169 [ComponentRegistry](DEBUG): SyncComponent "Aanderaa_O2" handled in the control thread.
2019-08-16T12:41:58.178Z,1565959318.178 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_density
2019-08-16T12:41:58.183Z,1565959318.183 [CTD_Seabird](INFO): created writer for : sea_water_density
2019-08-16T12:41:58.185Z,1565959318.185 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): depth
2019-08-16T12:41:58.190Z,1565959318.190 [CTD_Seabird](INFO): created writer for : depth
2019-08-16T12:41:58.190Z,1565959318.190 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_pressure
2019-08-16T12:41:58.195Z,1565959318.195 [CTD_Seabird](INFO): created writer for : sea_water_pressure
2019-08-16T12:41:58.196Z,1565959318.196 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_salinity
2019-08-16T12:41:58.201Z,1565959318.201 [CTD_Seabird](INFO): created writer for : sea_water_salinity
2019-08-16T12:41:58.202Z,1565959318.202 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_temperature
2019-08-16T12:41:58.207Z,1565959318.207 [CTD_Seabird](INFO): created writer for : sea_water_temperature
2019-08-16T12:41:58.208Z,1565959318.208 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_electrical_conductivity
2019-08-16T12:41:58.213Z,1565959318.213 [CTD_Seabird](INFO): created writer for : sea_water_electrical_conductivity
2019-08-16T12:41:58.213Z,1565959318.213 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): speed_of_sound_in_sea_water
2019-08-16T12:41:58.218Z,1565959318.218 [CTD_Seabird](INFO): created writer for : speed_of_sound_in_sea_water
2019-08-16T12:41:58.245Z,1565959318.245 [CTD_Seabird] Loaded
2019-08-16T12:41:58.245Z,1565959318.245 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2019-08-16T12:41:58.246Z,1565959318.246 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 4066B4E0
2019-08-16T12:41:58.246Z,1565959318.246 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 890
2019-08-16T12:41:58.277Z,1565959318.277 [ESPComponent] Loaded
2019-08-16T12:41:58.277Z,1565959318.277 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread.
2019-08-16T12:41:58.291Z,1565959318.291 [PAR_Licor] Loaded
2019-08-16T12:41:58.291Z,1565959318.291 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2019-08-16T12:41:58.339Z,1565959318.339 [WetLabsBB2FL] Loaded
2019-08-16T12:41:58.339Z,1565959318.339 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2019-08-16T12:41:58.340Z,1565959318.340 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 4069B4E0
2019-08-16T12:41:58.340Z,1565959318.340 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 891
2019-08-16T12:41:58.341Z,1565959318.341 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2019-08-16T12:41:58.342Z,1565959318.342 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2019-08-16T12:41:58.399Z,1565959318.399 [DepthRateCalculator] Loaded
2019-08-16T12:41:58.399Z,1565959318.399 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2019-08-16T12:41:58.405Z,1565959318.405 [PitchRateCalculator] Loaded
2019-08-16T12:41:58.405Z,1565959318.405 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2019-08-16T12:41:58.421Z,1565959318.421 [SpeedCalculator] Loaded
2019-08-16T12:41:58.421Z,1565959318.421 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2019-08-16T12:41:58.442Z,1565959318.442 [TempGradientCalculator] Loaded
2019-08-16T12:41:58.442Z,1565959318.442 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2019-08-16T12:41:58.448Z,1565959318.448 [YawRateCalculator] Loaded
2019-08-16T12:41:58.448Z,1565959318.448 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2019-08-16T12:41:58.480Z,1565959318.480 [ElevatorOffsetCalculator] Loaded
2019-08-16T12:41:58.481Z,1565959318.481 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2019-08-16T12:41:58.481Z,1565959318.481 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2019-08-16T12:41:58.482Z,1565959318.482 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2019-08-16T12:41:58.531Z,1565959318.531 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2019-08-16T12:41:58.531Z,1565959318.531 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2019-08-16T12:41:58.651Z,1565959318.651 [DeadReckonUsingMultipleVelocitySources] Loaded
2019-08-16T12:41:58.651Z,1565959318.651 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2019-08-16T12:41:58.672Z,1565959318.672 [NavChart] Loaded
2019-08-16T12:41:58.673Z,1565959318.673 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2019-08-16T12:41:58.677Z,1565959318.677 [UniversalFixResidualReporter] Loaded
2019-08-16T12:41:58.677Z,1565959318.677 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2019-08-16T12:41:58.677Z,1565959318.677 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2019-08-16T12:41:58.679Z,1565959318.679 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2019-08-16T12:41:59.365Z,1565959319.365 [AHRS_M2] Loaded
2019-08-16T12:41:59.365Z,1565959319.365 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2019-08-16T12:41:59.510Z,1565959319.510 [DataOverHttps] Loaded
2019-08-16T12:41:59.511Z,1565959319.511 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2019-08-16T12:41:59.512Z,1565959319.512 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 409744E0
2019-08-16T12:41:59.512Z,1565959319.512 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 892
2019-08-16T12:41:59.525Z,1565959319.525 [Depth_Keller] Loaded
2019-08-16T12:41:59.525Z,1565959319.525 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2019-08-16T12:41:59.530Z,1565959319.530 [DropWeight] Loaded
2019-08-16T12:41:59.530Z,1565959319.530 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2019-08-16T12:41:59.620Z,1565959319.620 [NAL9602] Loaded
2019-08-16T12:41:59.620Z,1565959319.620 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2019-08-16T12:41:59.626Z,1565959319.626 [Onboard] Loaded
2019-08-16T12:41:59.626Z,1565959319.626 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2019-08-16T12:41:59.629Z,1565959319.629 [Radio_Surface] Loaded
2019-08-16T12:41:59.629Z,1565959319.629 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2019-08-16T12:41:59.631Z,1565959319.631 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409A44E0
2019-08-16T12:41:59.631Z,1565959319.631 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 893
2019-08-16T12:41:59.757Z,1565959319.757 [DAT] Loaded
2019-08-16T12:41:59.757Z,1565959319.757 [ComponentRegistry](DEBUG): SyncComponent "DAT" handled in the control thread.
2019-08-16T12:42:01.034Z,1565959321.034 [BPC1] Loaded
2019-08-16T12:42:01.035Z,1565959321.035 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2019-08-16T12:42:01.035Z,1565959321.035 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2019-08-16T12:42:01.036Z,1565959321.036 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2019-08-16T12:42:01.146Z,1565959321.146 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2019-08-16T12:42:01.147Z,1565959321.147 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2019-08-16T12:42:01.237Z,1565959321.237 [VerticalControl](DEBUG): Construct VerticalControl.
2019-08-16T12:42:01.321Z,1565959321.321 [VerticalControl] Loaded
2019-08-16T12:42:01.321Z,1565959321.321 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2019-08-16T12:42:01.322Z,1565959321.322 [HorizontalControl](DEBUG): Construct HorizontalControl.
2019-08-16T12:42:01.379Z,1565959321.379 [HorizontalControl] Loaded
2019-08-16T12:42:01.380Z,1565959321.380 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2019-08-16T12:42:01.380Z,1565959321.380 [SpeedControl](DEBUG): Construct SpeedControl.
2019-08-16T12:42:01.382Z,1565959321.382 [SpeedControl] Loaded
2019-08-16T12:42:01.382Z,1565959321.382 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2019-08-16T12:42:01.383Z,1565959321.383 [LoopControl](DEBUG): Construct LoopControl.
2019-08-16T12:42:01.384Z,1565959321.384 [LoopControl] Loaded
2019-08-16T12:42:01.384Z,1565959321.384 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2019-08-16T12:42:01.384Z,1565959321.384 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2019-08-16T12:42:01.385Z,1565959321.385 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2019-08-16T12:42:01.409Z,1565959321.409 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2019-08-16T12:42:01.409Z,1565959321.409 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2019-08-16T12:42:01.749Z,1565959321.749 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2019-08-16T12:42:01.752Z,1565959321.752 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2019-08-16T12:42:01.753Z,1565959321.753 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2019-08-16T12:42:01.760Z,1565959321.760 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2019-08-16T12:42:01.761Z,1565959321.761 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40ADF4E0
2019-08-16T12:42:01.761Z,1565959321.761 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 894
2019-08-16T12:42:01.766Z,1565959321.766 [Supervisor](INFO): Main Thread ID is 804
2019-08-16T12:42:01.766Z,1565959321.766 [Supervisor](DEBUG): Running supervisor.
2019-08-16T12:42:01.767Z,1565959321.767 [CommandLine ThreadHandler](INFO): Handler Thread ID is 895
2019-08-16T12:42:01.769Z,1565959321.769 [controlThread ThreadHandler](INFO): Handler Thread ID is 896
2019-08-16T12:42:01.769Z,1565959321.769 [controlThread](DEBUG): Initializing ControlThread
2019-08-16T12:42:01.771Z,1565959321.771 [SBIT](INFO): Initialize SBIT Component.
2019-08-16T12:42:01.772Z,1565959321.772 [SBIT](IMPORTANT): git: 2019-08-13
2019-08-16T12:42:01.772Z,1565959321.772 [SBIT](INFO): git hash: 6b080875362fb71081cecd990260e30fa66d1cc0
2019-08-16T12:42:01.772Z,1565959321.772 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2019-08-16T12:42:01.774Z,1565959321.774 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018
Kernel Reported: #1 PREEMPT Thu Feb 21 11:17:40 PST 2019
2019-08-16T12:42:01.775Z,1565959321.775 [SBIT](INFO): Beginning SBIT in 88.000000 seconds.
2019-08-16T12:42:01.775Z,1565959321.775 [IBIT](INFO): Initialize IBIT Component.
2019-08-16T12:42:01.776Z,1565959321.776 [CBIT](DEBUG): Initialize CBIT Component.
2019-08-16T12:42:01.777Z,1565959321.777 [logger ThreadHandler](INFO): Handler Thread ID is 897
2019-08-16T12:42:01.786Z,1565959321.786 [CBIT](DEBUG): Initialized mux pins.
2019-08-16T12:42:01.787Z,1565959321.787 [CBIT](DEBUG): Initializing the watchdog timer.
2019-08-16T12:42:01.795Z,1565959321.795 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 898
2019-08-16T12:42:01.796Z,1565959321.796 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2019-08-16T12:42:01.799Z,1565959321.799 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2019-08-16T12:42:01.800Z,1565959321.800 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 900
2019-08-16T12:42:01.802Z,1565959321.802 [WetLabsBB2FL](INFO): Powering down
2019-08-16T12:42:01.811Z,1565959321.811 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2019-08-16T12:42:01.811Z,1565959321.811 [CBIT](DEBUG): Initializing heartbeat.
2019-08-16T12:42:01.831Z,1565959321.831 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 901
2019-08-16T12:42:01.832Z,1565959321.832 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2019-08-16T12:42:01.843Z,1565959321.843 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 902
2019-08-16T12:42:01.859Z,1565959321.859 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 903
2019-08-16T12:42:01.868Z,1565959321.868 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2019-08-16T12:42:01.868Z,1565959321.868 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2019-08-16T12:42:01.869Z,1565959321.869 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2019-08-16T12:42:01.869Z,1565959321.869 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2019-08-16T12:42:01.869Z,1565959321.869 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2019-08-16T12:42:01.869Z,1565959321.869 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2019-08-16T12:42:01.869Z,1565959321.869 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2019-08-16T12:42:01.869Z,1565959321.869 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2019-08-16T12:42:01.870Z,1565959321.870 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2019-08-16T12:42:01.870Z,1565959321.870 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2019-08-16T12:42:01.870Z,1565959321.870 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2019-08-16T12:42:01.870Z,1565959321.870 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2019-08-16T12:42:01.870Z,1565959321.870 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2019-08-16T12:42:01.871Z,1565959321.871 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2019-08-16T12:42:01.871Z,1565959321.871 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2019-08-16T12:42:01.871Z,1565959321.871 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2019-08-16T12:42:01.882Z,1565959321.882 [CBIT](DEBUG): Deactivating GF circuits.
2019-08-16T12:42:01.883Z,1565959321.883 [CBIT](DEBUG): Deactivating emergency mode.
2019-08-16T12:42:01.918Z,1565959321.918 [CBIT](DEBUG): Backplane powered.
2019-08-16T12:42:01.923Z,1565959321.923 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2019-08-16T12:42:01.923Z,1565959321.923 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2019-08-16T12:42:01.924Z,1565959321.924 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2019-08-16T12:42:01.924Z,1565959321.924 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2019-08-16T12:42:01.924Z,1565959321.924 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2019-08-16T12:42:01.925Z,1565959321.925 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2019-08-16T12:42:01.926Z,1565959321.926 [NavChart](DEBUG): Initialize NavChart Navigation.
2019-08-16T12:42:01.926Z,1565959321.926 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2019-08-16T12:42:01.937Z,1565959321.937 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2019-08-16T12:42:01.947Z,1565959321.947 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2019-08-16T12:42:01.948Z,1565959321.948 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2019-08-16T12:42:01.948Z,1565959321.948 [LoopControl](DEBUG): Initialize LoopControlComponent.
2019-08-16T12:42:01.949Z,1565959321.949 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2019-08-16T12:42:01.991Z,1565959321.991 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2019-08-16T12:42:02.018Z,1565959322.018 [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-08-16T12:42:02.031Z,1565959322.031 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2019-08-16T12:42:02.111Z,1565959322.111 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2019-08-16T12:42:02.112Z,1565959322.112 [Default:A.Wait](DEBUG): Construct Wait.
2019-08-16T12:42:02.114Z,1565959322.114 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2019-08-16T12:42:02.133Z,1565959322.133 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2019-08-16T12:42:02.159Z,1565959322.159 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2019-08-16T12:42:02.181Z,1565959322.181 [Default:E.Execute](DEBUG): Construct Execute.
2019-08-16T12:42:02.184Z,1565959322.184 [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-08-16T12:42:02.199Z,1565959322.199 [controlThread](DEBUG): Component order: CycleStarter,Aanderaa_O2,ESPComponent,PAR_Licor,AHRS_M2,Depth_Keller,DropWeight,NAL9602,Onboard,DAT,BPC1,PAR_Licor,Depth_Keller,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-08-16T12:42:02.236Z,1565959322.236 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2019-08-16T12:42:02.247Z,1565959322.247 [Radio_Surface](INFO): Powering up
2019-08-16T12:42:02.379Z,1565959322.379 [Depth_Keller](ERROR): Pressure reading out of range: 1895.684326 decibar
2019-08-16T12:42:02.397Z,1565959322.397 [DAT](INFO): Powered 24V power converter LCB with command: ! echo 1 > /dev/loadB2
2019-08-16T12:42:02.397Z,1565959322.397 [DAT](INFO): Powering up
2019-08-16T12:42:02.397Z,1565959322.397 [DAT](DEBUG): Initializing DAT.
2019-08-16T12:42:02.459Z,1565959322.459 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-08-16T12:42:02.471Z,1565959322.471 [CommandLine](IMPORTANT): got command ! echo 1 > /dev/loadB2
2019-08-16T12:42:02.519Z,1565959322.519 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2019-08-16T12:42:02.531Z,1565959322.531 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2019-08-16T12:42:02.533Z,1565959322.533 [ElevatorServo](DEBUG): Initializing EZServoServo.
2019-08-16T12:42:02.547Z,1565959322.547 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2019-08-16T12:42:02.548Z,1565959322.548 [MassServo](DEBUG): Initializing EZServoServo.
2019-08-16T12:42:02.559Z,1565959322.559 [MassServo](DEBUG): Initializing MassServo.
2019-08-16T12:42:02.560Z,1565959322.560 [RudderServo](DEBUG): Initializing EZServoServo.
2019-08-16T12:42:02.571Z,1565959322.571 [RudderServo](DEBUG): Initializing RudderServo.
2019-08-16T12:42:02.572Z,1565959322.572 [ThrusterServo](DEBUG): Initializing EZServoServo.
2019-08-16T12:42:02.583Z,1565959322.583 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2019-08-16T12:42:05.555Z,1565959325.555 [Aanderaa_O2](INFO): Powering down
2019-08-16T12:42:17.650Z,1565959337.650 [DAT](INFO): setting local address to 3
2019-08-16T12:42:18.044Z,1565959338.044 [DAT](INFO): set local address to 3
2019-08-16T12:42:29.748Z,1565959349.748 [NAL9602](INFO): Powering up NAL9602
2019-08-16T12:42:40.664Z,1565959360.664 [NAL9602](INFO): NAL9602 initialized
2019-08-16T12:42:41.475Z,1565959361.475 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:43:30.417Z,1565959410.417 [SBIT](IMPORTANT): Beginning Startup BIT
2019-08-16T12:43:30.421Z,1565959410.421 [CBIT](IMPORTANT): Beginning ground fault scan
2019-08-16T12:43:41.415Z,1565959421.415 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.013458
CHAN A1 (24V): -0.021381
CHAN A2 (12V): -0.004558
CHAN A3 (5V): -0.002177
CHAN B0 (3.3V): -0.001314
CHAN B1 (3.15aV): -0.000723
CHAN B2 (3.15bV): -0.000911
CHAN B3 (GND): -0.000171
OPEN: 0.006744
Full Scale Calc: 4.765 mA, -1.589 mA
2019-08-16T12:44:24.025Z,1565959464.025 [SBIT](IMPORTANT): SBIT PASSED
2019-08-16T12:44:24.045Z,1565959464.045 [CommandLine](IMPORTANT): got command configSet list
2019-08-16T12:44:24.045Z,1565959464.045 [CommandLine](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2019-08-16T12:44:24.047Z,1565959464.047 [CommandLine](IMPORTANT): BPC1.batteryMissingStickThreshold=2 count;

2019-08-16T12:44:24.047Z,1565959464.047 [CommandLine](IMPORTANT): BuoyancyServo.fastPumpDepth=5 meter;

2019-08-16T12:44:24.047Z,1565959464.047 [CommandLine](IMPORTANT): CBIT.stopDepth=10 meter;

2019-08-16T12:44:24.047Z,1565959464.047 [CommandLine](IMPORTANT): CTD_Seabird.minSalinityBound=0.01 practical_salinity_unit;

2019-08-16T12:44:24.048Z,1565959464.048 [CommandLine](IMPORTANT): DVL_micro.loadAtStartup=0 bool;

2019-08-16T12:44:24.048Z,1565959464.048 [CommandLine](IMPORTANT): DropWeight.loadAtStartup=1 bool;

2019-08-16T12:44:24.048Z,1565959464.048 [CommandLine](IMPORTANT): VerticalControl.buoyancyNeutral=220 cubic_centimeter;

2019-08-16T12:44:24.048Z,1565959464.048 [CommandLine](IMPORTANT): VerticalControl.elevDeadband=0.1 degree;

2019-08-16T12:44:24.048Z,1565959464.048 [CommandLine](IMPORTANT): VerticalControl.kiDepthBuoy=0.3 reciprocal_second;

2019-08-16T12:44:24.048Z,1565959464.048 [CommandLine](IMPORTANT): VerticalControl.massDefault=17 millimeter;

2019-08-16T12:44:24.417Z,1565959464.417 [MissionManager](IMPORTANT): Started mission Startup
2019-08-16T12:44:24.418Z,1565959464.418 [Startup] Running Loop=1
2019-08-16T12:44:24.418Z,1565959464.418 [Startup](DEBUG): Aggregate::initialize Startup
2019-08-16T12:44:24.418Z,1565959464.418 [Startup:A.GoToSurface] Running Loop=1
2019-08-16T12:44:24.418Z,1565959464.418 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2019-08-16T12:44:24.419Z,1565959464.419 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2019-08-16T12:44:24.419Z,1565959464.419 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2019-08-16T12:44:24.419Z,1565959464.419 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2019-08-16T12:44:24.420Z,1565959464.420 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2019-08-16T12:44:24.420Z,1565959464.420 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2019-08-16T12:44:24.421Z,1565959464.421 [Startup:StartupSatComms] Running Loop=1
2019-08-16T12:44:24.422Z,1565959464.422 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2019-08-16T12:44:24.422Z,1565959464.422 [Startup:StartupSatComms:A] Running Loop=1
2019-08-16T12:44:24.829Z,1565959464.829 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2019-08-16T12:45:01.961Z,1565959501.961 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2019-08-16T12:45:01.962Z,1565959501.962 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-08-16T12:45:01.971Z,1565959501.971 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-08-16T12:45:02.446Z,1565959502.446 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-08-16T12:45:02.446Z,1565959502.446 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2019-08-16T12:45:24.594Z,1565959524.594 [Startup:StartupSatComms:A](INFO): Timed out from 2019-08-16T12:44:24.4Z
2019-08-16T12:45:24.594Z,1565959524.594 [Startup:StartupSatComms:A] Stopped
2019-08-16T12:45:24.594Z,1565959524.594 [Startup:StartupSatComms:B] Running Loop=1
2019-08-16T12:45:24.995Z,1565959524.995 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2019-08-16T12:45:40.857Z,1565959540.857 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.005072
2019-08-16T12:45:47.336Z,1565959547.336 [DataOverHttps](INFO): Sending 187 bytes from file Logs/20190816T122024/Courier0007.lzma
2019-08-16T12:45:48.140Z,1565959548.140 [DataOverHttps](INFO): Moved sent file to Logs/20190816T122024/Courier0007.lzma.bak
2019-08-16T12:45:48.140Z,1565959548.140 [DataOverHttps](INFO): SBD MOMSN=11581671
2019-08-16T12:46:00.467Z,1565959560.467 [DataOverHttps](INFO): Sending 99 bytes from file Logs/20190816T123501/Courier0000.lzma
2019-08-16T12:46:01.272Z,1565959561.272 [DataOverHttps](INFO): Moved sent file to Logs/20190816T123501/Courier0000.lzma.bak
2019-08-16T12:46:01.272Z,1565959561.272 [DataOverHttps](INFO): SBD MOMSN=11581673
2019-08-16T12:46:12.175Z,1565959572.175 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20190816T123501/Courier0004.lzma
2019-08-16T12:46:12.980Z,1565959572.980 [DataOverHttps](INFO): Moved sent file to Logs/20190816T123501/Courier0004.lzma.bak
2019-08-16T12:46:12.980Z,1565959572.980 [DataOverHttps](INFO): SBD MOMSN=11581677
2019-08-16T12:46:24.336Z,1565959584.336 [DataOverHttps](INFO): Sending 533 bytes from file Logs/20190816T122024/Express0008.lzma
2019-08-16T12:46:24.802Z,1565959584.802 [Startup:StartupSatComms:B](INFO): Timed out from 2019-08-16T12:45:24.6Z
2019-08-16T12:46:24.802Z,1565959584.802 [Startup:StartupSatComms:B] Stopped
2019-08-16T12:46:24.802Z,1565959584.802 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2019-08-16T12:46:24.802Z,1565959584.802 [Startup:StartupSatComms] Stopped
2019-08-16T12:46:24.803Z,1565959584.803 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2019-08-16T12:46:24.803Z,1565959584.803 [Startup](INFO): Completed Startup
2019-08-16T12:46:24.803Z,1565959584.803 [MissionManager](INFO): Startup is completed.
2019-08-16T12:46:24.804Z,1565959584.804 [MissionManager](INFO): Uninitializing Mission Startup
2019-08-16T12:46:24.804Z,1565959584.804 [Startup] Stopped
2019-08-16T12:46:24.804Z,1565959584.804 [Startup](DEBUG): Aggregate::uninitialize Startup
2019-08-16T12:46:24.804Z,1565959584.804 [Startup:A.GoToSurface] Stopped
2019-08-16T12:46:24.804Z,1565959584.804 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2019-08-16T12:46:25.140Z,1565959585.140 [DataOverHttps](INFO): Moved sent file to Logs/20190816T122024/Express0008.lzma.bak
2019-08-16T12:46:25.140Z,1565959585.140 [DataOverHttps](INFO): SBD MOMSN=11581679
2019-08-16T12:46:25.219Z,1565959585.219 [MissionManager](IMPORTANT): Started mission Default
2019-08-16T12:46:25.220Z,1565959585.220 [Default] Running Loop=1
2019-08-16T12:46:25.220Z,1565959585.220 [Default](DEBUG): Aggregate::initialize Default
2019-08-16T12:46:25.220Z,1565959585.220 [Default:B.GoToSurface] Running Loop=1
2019-08-16T12:46:25.220Z,1565959585.220 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2019-08-16T12:46:25.220Z,1565959585.220 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2019-08-16T12:46:25.221Z,1565959585.221 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2019-08-16T12:46:25.221Z,1565959585.221 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2019-08-16T12:46:25.221Z,1565959585.221 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2019-08-16T12:46:25.222Z,1565959585.222 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2019-08-16T12:46:25.222Z,1565959585.222 [Default:A.Wait] Running Loop=1
2019-08-16T12:46:25.222Z,1565959585.222 [Default:A.Wait](DEBUG): Initialize Wait Component.
2019-08-16T12:46:38.544Z,1565959598.544 [Default:A.Wait](INFO): Done Waiting.
2019-08-16T12:46:38.544Z,1565959598.544 [Default:A.Wait] Stopped
2019-08-16T12:46:38.544Z,1565959598.544 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2019-08-16T12:46:38.950Z,1565959598.950 [Default:CheckIn] Running Loop=1
2019-08-16T12:46:38.950Z,1565959598.950 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-08-16T12:46:38.950Z,1565959598.950 [Default:CheckIn:Read_GPS] Running Loop=1
2019-08-16T12:46:39.339Z,1565959599.339 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2019-08-16T12:46:50.529Z,1565959610.529 [CommandLine](IMPORTANT): got command configSet list
2019-08-16T12:46:50.529Z,1565959610.529 [CommandLine](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2019-08-16T12:46:50.530Z,1565959610.530 [CommandLine](IMPORTANT): BPC1.batteryMissingStickThreshold=2 count;

2019-08-16T12:46:50.530Z,1565959610.530 [CommandLine](IMPORTANT): BuoyancyServo.fastPumpDepth=5 meter;

2019-08-16T12:46:50.530Z,1565959610.530 [CommandLine](IMPORTANT): CBIT.stopDepth=10 meter;

2019-08-16T12:46:50.530Z,1565959610.530 [CommandLine](IMPORTANT): CTD_Seabird.minSalinityBound=0.01 practical_salinity_unit;

2019-08-16T12:46:50.530Z,1565959610.530 [CommandLine](IMPORTANT): DVL_micro.loadAtStartup=0 bool;

2019-08-16T12:46:50.531Z,1565959610.531 [CommandLine](IMPORTANT): DropWeight.loadAtStartup=1 bool;

2019-08-16T12:46:50.531Z,1565959610.531 [CommandLine](IMPORTANT): VerticalControl.buoyancyNeutral=220 cubic_centimeter;

2019-08-16T12:46:50.531Z,1565959610.531 [CommandLine](IMPORTANT): VerticalControl.elevDeadband=0.1 degree;

2019-08-16T12:46:50.531Z,1565959610.531 [CommandLine](IMPORTANT): VerticalControl.kiDepthBuoy=0.3 reciprocal_second;

2019-08-16T12:46:50.531Z,1565959610.531 [CommandLine](IMPORTANT): VerticalControl.massDefault=17 millimeter;

2019-08-16T12:47:43.556Z,1565959663.556 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2019-08-16T12:47:44.374Z,1565959664.374 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:47:48.418Z,1565959668.418 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:47:51.647Z,1565959671.647 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:47:54.475Z,1565959674.475 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:47:57.703Z,1565959677.703 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:48:00.530Z,1565959680.530 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:48:01.568Z,1565959681.568 [DataOverHttps](IMPORTANT): SBD MTMSN=20190816T124802
2019-08-16T12:48:03.096Z,1565959683.096 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2019-08-16T12:48:03.096Z,1565959683.096 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-08-16T12:48:03.114Z,1565959683.114 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-08-16T12:48:03.359Z,1565959683.359 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:48:03.444Z,1565959683.444 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-08-16T12:48:03.444Z,1565959683.444 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2019-08-16T12:48:05.383Z,1565959685.383 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:48:06.619Z,1565959686.619 [DataOverHttps](INFO): Received command:sched asap "configSet Express linearApproximation CTD_Seabird.sea_water_electrical_conductivity 0.001 siemens_per_meter persist;configSet Express linearApproximation mass_concentration_of_oxygen_in_sea_water 750 microgram_per_liter persist" 19fjt 1 2
2019-08-16T12:48:06.716Z,1565959686.716 [CommandLine](IMPORTANT): got command schedule asap "configSet Express linearApproximation CTD_Seabird.sea_water_electrical_conductivity 0.001 siemens_per_meter persist;configSet Express linearApproximation mass_concentration_of_oxygen_in_sea_water 750 microgram_per_liter persist" 19fjt 1 2.000000
2019-08-16T12:48:06.716Z,1565959686.716 [CommandLine](IMPORTANT): Scheduling command #1 of 2 with id=19fjt
2019-08-16T12:48:06.717Z,1565959686.717 [CommandLine](IMPORTANT): Scheduled #1 (#1 of 2 with id='19fjt'): "configSet Express linearApproximation CTD_Seabird.sea_water_electrical_conductivity 0.001 siemens_per_meter persist;configSet Express linearApproximation mass_concentration_of_oxygen_in_sea_water 750 microgram_per_liter persist" ASAP
2019-08-16T12:48:07.403Z,1565959687.403 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:48:07.424Z,1565959687.424 [DataOverHttps](IMPORTANT): SBD MTMSN=20190816T124808
2019-08-16T12:48:10.679Z,1565959690.679 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:48:12.370Z,1565959692.370 [DataOverHttps](INFO): Received command:sched asap "configSet Express None CTD_Seabird.bin_median_sea_water_salinity persist" 19fjt 2 2
2019-08-16T12:48:12.447Z,1565959692.447 [CommandLine](IMPORTANT): got command schedule asap "configSet Express None CTD_Seabird.bin_median_sea_water_salinity persist" 19fjt 2 2.000000
2019-08-16T12:48:12.448Z,1565959692.448 [CommandLine](IMPORTANT): Scheduling command #2 of 2 with id=19fjt
2019-08-16T12:48:12.449Z,1565959692.449 [CommandLine](IMPORTANT): Scheduled #2 (#2 of 2 with id='19fjt'): "configSet Express None CTD_Seabird.bin_median_sea_water_salinity persist" ASAP
2019-08-16T12:48:13.458Z,1565959693.458 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:48:15.342Z,1565959695.342 [CommandLine](IMPORTANT): got command configSet Express linearApproximation CTD_Seabird.sea_water_electrical_conductivity 0.001000 siemens_per_meter persist
2019-08-16T12:48:15.347Z,1565959695.347 [CommandLine](IMPORTANT): got command configSet Express linearApproximation mass_concentration_of_oxygen_in_sea_water 750.000000 microgram_per_liter persist
2019-08-16T12:48:16.691Z,1565959696.691 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:48:16.928Z,1565959696.928 [CommandLine](IMPORTANT): got command configSet Express none CTD_Seabird.bin_median_sea_water_salinity persist
2019-08-16T12:48:19.535Z,1565959699.535 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:48:22.762Z,1565959702.762 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:48:25.583Z,1565959705.583 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:48:28.411Z,1565959708.411 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:48:30.431Z,1565959710.431 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:48:32.451Z,1565959712.451 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:48:35.683Z,1565959715.683 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:48:38.514Z,1565959718.514 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:48:41.743Z,1565959721.743 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:48:44.595Z,1565959724.595 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:48:47.411Z,1565959727.411 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:48:49.430Z,1565959729.430 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:48:51.447Z,1565959731.447 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:48:53.466Z,1565959733.466 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:48:56.698Z,1565959736.698 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:48:59.526Z,1565959739.526 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:49:02.758Z,1565959742.758 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:49:05.590Z,1565959745.590 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:49:08.818Z,1565959748.818 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:49:11.651Z,1565959751.651 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:49:14.474Z,1565959754.474 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:49:16.494Z,1565959756.494 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:49:18.519Z,1565959758.519 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:49:21.750Z,1565959761.750 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:49:24.574Z,1565959764.574 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:49:27.806Z,1565959767.806 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:49:30.639Z,1565959770.639 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:49:33.866Z,1565959773.866 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:49:36.694Z,1565959776.694 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:49:39.519Z,1565959779.519 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:49:41.543Z,1565959781.543 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:49:43.575Z,1565959783.575 [BPC1](ERROR): Battery stick #38 (s/n: 0139) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0.
2019-08-16T12:49:43.575Z,1565959783.575 [BPC1](ERROR): Battery stick #39 (s/n: 00F0) reported TERMINATE_DISCHARGE_ALARM. Status code: 0x48C0.
2019-08-16T12:49:43.576Z,1565959783.576 [BPC1](INFO): Calculating totals. Valid battery stick count: 55. Valid reserve battery stick count: 5.
2019-08-16T12:49:43.579Z,1565959783.579 [BPC1](INFO): Received data from all battery sticks.
2019-08-16T12:49:44.770Z,1565959784.770 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:49:47.602Z,1565959787.602 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:49:50.830Z,1565959790.830 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:49:53.666Z,1565959793.666 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:49:56.890Z,1565959796.890 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:49:59.722Z,1565959799.722 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:50:02.558Z,1565959802.558 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:50:04.570Z,1565959804.570 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:50:06.590Z,1565959806.590 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:50:09.819Z,1565959809.819 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:50:12.651Z,1565959812.651 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:50:15.882Z,1565959815.882 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:50:18.706Z,1565959818.706 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:50:21.942Z,1565959821.942 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:50:24.766Z,1565959824.766 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:50:27.598Z,1565959827.598 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:50:29.619Z,1565959829.619 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:50:32.854Z,1565959832.854 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:50:35.675Z,1565959835.675 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:50:38.910Z,1565959838.910 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:50:41.739Z,1565959841.739 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:50:44.603Z,1565959844.603 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:50:46.618Z,1565959846.618 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:50:48.627Z,1565959848.627 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:50:50.651Z,1565959850.651 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:50:53.882Z,1565959853.882 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:50:56.714Z,1565959856.714 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:50:59.942Z,1565959859.942 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:51:02.774Z,1565959862.774 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:51:04.003Z,1565959864.003 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2019-08-16T12:51:04.003Z,1565959864.003 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-08-16T12:51:04.013Z,1565959864.013 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-08-16T12:51:04.419Z,1565959864.419 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-08-16T12:51:04.419Z,1565959864.419 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2019-08-16T12:51:05.998Z,1565959865.998 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:51:08.826Z,1565959868.826 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:51:11.671Z,1565959871.671 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:51:13.686Z,1565959873.686 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:51:15.698Z,1565959875.698 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:51:18.930Z,1565959878.930 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:51:21.758Z,1565959881.758 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:51:24.991Z,1565959884.991 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:51:27.823Z,1565959887.823 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:51:31.054Z,1565959891.054 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:51:33.878Z,1565959893.878 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:51:36.706Z,1565959896.706 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:51:38.722Z,1565959898.722 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:51:39.169Z,1565959899.169 [Default:CheckIn:Read_GPS](INFO): Timed out from 2019-08-16T12:46:38.0Z
2019-08-16T12:51:39.169Z,1565959899.169 [Default:CheckIn:Read_GPS] Stopped
2019-08-16T12:51:39.169Z,1565959899.169 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-08-16T12:51:39.555Z,1565959899.555 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2019-08-16T12:51:41.955Z,1565959901.955 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:51:44.782Z,1565959904.782 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:51:44.871Z,1565959904.871 [DataOverHttps](INFO): Sending 187 bytes from file Logs/20190816T124149/Courier0004.lzma
2019-08-16T12:51:45.676Z,1565959905.676 [DataOverHttps](INFO): Moved sent file to Logs/20190816T124149/Courier0004.lzma.bak
2019-08-16T12:51:45.676Z,1565959905.676 [DataOverHttps](INFO): SBD MOMSN=11581701
2019-08-16T12:51:48.015Z,1565959908.015 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:51:50.843Z,1565959910.843 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:51:54.079Z,1565959914.079 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:51:56.214Z,1565959916.214 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20190816T124149/Courier0007.lzma
2019-08-16T12:51:56.902Z,1565959916.902 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:51:57.020Z,1565959917.020 [DataOverHttps](INFO): Moved sent file to Logs/20190816T124149/Courier0007.lzma.bak
2019-08-16T12:51:57.020Z,1565959917.020 [DataOverHttps](INFO): SBD MOMSN=11581704
2019-08-16T12:51:59.738Z,1565959919.738 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:52:01.763Z,1565959921.763 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:52:03.770Z,1565959923.770 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:52:07.003Z,1565959927.003 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:52:09.198Z,1565959929.198 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20190816T123237/Express0001.lzma
2019-08-16T12:52:09.850Z,1565959929.850 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:52:10.004Z,1565959930.004 [DataOverHttps](INFO): Moved sent file to Logs/20190816T123237/Express0001.lzma.bak
2019-08-16T12:52:10.004Z,1565959930.004 [DataOverHttps](INFO): SBD MOMSN=11581711
2019-08-16T12:52:13.063Z,1565959933.063 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:52:15.895Z,1565959935.895 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:52:19.123Z,1565959939.123 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:52:20.929Z,1565959940.929 [DataOverHttps](INFO): Sending 911 bytes from file Logs/20190816T123501/Express0001.lzma
2019-08-16T12:52:21.732Z,1565959941.732 [DataOverHttps](INFO): Moved sent file to Logs/20190816T123501/Express0001.lzma.bak
2019-08-16T12:52:21.732Z,1565959941.732 [DataOverHttps](INFO): SBD MOMSN=11581714
2019-08-16T12:52:21.958Z,1565959941.958 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:52:24.779Z,1565959944.779 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:52:26.799Z,1565959946.799 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:52:30.031Z,1565959950.031 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:52:32.858Z,1565959952.858 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:52:33.096Z,1565959953.096 [DataOverHttps](INFO): Sending 177 bytes from file Logs/20190816T123501/Express0005.lzma
2019-08-16T12:52:33.905Z,1565959953.905 [DataOverHttps](INFO): Moved sent file to Logs/20190816T123501/Express0005.lzma.bak
2019-08-16T12:52:33.905Z,1565959953.905 [DataOverHttps](INFO): SBD MOMSN=11581739
2019-08-16T12:52:36.091Z,1565959956.091 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:52:38.918Z,1565959958.918 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:52:42.172Z,1565959962.172 [NAL9602](FAULT): GPS failed to acquire within timeout.
2019-08-16T12:52:42.172Z,1565959962.172 [NAL9602] Data Fault, FailCount= 1
2019-08-16T12:52:42.172Z,1565959962.172 [NAL9602](ERROR): Data Fault
2019-08-16T12:52:42.306Z,1565959962.306 [CBIT](ERROR): Data Fault in component: NAL9602
2019-08-16T12:52:42.576Z,1565959962.576 [NAL9602](INFO): Powering down
2019-08-16T12:52:43.517Z,1565959963.517 [CBIT](INFO): Clearing failed state for component NAL9602
2019-08-16T12:52:43.517Z,1565959963.517 [NAL9602] No Fault, FailCount= 1
2019-08-16T12:52:47.895Z,1565959967.895 [DataOverHttps](INFO): Sending 844 bytes from file Logs/20190816T124149/Express0001.lzma
2019-08-16T12:52:48.700Z,1565959968.700 [DataOverHttps](INFO): Moved sent file to Logs/20190816T124149/Express0001.lzma.bak
2019-08-16T12:52:48.700Z,1565959968.700 [DataOverHttps](INFO): SBD MOMSN=11581744
2019-08-16T12:53:01.151Z,1565959981.151 [DataOverHttps](INFO): Sending 850 bytes from file Logs/20190816T124149/Express0005.lzma
2019-08-16T12:53:01.956Z,1565959981.956 [DataOverHttps](INFO): Moved sent file to Logs/20190816T124149/Express0005.lzma.bak
2019-08-16T12:53:01.956Z,1565959981.956 [DataOverHttps](INFO): SBD MOMSN=11581767
2019-08-16T12:53:12.885Z,1565959992.885 [NAL9602](INFO): Powering up NAL9602
2019-08-16T12:53:13.470Z,1565959993.470 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20190816T124149/Express0006.lzma
2019-08-16T12:53:14.276Z,1565959994.276 [DataOverHttps](INFO): Moved sent file to Logs/20190816T124149/Express0006.lzma.bak
2019-08-16T12:53:14.276Z,1565959994.276 [DataOverHttps](INFO): SBD MOMSN=11581794
2019-08-16T12:53:23.792Z,1565960003.792 [NAL9602](INFO): NAL9602 initialized
2019-08-16T12:53:24.611Z,1565960004.611 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:53:25.186Z,1565960005.186 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20190816T124149/Express0008.lzma
2019-08-16T12:53:25.992Z,1565960005.992 [DataOverHttps](INFO): Moved sent file to Logs/20190816T124149/Express0008.lzma.bak
2019-08-16T12:53:25.992Z,1565960005.992 [DataOverHttps](INFO): SBD MOMSN=11581796
2019-08-16T12:53:27.035Z,1565960007.035 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:53:27.076Z,1565960007.076 [Default:CheckIn:Read_Iridium] Stopped
2019-08-16T12:53:27.076Z,1565960007.076 [Default:CheckIn:C.Wait] Running Loop=1
2019-08-16T12:53:27.076Z,1565960007.076 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-08-16T12:53:30.279Z,1565960010.279 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:53:33.103Z,1565960013.103 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:53:36.327Z,1565960016.327 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:53:39.159Z,1565960019.159 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:53:41.982Z,1565960021.982 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:53:44.010Z,1565960024.010 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:53:46.026Z,1565960026.026 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:53:49.258Z,1565960029.258 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:53:52.090Z,1565960032.090 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:53:55.319Z,1565960035.319 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:53:58.142Z,1565960038.142 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:54:00.991Z,1565960040.991 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:54:03.002Z,1565960043.002 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:54:05.014Z,1565960045.014 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:54:05.039Z,1565960045.039 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2019-08-16T12:54:05.040Z,1565960045.040 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-08-16T12:54:05.050Z,1565960045.050 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-08-16T12:54:05.464Z,1565960045.464 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-08-16T12:54:05.464Z,1565960045.464 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2019-08-16T12:54:07.031Z,1565960047.031 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:54:09.054Z,1565960049.055 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:54:12.286Z,1565960052.286 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:54:15.118Z,1565960055.118 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:54:18.346Z,1565960058.346 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:54:21.174Z,1565960061.174 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:54:24.406Z,1565960064.406 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:54:27.231Z,1565960067.231 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:54:30.066Z,1565960070.066 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:54:32.082Z,1565960072.082 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:54:35.314Z,1565960075.314 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:54:38.143Z,1565960078.143 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:54:41.371Z,1565960081.371 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:54:44.202Z,1565960084.202 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:54:47.435Z,1565960087.435 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:54:50.262Z,1565960090.262 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:54:53.095Z,1565960093.095 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:54:55.110Z,1565960095.110 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:54:58.343Z,1565960098.343 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:55:01.174Z,1565960101.174 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:55:04.398Z,1565960104.398 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:55:07.231Z,1565960107.231 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:55:10.462Z,1565960110.462 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:55:13.290Z,1565960113.290 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:55:16.119Z,1565960116.119 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:55:18.138Z,1565960118.138 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:55:20.155Z,1565960120.155 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:55:23.395Z,1565960123.395 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:55:26.222Z,1565960126.222 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:55:29.450Z,1565960129.450 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:55:32.278Z,1565960132.279 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:55:35.519Z,1565960135.519 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:55:38.335Z,1565960138.335 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:55:41.166Z,1565960141.166 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:55:43.190Z,1565960143.190 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:55:45.211Z,1565960145.211 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:55:48.434Z,1565960148.434 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:55:51.270Z,1565960151.270 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:55:54.498Z,1565960154.498 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:55:57.350Z,1565960157.350 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:56:00.571Z,1565960160.571 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:56:03.387Z,1565960163.387 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:56:06.219Z,1565960166.219 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:56:08.231Z,1565960168.231 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:56:11.470Z,1565960171.470 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:56:14.298Z,1565960174.298 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:56:17.526Z,1565960177.526 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:56:20.371Z,1565960180.371 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:56:23.594Z,1565960183.594 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:56:26.419Z,1565960186.419 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:56:29.243Z,1565960189.243 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:56:31.262Z,1565960191.262 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:56:33.286Z,1565960193.286 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:56:36.514Z,1565960196.514 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:56:39.343Z,1565960199.343 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:56:42.571Z,1565960202.571 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:56:45.402Z,1565960205.402 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:56:48.631Z,1565960208.631 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:56:51.463Z,1565960211.463 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:56:54.299Z,1565960214.299 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:56:57.538Z,1565960217.538 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:57:00.355Z,1565960220.355 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:57:03.586Z,1565960223.586 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:57:06.019Z,1565960226.019 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5
2019-08-16T12:57:06.019Z,1565960226.019 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-08-16T12:57:06.029Z,1565960226.029 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-08-16T12:57:06.415Z,1565960226.415 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:57:06.444Z,1565960226.444 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-08-16T12:57:06.444Z,1565960226.444 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5
2019-08-16T12:57:09.647Z,1565960229.647 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:57:12.475Z,1565960232.475 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:57:15.299Z,1565960235.299 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:57:17.319Z,1565960237.319 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:57:19.350Z,1565960239.350 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:57:22.579Z,1565960242.579 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:57:25.398Z,1565960245.398 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:57:28.631Z,1565960248.631 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:57:31.454Z,1565960251.454 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:57:34.687Z,1565960254.687 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:57:37.519Z,1565960257.519 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:57:40.747Z,1565960260.747 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:57:43.578Z,1565960263.578 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:57:46.407Z,1565960266.407 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:57:49.639Z,1565960269.639 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:57:52.471Z,1565960272.471 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:57:55.699Z,1565960275.699 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:57:58.530Z,1565960278.530 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:58:01.759Z,1565960281.759 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:58:04.591Z,1565960284.591 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:58:07.414Z,1565960287.414 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:58:09.439Z,1565960289.439 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:58:12.666Z,1565960292.666 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:58:15.499Z,1565960295.499 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:58:18.726Z,1565960298.726 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:58:21.555Z,1565960301.555 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:58:24.787Z,1565960304.787 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:58:27.619Z,1565960307.619 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:58:27.656Z,1565960307.656 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-08-16T12:58:27.656Z,1565960307.656 [Default:CheckIn:C.Wait] Stopped
2019-08-16T12:58:27.656Z,1565960307.656 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-08-16T12:58:27.656Z,1565960307.656 [Default:CheckIn:D] Running Loop=1
2019-08-16T12:58:28.056Z,1565960308.056 [Default:CheckIn:D] Stopped
2019-08-16T12:58:28.056Z,1565960308.056 [Default:CheckIn:E] Running Loop=1
2019-08-16T12:58:28.447Z,1565960308.447 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 12.047272 min 
2019-08-16T12:58:28.447Z,1565960308.447 [Default:CheckIn:E] Stopped
2019-08-16T12:58:28.447Z,1565960308.447 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-08-16T12:58:28.447Z,1565960308.447 [Default:CheckIn] Stopped
2019-08-16T12:58:28.448Z,1565960308.448 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-08-16T12:58:28.448Z,1565960308.448 [Default:CheckIn](INFO): Running loop #2
2019-08-16T12:58:28.448Z,1565960308.448 [Default:CheckIn] Running Loop=2
2019-08-16T12:58:28.448Z,1565960308.448 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-08-16T12:58:28.448Z,1565960308.448 [Default:CheckIn:Read_GPS] Running Loop=1
2019-08-16T12:58:30.446Z,1565960310.446 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:58:32.467Z,1565960312.467 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:58:35.690Z,1565960315.690 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:58:38.519Z,1565960318.519 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:58:41.754Z,1565960321.754 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:58:44.582Z,1565960324.582 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:58:47.814Z,1565960327.814 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:58:50.655Z,1565960330.655 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:58:53.475Z,1565960333.475 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:58:55.491Z,1565960335.491 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:58:58.730Z,1565960338.730 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:59:01.550Z,1565960341.550 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:59:04.778Z,1565960344.778 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:59:07.614Z,1565960347.614 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:59:10.851Z,1565960350.851 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:59:13.674Z,1565960353.674 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:59:16.494Z,1565960356.494 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:59:18.522Z,1565960358.522 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:59:20.543Z,1565960360.543 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:59:23.770Z,1565960363.770 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:59:26.602Z,1565960366.602 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:59:29.830Z,1565960369.830 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:59:32.659Z,1565960372.659 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:59:35.890Z,1565960375.890 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:59:38.731Z,1565960378.731 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:59:41.543Z,1565960381.543 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:59:43.567Z,1565960383.567 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:59:46.807Z,1565960386.807 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:59:49.630Z,1565960389.630 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:59:52.854Z,1565960392.854 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:59:55.690Z,1565960395.690 [NAL9602](DEBUG): Fix Requested
2019-08-16T12:59:58.914Z,1565960398.914 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:00:01.746Z,1565960401.746 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:00:04.579Z,1565960404.579 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:00:06.594Z,1565960406.594 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:00:07.031Z,1565960407.031 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6
2019-08-16T13:00:07.031Z,1565960407.031 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-08-16T13:00:07.041Z,1565960407.041 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-08-16T13:00:07.439Z,1565960407.439 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-08-16T13:00:07.439Z,1565960407.439 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6
2019-08-16T13:00:08.614Z,1565960408.614 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:00:11.843Z,1565960411.843 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:00:14.674Z,1565960414.674 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:00:17.911Z,1565960417.911 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:00:20.742Z,1565960420.742 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:00:23.970Z,1565960423.970 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:00:26.790Z,1565960426.790 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:00:29.622Z,1565960429.622 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:00:31.642Z,1565960431.642 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:00:34.878Z,1565960434.878 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:00:37.703Z,1565960437.703 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:00:40.935Z,1565960440.935 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:00:43.763Z,1565960443.763 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:00:46.995Z,1565960446.995 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:00:49.823Z,1565960449.823 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:00:52.666Z,1565960452.666 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:00:54.682Z,1565960454.682 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:00:57.902Z,1565960457.902 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:01:00.731Z,1565960460.731 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:01:03.971Z,1565960463.971 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:01:06.790Z,1565960466.790 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:01:10.019Z,1565960470.019 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:01:12.846Z,1565960472.846 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:01:15.686Z,1565960475.686 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:01:17.699Z,1565960477.699 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:01:19.719Z,1565960479.719 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:01:22.954Z,1565960482.954 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:01:25.779Z,1565960485.779 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:01:29.011Z,1565960489.011 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:01:31.839Z,1565960491.839 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:01:35.074Z,1565960495.074 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:01:37.898Z,1565960497.898 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:01:40.731Z,1565960500.731 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:01:42.743Z,1565960502.743 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:01:45.979Z,1565960505.979 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:01:48.811Z,1565960508.811 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:01:52.054Z,1565960512.054 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:01:54.866Z,1565960514.866 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:01:58.099Z,1565960518.099 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:02:00.934Z,1565960520.934 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:02:03.754Z,1565960523.754 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:02:05.775Z,1565960525.775 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:02:07.806Z,1565960527.806 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:02:11.031Z,1565960531.031 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:02:13.851Z,1565960533.851 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:02:17.082Z,1565960537.082 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:02:19.915Z,1565960539.915 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:02:23.146Z,1565960543.146 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:02:25.974Z,1565960545.974 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:02:28.806Z,1565960548.806 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:02:30.822Z,1565960550.822 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:02:34.051Z,1565960554.051 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:02:36.882Z,1565960556.882 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:02:40.115Z,1565960560.115 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:02:42.955Z,1565960562.955 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:02:46.199Z,1565960566.199 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:02:49.039Z,1565960569.039 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:02:51.859Z,1565960571.859 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:02:55.086Z,1565960575.086 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:02:57.919Z,1565960577.919 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:03:01.151Z,1565960581.151 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:03:03.982Z,1565960583.982 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:03:07.206Z,1565960587.206 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:03:08.038Z,1565960588.038 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7
2019-08-16T13:03:08.039Z,1565960588.039 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-08-16T13:03:08.048Z,1565960588.048 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-08-16T13:03:08.455Z,1565960588.455 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-08-16T13:03:08.455Z,1565960588.455 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7
2019-08-16T13:03:10.042Z,1565960590.042 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:03:12.863Z,1565960592.863 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:03:14.887Z,1565960594.887 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:03:18.119Z,1565960598.119 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:03:20.950Z,1565960600.950 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:03:24.178Z,1565960604.178 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:03:26.996Z,1565960606.996 [NAL9602](FAULT): GPS failed to acquire within timeout.
2019-08-16T13:03:26.996Z,1565960606.996 [NAL9602] Data Fault, FailCount= 2
2019-08-16T13:03:26.996Z,1565960606.996 [NAL9602](ERROR): Data Fault
2019-08-16T13:03:27.027Z,1565960607.027 [CBIT](ERROR): Data Fault in component: NAL9602
2019-08-16T13:03:27.396Z,1565960607.396 [NAL9602](INFO): Powering down
2019-08-16T13:03:28.239Z,1565960608.239 [CBIT](INFO): Clearing failed state for component NAL9602
2019-08-16T13:03:28.239Z,1565960608.239 [NAL9602] No Fault, FailCount= 2
2019-08-16T13:03:28.641Z,1565960608.641 [Default:CheckIn:Read_GPS](INFO): Timed out from 2019-08-16T12:58:28.4Z
2019-08-16T13:03:28.641Z,1565960608.641 [Default:CheckIn:Read_GPS] Stopped
2019-08-16T13:03:28.641Z,1565960608.641 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-08-16T13:03:33.698Z,1565960613.698 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20190816T124149/Courier0009.lzma
2019-08-16T13:03:34.504Z,1565960614.504 [DataOverHttps](INFO): Moved sent file to Logs/20190816T124149/Courier0009.lzma.bak
2019-08-16T13:03:34.504Z,1565960614.504 [DataOverHttps](INFO): SBD MOMSN=11581804
2019-08-16T13:03:45.370Z,1565960625.370 [DataOverHttps](INFO): Sending 177 bytes from file Logs/20190816T124149/Express0011.lzma
2019-08-16T13:03:46.176Z,1565960626.176 [DataOverHttps](INFO): Moved sent file to Logs/20190816T124149/Express0011.lzma.bak
2019-08-16T13:03:46.176Z,1565960626.176 [DataOverHttps](INFO): SBD MOMSN=11581806
2019-08-16T13:03:47.248Z,1565960627.248 [Default:CheckIn:Read_Iridium] Stopped
2019-08-16T13:03:47.248Z,1565960627.248 [Default:CheckIn:C.Wait] Running Loop=1
2019-08-16T13:03:47.248Z,1565960627.248 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-08-16T13:03:57.706Z,1565960637.706 [NAL9602](INFO): Powering up NAL9602
2019-08-16T13:04:08.608Z,1565960648.608 [NAL9602](INFO): NAL9602 initialized
2019-08-16T13:04:09.422Z,1565960649.422 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:04:11.850Z,1565960651.850 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:04:15.083Z,1565960655.083 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:04:17.910Z,1565960657.910 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:04:21.138Z,1565960661.138 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:04:23.967Z,1565960663.967 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:04:26.795Z,1565960666.795 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:04:28.818Z,1565960668.818 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:04:30.842Z,1565960670.842 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:04:34.066Z,1565960674.066 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:04:36.894Z,1565960676.894 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:04:40.130Z,1565960680.130 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:04:42.959Z,1565960682.959 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:04:46.194Z,1565960686.194 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:04:49.018Z,1565960689.018 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:04:51.862Z,1565960691.862 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:04:53.870Z,1565960693.870 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:04:55.887Z,1565960695.887 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:04:59.126Z,1565960699.126 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:05:01.954Z,1565960701.954 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:05:05.182Z,1565960705.182 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:05:08.011Z,1565960708.011 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:05:11.251Z,1565960711.251 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:05:14.070Z,1565960714.070 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:05:16.894Z,1565960716.894 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:05:18.918Z,1565960718.918 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:05:22.150Z,1565960722.150 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:05:24.975Z,1565960724.975 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:05:28.215Z,1565960728.215 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:05:31.038Z,1565960731.038 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:05:34.274Z,1565960734.274 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:05:37.098Z,1565960737.098 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:05:39.926Z,1565960739.926 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:05:41.947Z,1565960741.947 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:05:45.187Z,1565960745.187 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:05:48.006Z,1565960748.006 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:05:51.243Z,1565960751.243 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:05:54.066Z,1565960754.066 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:05:57.295Z,1565960757.295 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:06:00.126Z,1565960760.126 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:06:02.964Z,1565960762.964 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:06:04.974Z,1565960764.974 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:06:08.206Z,1565960768.207 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:06:09.030Z,1565960769.030 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8
2019-08-16T13:06:09.030Z,1565960769.030 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-08-16T13:06:09.040Z,1565960769.040 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-08-16T13:06:09.449Z,1565960769.449 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-08-16T13:06:09.449Z,1565960769.449 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8
2019-08-16T13:06:11.034Z,1565960771.034 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:06:14.266Z,1565960774.266 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:06:17.094Z,1565960777.094 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:06:20.326Z,1565960780.326 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:06:23.159Z,1565960783.159 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:06:25.983Z,1565960785.983 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:06:27.999Z,1565960787.999 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:06:30.026Z,1565960790.026 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:06:33.250Z,1565960793.250 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:06:36.090Z,1565960796.090 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:06:39.310Z,1565960799.310 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:06:42.147Z,1565960802.147 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:06:45.375Z,1565960805.375 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:06:48.199Z,1565960808.199 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:06:51.031Z,1565960811.031 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:06:53.050Z,1565960813.050 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:06:56.279Z,1565960816.279 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:06:59.110Z,1565960819.110 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:07:02.338Z,1565960822.338 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:07:05.215Z,1565960825.215 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:07:08.398Z,1565960828.398 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:07:11.235Z,1565960831.235 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:07:14.058Z,1565960834.058 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:07:16.079Z,1565960836.079 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:07:18.094Z,1565960838.094 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:07:21.331Z,1565960841.331 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:07:24.154Z,1565960844.154 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:07:27.387Z,1565960847.387 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:07:30.214Z,1565960850.214 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:07:33.451Z,1565960853.451 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:07:36.274Z,1565960856.274 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:07:39.107Z,1565960859.107 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:07:41.135Z,1565960861.135 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:07:44.358Z,1565960864.358 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:07:47.182Z,1565960867.182 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:07:50.418Z,1565960870.418 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:07:53.242Z,1565960873.242 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:07:56.479Z,1565960876.479 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:07:59.311Z,1565960879.311 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:08:02.138Z,1565960882.138 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:08:04.150Z,1565960884.150 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:08:06.175Z,1565960886.175 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:08:09.411Z,1565960889.411 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:08:12.238Z,1565960892.238 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:08:15.467Z,1565960895.467 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:08:18.294Z,1565960898.294 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:08:21.526Z,1565960901.526 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:08:24.354Z,1565960904.354 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:08:27.183Z,1565960907.183 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:08:29.207Z,1565960909.207 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:08:32.438Z,1565960912.438 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:08:35.262Z,1565960915.262 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:08:38.499Z,1565960918.499 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:08:41.322Z,1565960921.322 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:08:44.555Z,1565960924.555 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:08:47.379Z,1565960927.379 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:08:47.820Z,1565960927.820 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-08-16T13:08:47.820Z,1565960927.820 [Default:CheckIn:C.Wait] Stopped
2019-08-16T13:08:47.820Z,1565960927.820 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-08-16T13:08:47.820Z,1565960927.820 [Default:CheckIn:D] Running Loop=1
2019-08-16T13:08:48.236Z,1565960928.236 [Default:CheckIn:D] Stopped
2019-08-16T13:08:48.236Z,1565960928.236 [Default:CheckIn:E] Running Loop=1
2019-08-16T13:08:48.605Z,1565960928.605 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 22.383604 min 
2019-08-16T13:08:48.605Z,1565960928.605 [Default:CheckIn:E] Stopped
2019-08-16T13:08:48.605Z,1565960928.605 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-08-16T13:08:48.605Z,1565960928.605 [Default:CheckIn] Stopped
2019-08-16T13:08:48.605Z,1565960928.605 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-08-16T13:08:48.606Z,1565960928.606 [Default:CheckIn](INFO): Running loop #3
2019-08-16T13:08:48.606Z,1565960928.606 [Default:CheckIn] Running Loop=3
2019-08-16T13:08:48.606Z,1565960928.606 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-08-16T13:08:48.606Z,1565960928.606 [Default:CheckIn:Read_GPS] Running Loop=1
2019-08-16T13:08:50.207Z,1565960930.207 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:08:53.042Z,1565960933.042 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:08:56.271Z,1565960936.271 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:08:59.095Z,1565960939.095 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:09:02.326Z,1565960942.326 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:09:05.159Z,1565960945.159 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:09:08.386Z,1565960948.386 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:09:10.026Z,1565960950.026 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 9
2019-08-16T13:09:10.026Z,1565960950.026 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-08-16T13:09:10.036Z,1565960950.036 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-08-16T13:09:10.440Z,1565960950.440 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-08-16T13:09:10.441Z,1565960950.441 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 9
2019-08-16T13:09:11.218Z,1565960951.218 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:09:14.046Z,1565960954.046 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:09:17.278Z,1565960957.278 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:09:20.506Z,1565960960.506 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:09:20.910Z,1565960960.910 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,130918.00,A,4149.67245,N,08324.69313,W,0.019,0.00,160819,,,A*78
2019-08-16T13:09:20.913Z,1565960960.913 [NAL9602](INFO): GPS fix at 20190816T130918: (41.827874, -83.411552)
2019-08-16T13:09:20.970Z,1565960960.970 [Default:CheckIn:Read_GPS] Stopped
2019-08-16T13:09:20.970Z,1565960960.970 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-08-16T13:09:26.279Z,1565960966.279 [DataOverHttps](INFO): Sending 214 bytes from file Logs/20190816T124149/Courier0013.lzma
2019-08-16T13:09:27.084Z,1565960967.084 [DataOverHttps](INFO): Moved sent file to Logs/20190816T124149/Courier0013.lzma.bak
2019-08-16T13:09:27.084Z,1565960967.084 [DataOverHttps](INFO): SBD MOMSN=11581811
2019-08-16T13:09:38.406Z,1565960978.406 [DataOverHttps](INFO): Sending 233 bytes from file Logs/20190816T124149/Express0014.lzma
2019-08-16T13:09:39.212Z,1565960979.212 [DataOverHttps](INFO): Moved sent file to Logs/20190816T124149/Express0014.lzma.bak
2019-08-16T13:09:39.212Z,1565960979.212 [DataOverHttps](INFO): SBD MOMSN=11581814
2019-08-16T13:09:40.343Z,1565960980.343 [Default:CheckIn:Read_Iridium] Stopped
2019-08-16T13:09:40.343Z,1565960980.343 [Default:CheckIn:C.Wait] Running Loop=1
2019-08-16T13:09:40.344Z,1565960980.344 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-08-16T13:09:53.223Z,1565960993.223 [NAL9602](INFO): Not Powering down - fast GPS
2019-08-16T13:14:40.905Z,1565961280.905 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-08-16T13:14:40.905Z,1565961280.905 [Default:CheckIn:C.Wait] Stopped
2019-08-16T13:14:40.906Z,1565961280.906 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-08-16T13:14:40.906Z,1565961280.906 [Default:CheckIn:D] Running Loop=1
2019-08-16T13:14:41.309Z,1565961281.309 [Default:CheckIn:D] Stopped
2019-08-16T13:14:41.309Z,1565961281.309 [Default:CheckIn:E] Running Loop=1
2019-08-16T13:14:41.713Z,1565961281.713 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 28.268148 min 
2019-08-16T13:14:41.713Z,1565961281.713 [Default:CheckIn:E] Stopped
2019-08-16T13:14:41.713Z,1565961281.713 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-08-16T13:14:41.713Z,1565961281.713 [Default:CheckIn] Stopped
2019-08-16T13:14:41.713Z,1565961281.713 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-08-16T13:14:41.714Z,1565961281.714 [Default:CheckIn](INFO): Running loop #4
2019-08-16T13:14:41.714Z,1565961281.714 [Default:CheckIn] Running Loop=4
2019-08-16T13:14:41.714Z,1565961281.714 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-08-16T13:14:41.714Z,1565961281.714 [Default:CheckIn:Read_GPS] Running Loop=1
2019-08-16T13:14:43.311Z,1565961283.311 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:14:43.705Z,1565961283.705 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,131440.00,A,4149.69427,N,08324.71310,W,0.039,336.38,160819,,,D*75
2019-08-16T13:14:43.707Z,1565961283.707 [NAL9602](INFO): GPS fix at 20190816T131440: (41.828238, -83.411885)
2019-08-16T13:14:43.762Z,1565961283.762 [Default:CheckIn:Read_GPS] Stopped
2019-08-16T13:14:43.762Z,1565961283.762 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-08-16T13:14:45.219Z,1565961285.219 [NAL9602](ERROR): parseGSV uart error: serial buffer full
2019-08-16T13:14:51.870Z,1565961291.870 [DataOverHttps](INFO): Sending 62 bytes from file Logs/20190816T124149/Courier0016.lzma
2019-08-16T13:14:52.676Z,1565961292.676 [DataOverHttps](INFO): Moved sent file to Logs/20190816T124149/Courier0016.lzma.bak
2019-08-16T13:14:52.676Z,1565961292.676 [DataOverHttps](INFO): SBD MOMSN=11581825
2019-08-16T13:15:03.926Z,1565961303.926 [DataOverHttps](INFO): Sending 135 bytes from file Logs/20190816T124149/Express0017.lzma
2019-08-16T13:15:04.732Z,1565961304.732 [DataOverHttps](INFO): Moved sent file to Logs/20190816T124149/Express0017.lzma.bak
2019-08-16T13:15:04.732Z,1565961304.732 [DataOverHttps](INFO): SBD MOMSN=11581829
2019-08-16T13:15:05.866Z,1565961305.866 [Default:CheckIn:Read_Iridium] Stopped
2019-08-16T13:15:05.866Z,1565961305.866 [Default:CheckIn:C.Wait] Running Loop=1
2019-08-16T13:15:05.866Z,1565961305.866 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-08-16T13:15:15.101Z,1565961315.101 [NAL9602](INFO): SBD MO Status=2, MOMSN=31150, MT Status=2, MTMSN=0
2019-08-16T13:15:15.101Z,1565961315.101 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2019-08-16T13:15:34.901Z,1565961334.901 [NAL9602](INFO): SBD MO Status=2, MOMSN=31150, MT Status=2, MTMSN=0
2019-08-16T13:15:34.901Z,1565961334.901 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2019-08-16T13:15:43.389Z,1565961343.389 [NAL9602](INFO): SBD MO Status=2, MOMSN=31150, MT Status=2, MTMSN=0
2019-08-16T13:15:43.389Z,1565961343.389 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2019-08-16T13:16:10.447Z,1565961370.447 [NAL9602](INFO): SBD MO Status=2, MOMSN=31150, MT Status=2, MTMSN=0
2019-08-16T13:16:10.448Z,1565961370.448 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2019-08-16T13:16:25.399Z,1565961385.399 [NAL9602](INFO): SBD MO Status=2, MOMSN=31150, MT Status=2, MTMSN=0
2019-08-16T13:16:25.399Z,1565961385.399 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2019-08-16T13:16:33.879Z,1565961393.879 [NAL9602](INFO): SBD MO Status=2, MOMSN=31150, MT Status=2, MTMSN=0
2019-08-16T13:16:33.879Z,1565961393.879 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2019-08-16T13:16:42.769Z,1565961402.769 [NAL9602](INFO): SBD MO Status=2, MOMSN=31150, MT Status=2, MTMSN=0
2019-08-16T13:16:42.769Z,1565961402.769 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2019-08-16T13:17:00.165Z,1565961420.165 [NAL9602](INFO): SBD MO Status=2, MOMSN=31150, MT Status=2, MTMSN=0
2019-08-16T13:17:00.165Z,1565961420.165 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2019-08-16T13:17:09.461Z,1565961429.461 [NAL9602](INFO): SBD MO Status=2, MOMSN=31150, MT Status=2, MTMSN=0
2019-08-16T13:17:09.461Z,1565961429.461 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2019-08-16T13:17:22.387Z,1565961442.387 [NAL9602](INFO): SBD MO Status=2, MOMSN=31150, MT Status=2, MTMSN=0
2019-08-16T13:17:22.387Z,1565961442.387 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2019-08-16T13:18:07.229Z,1565961487.229 [NAL9602](INFO): SBD MO Status=2, MOMSN=31150, MT Status=2, MTMSN=0
2019-08-16T13:18:07.229Z,1565961487.229 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2019-08-16T13:18:26.619Z,1565961506.619 [NAL9602](INFO): SBD MO Status=2, MOMSN=31150, MT Status=2, MTMSN=0
2019-08-16T13:18:26.619Z,1565961506.619 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2019-08-16T13:18:44.805Z,1565961524.805 [NAL9602](INFO): SBD MO Status=2, MOMSN=31150, MT Status=2, MTMSN=0
2019-08-16T13:18:44.805Z,1565961524.805 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2019-08-16T13:18:53.710Z,1565961533.710 [NAL9602](INFO): SBD MO Status=2, MOMSN=31150, MT Status=2, MTMSN=0
2019-08-16T13:18:53.711Z,1565961533.711 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2019-08-16T13:19:10.279Z,1565961550.279 [NAL9602](INFO): SBD MO Status=2, MOMSN=31150, MT Status=2, MTMSN=0
2019-08-16T13:19:10.279Z,1565961550.279 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2019-08-16T13:19:17.957Z,1565961557.957 [NAL9602](INFO): SBD MO Status=2, MOMSN=31150, MT Status=2, MTMSN=0
2019-08-16T13:19:17.957Z,1565961557.957 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2019-08-16T13:19:26.438Z,1565961566.438 [NAL9602](INFO): SBD MO Status=2, MOMSN=31150, MT Status=2, MTMSN=0
2019-08-16T13:19:26.438Z,1565961566.438 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2019-08-16T13:19:35.325Z,1565961575.325 [NAL9602](INFO): SBD MO Status=2, MOMSN=31150, MT Status=2, MTMSN=0
2019-08-16T13:19:35.325Z,1565961575.325 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2019-08-16T13:19:40.172Z,1565961580.172 [NAL9602](INFO): SBD MO Status=2, MOMSN=31150, MT Status=2, MTMSN=0
2019-08-16T13:19:40.172Z,1565961580.172 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2019-08-16T13:19:45.844Z,1565961585.844 [NAL9602](INFO): SBD MO Status=2, MOMSN=31150, MT Status=2, MTMSN=0
2019-08-16T13:19:45.844Z,1565961585.844 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2019-08-16T13:19:46.236Z,1565961586.236 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2019-08-16T13:20:06.465Z,1565961606.465 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-08-16T13:20:06.465Z,1565961606.465 [Default:CheckIn:C.Wait] Stopped
2019-08-16T13:20:06.465Z,1565961606.465 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-08-16T13:20:06.465Z,1565961606.465 [Default:CheckIn:D] Running Loop=1
2019-08-16T13:20:06.876Z,1565961606.876 [Default:CheckIn:D] Stopped
2019-08-16T13:20:06.876Z,1565961606.876 [Default:CheckIn:E] Running Loop=1
2019-08-16T13:20:07.265Z,1565961607.265 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 33.694267 min 
2019-08-16T13:20:07.265Z,1565961607.265 [Default:CheckIn:E] Stopped
2019-08-16T13:20:07.265Z,1565961607.265 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-08-16T13:20:07.265Z,1565961607.265 [Default:CheckIn] Stopped
2019-08-16T13:20:07.265Z,1565961607.265 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-08-16T13:20:07.265Z,1565961607.265 [Default:CheckIn](INFO): Running loop #5
2019-08-16T13:20:07.265Z,1565961607.265 [Default:CheckIn] Running Loop=5
2019-08-16T13:20:07.265Z,1565961607.265 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-08-16T13:20:07.265Z,1565961607.265 [Default:CheckIn:Read_GPS] Running Loop=1
2019-08-16T13:20:08.879Z,1565961608.879 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:20:09.259Z,1565961609.259 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,132006.00,A,4149.69651,N,08324.71588,W,0.078,350.39,160819,,,A*75
2019-08-16T13:20:09.262Z,1565961609.262 [NAL9602](INFO): GPS fix at 20190816T132006: (41.828275, -83.411931)
2019-08-16T13:20:09.313Z,1565961609.313 [Default:CheckIn:Read_GPS] Stopped
2019-08-16T13:20:09.313Z,1565961609.313 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-08-16T13:20:10.483Z,1565961610.483 [NAL9602](ERROR): parseGSV uart error: serial buffer full
2019-08-16T13:20:14.578Z,1565961614.578 [DataOverHttps](INFO): Sending 63 bytes from file Logs/20190816T124149/Courier0019.lzma
2019-08-16T13:20:15.384Z,1565961615.384 [DataOverHttps](INFO): Moved sent file to Logs/20190816T124149/Courier0019.lzma.bak
2019-08-16T13:20:15.384Z,1565961615.384 [DataOverHttps](INFO): SBD MOMSN=11581840
2019-08-16T13:20:26.490Z,1565961626.490 [DataOverHttps](INFO): Sending 195 bytes from file Logs/20190816T124149/Express0020.lzma
2019-08-16T13:20:27.296Z,1565961627.296 [DataOverHttps](INFO): Moved sent file to Logs/20190816T124149/Express0020.lzma.bak
2019-08-16T13:20:27.296Z,1565961627.296 [DataOverHttps](INFO): SBD MOMSN=11581843
2019-08-16T13:20:28.277Z,1565961628.277 [Default:CheckIn:Read_Iridium] Stopped
2019-08-16T13:20:28.278Z,1565961628.278 [Default:CheckIn:C.Wait] Running Loop=1
2019-08-16T13:20:28.278Z,1565961628.278 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-08-16T13:20:41.177Z,1565961641.177 [NAL9602](INFO): Not Powering down - fast GPS
2019-08-16T13:25:28.860Z,1565961928.860 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-08-16T13:25:28.860Z,1565961928.860 [Default:CheckIn:C.Wait] Stopped
2019-08-16T13:25:28.860Z,1565961928.860 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-08-16T13:25:28.860Z,1565961928.860 [Default:CheckIn:D] Running Loop=1
2019-08-16T13:25:29.265Z,1565961929.265 [Default:CheckIn:D] Stopped
2019-08-16T13:25:29.265Z,1565961929.265 [Default:CheckIn:E] Running Loop=1
2019-08-16T13:25:29.674Z,1565961929.674 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 39.067415 min 
2019-08-16T13:25:29.674Z,1565961929.674 [Default:CheckIn:E] Stopped
2019-08-16T13:25:29.674Z,1565961929.674 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-08-16T13:25:29.674Z,1565961929.674 [Default:CheckIn] Stopped
2019-08-16T13:25:29.674Z,1565961929.674 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-08-16T13:25:29.674Z,1565961929.674 [Default:CheckIn](INFO): Running loop #6
2019-08-16T13:25:29.674Z,1565961929.674 [Default:CheckIn] Running Loop=6
2019-08-16T13:25:29.675Z,1565961929.675 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-08-16T13:25:29.675Z,1565961929.675 [Default:CheckIn:Read_GPS] Running Loop=1
2019-08-16T13:25:31.283Z,1565961931.283 [NAL9602](DEBUG): Fix Requested
2019-08-16T13:25:31.668Z,1565961931.668 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,132528.00,A,4149.69729,N,08324.71486,W,0.039,350.39,160819,,,D*7D
2019-08-16T13:25:31.670Z,1565961931.670 [NAL9602](INFO): GPS fix at 20190816T132528: (41.828288, -83.411914)
2019-08-16T13:25:31.717Z,1565961931.717 [Default:CheckIn:Read_GPS] Stopped
2019-08-16T13:25:31.718Z,1565961931.718 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-08-16T13:25:32.883Z,1565961932.883 [NAL9602](ERROR): parseGSV uart error: serial buffer full
2019-08-16T13:25:36.874Z,1565961936.874 [DataOverHttps](INFO): Sending 62 bytes from file Logs/20190816T124149/Courier0022.lzma
2019-08-16T13:25:37.680Z,1565961937.680 [DataOverHttps](INFO): Moved sent file to Logs/20190816T124149/Courier0022.lzma.bak
2019-08-16T13:25:37.680Z,1565961937.680 [DataOverHttps](INFO): SBD MOMSN=11581852
2019-08-16T13:25:46.209Z,1565961946.209 [NAL9602](IMPORTANT): SBD MO Status=0, MOMSN=31150, MT Status=1, MTMSN=2051
2019-08-16T13:25:46.209Z,1565961946.209 [NAL9602](INFO): Data available in MT queue
2019-08-16T13:25:46.695Z,1565961946.695 [NAL9602](INFO): Received command:Restart sys
2019-08-16T13:25:46.783Z,1565961946.783 [CommandLine](IMPORTANT): got command restart system
2019-08-16T13:25:48.923Z,1565961948.923 [Supervisor](INFO): Stop Mission called by Supervisor::terminate
2019-08-16T13:25:48.923Z,1565961948.923 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2019-08-16T13:25:48.923Z,1565961948.923 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-08-16T13:25:49.071Z,1565961949.071 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2019-08-16T13:25:49.071Z,1565961949.071 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-08-16T13:25:49.072Z,1565961949.072 [CommandLine](INFO): Join timeout helper Thread ID is 1112
2019-08-16T13:25:49.072Z,1565961949.072 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2019-08-16T13:25:49.072Z,1565961949.072 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-08-16T13:25:49.073Z,1565961949.073 [NavChartDb](INFO): Join timeout helper Thread ID is 1113
2019-08-16T13:25:49.371Z,1565961949.371 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2019-08-16T13:25:49.371Z,1565961949.371 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-08-16T13:25:49.383Z,1565961949.383 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2019-08-16T13:25:49.383Z,1565961949.383 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-08-16T13:25:49.383Z,1565961949.383 [Radio_Surface](INFO): Join timeout helper Thread ID is 1114
2019-08-16T13:25:49.747Z,1565961949.747 [Radio_Surface](INFO): Powering down
2019-08-16T13:25:49.748Z,1565961949.748 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2019-08-16T13:25:49.748Z,1565961949.748 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-08-16T13:25:49.759Z,1565961949.759 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2019-08-16T13:25:49.759Z,1565961949.759 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2019-08-16T13:25:49.759Z,1565961949.759 [DataOverHttps](INFO): Join timeout helper Thread ID is 1115
2019-08-16T13:25:50.007Z,1565961950.007 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2019-08-16T13:25:50.010Z,1565961950.010 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2019-08-16T13:25:50.011Z,1565961950.011 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2019-08-16T13:25:50.011Z,1565961950.011 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2019-08-16T13:25:50.011Z,1565961950.011 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 1116
2019-08-16T13:25:50.115Z,1565961950.115 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2019-08-16T13:25:50.115Z,1565961950.115 [WetLabsBB2FL](INFO): Powering down
2019-08-16T13:25:50.116Z,1565961950.116 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2019-08-16T13:25:50.134Z,1565961950.134 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2019-08-16T13:25:50.134Z,1565961950.134 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2019-08-16T13:25:50.134Z,1565961950.134 [CTD_Seabird](INFO): Join timeout helper Thread ID is 1117
2019-08-16T13:25:50.675Z,1565961950.675 [CTD_Seabird](INFO): Powering down
2019-08-16T13:25:50.687Z,1565961950.687 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2019-08-16T13:25:50.687Z,1565961950.687 [CTD_Seabird](INFO): Powering down
2019-08-16T13:25:50.699Z,1565961950.699 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2019-08-16T13:25:50.707Z,1565961950.707 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2019-08-16T13:25:50.707Z,1565961950.707 [logger ThreadHandler](INFO): Thread cancelled.
2019-08-16T13:25:50.708Z,1565961950.708 [logger](INFO): Join timeout helper Thread ID is 1118
2019-08-16T13:25:50.759Z,1565961950.759 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2019-08-16T13:25:50.759Z,1565961950.759 [logger ThreadHandler](INFO): Thread cancelled.
2019-08-16T13:25:50.767Z,1565961950.767 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2019-08-16T13:25:50.767Z,1565961950.767 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-08-16T13:25:50.768Z,1565961950.768 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2019-08-16T13:25:50.768Z,1565961950.768 [controlThread ThreadHandler](INFO): Thread cancelled.
2019-08-16T13:25:50.768Z,1565961950.768 [controlThread](INFO): Join timeout helper Thread ID is 1119
2019-08-16T13:25:51.035Z,1565961951.035 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2019-08-16T13:25:51.035Z,1565961951.035 [controlThread](DEBUG): Uninitializing ControlThread
2019-08-16T13:25:51.035Z,1565961951.035 [Aanderaa_O2](INFO): Powering down
2019-08-16T13:25:51.058Z,1565961951.058 [AHRS_M2](INFO): Powering down
2019-08-16T13:25:51.131Z,1565961951.131 [NAL9602](INFO): Powering down
2019-08-16T13:25:51.133Z,1565961951.133 [DAT](INFO): Powering down
2019-08-16T13:25:51.252Z,1565961951.252 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2019-08-16T13:25:51.252Z,1565961951.252 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2019-08-16T13:25:51.253Z,1565961951.253 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2019-08-16T13:25:51.253Z,1565961951.253 [MissionManager](INFO): Uninitializing Mission Default
2019-08-16T13:25:51.254Z,1565961951.254 [Default] Stopped
2019-08-16T13:25:51.254Z,1565961951.254 [Default](DEBUG): Aggregate::uninitialize Default
2019-08-16T13:25:51.254Z,1565961951.254 [Default:B.GoToSurface] Stopped
2019-08-16T13:25:51.254Z,1565961951.254 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2019-08-16T13:25:51.254Z,1565961951.254 [Default:CheckIn] Stopped
2019-08-16T13:25:51.254Z,1565961951.254 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-08-16T13:25:51.254Z,1565961951.254 [Default:CheckIn:Read_Iridium] Stopped
2019-08-16T13:25:51.257Z,1565961951.257 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2019-08-16T13:25:51.257Z,1565961951.257 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2019-08-16T13:25:51.257Z,1565961951.257 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2019-08-16T13:25:51.257Z,1565961951.257 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2019-08-16T13:25:51.258Z,1565961951.258 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2019-08-16T13:25:51.258Z,1565961951.258 [BuoyancyServo](INFO): Powering down
2019-08-16T13:25:51.271Z,1565961951.271 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2019-08-16T13:25:51.271Z,1565961951.271 [ElevatorServo](INFO): Powering down
2019-08-16T13:25:51.272Z,1565961951.272 [MassServo](DEBUG): Uninitialize Mass Servo.
2019-08-16T13:25:51.272Z,1565961951.272 [MassServo](INFO): Powering down
2019-08-16T13:25:51.273Z,1565961951.273 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2019-08-16T13:25:51.273Z,1565961951.273 [RudderServo](INFO): Powering down
2019-08-16T13:25:51.274Z,1565961951.274 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2019-08-16T13:25:51.274Z,1565961951.274 [ThrusterServo](INFO): Powering down
2019-08-16T13:25:51.275Z,1565961951.275 [SBIT](DEBUG): Uninitialize SBIT Component.
2019-08-16T13:25:51.275Z,1565961951.275 [IBIT](DEBUG): Uninitialize IBIT Component.
2019-08-16T13:25:51.276Z,1565961951.276 [CBIT](DEBUG): Uninitialize CBIT Component.
2019-08-16T13:25:51.276Z,1565961951.276 [CBIT](DEBUG): Powering off loads.
2019-08-16T13:25:51.286Z,1565961951.286 [CBIT](DEBUG): Disabling WDT.
2019-08-16T13:25:51.298Z,1565961951.298 [CBIT](DEBUG): Opening all GF detection circuits.
2019-08-16T13:25:51.299Z,1565961951.299 [controlThread ThreadHandler](INFO): Thread cancelled.
2019-08-16T13:25:51.339Z,1565961951.339 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2019-08-16T13:25:51.344Z,1565961951.344 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2019-08-16T13:25:51.411Z,1565961951.411 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-08-16T13:25:51.416Z,1565961951.416 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2019-08-16T13:25:51.465Z,1565961951.465 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-08-16T13:25:51.529Z,1565961951.529 [logger ThreadHandler](INFO): Thread cancelled.