2020-08-26T15:18:27.008Z,1598455107.008 [Supervisor](DEBUG): Initializing supervisor. 2020-08-26T15:18:27.011Z,1598455107.011 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2020-08-26T15:18:27.011Z,1598455107.011 [SyncHandler](INFO): Protected caller Thread ID is 2081 2020-08-26T15:18:27.012Z,1598455107.012 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2020-08-26T15:18:27.013Z,1598455107.013 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2020-08-26T15:18:27.013Z,1598455107.013 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 2082 2020-08-26T15:18:27.016Z,1598455107.016 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2020-08-26T15:18:27.029Z,1598455107.029 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2020-08-26T15:18:27.030Z,1598455107.030 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2020-08-26T15:18:27.030Z,1598455107.030 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 2083 2020-08-26T15:18:27.031Z,1598455107.031 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2020-08-26T15:18:27.032Z,1598455107.032 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2020-08-26T15:18:27.032Z,1598455107.032 [logger ThreadHandler](INFO): Protected caller Thread ID is 2084 2020-08-26T15:18:27.034Z,1598455107.034 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2020-08-26T15:18:27.034Z,1598455107.034 [Supervisor](INFO): Looking for Config files in directory: Config/ 2020-08-26T15:18:27.036Z,1598455107.036 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2020-08-26T15:18:27.129Z,1598455107.129 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2020-08-26T15:18:27.130Z,1598455107.130 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2020-08-26T15:18:27.729Z,1598455107.729 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2020-08-26T15:18:27.729Z,1598455107.729 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2020-08-26T15:18:27.921Z,1598455107.921 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2020-08-26T15:18:27.921Z,1598455107.921 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2020-08-26T15:18:28.020Z,1598455108.020 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample 2020-08-26T15:18:28.020Z,1598455108.020 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2020-08-26T15:18:28.120Z,1598455108.120 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2020-08-26T15:18:28.121Z,1598455108.121 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2020-08-26T15:18:28.200Z,1598455108.200 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2020-08-26T15:18:28.336Z,1598455108.336 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2020-08-26T15:18:28.336Z,1598455108.336 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2020-08-26T15:18:28.627Z,1598455108.627 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2020-08-26T15:18:28.627Z,1598455108.627 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2020-08-26T15:18:29.081Z,1598455109.081 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2020-08-26T15:18:29.082Z,1598455109.082 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2020-08-26T15:18:29.225Z,1598455109.225 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2020-08-26T15:18:29.226Z,1598455109.226 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2020-08-26T15:18:29.420Z,1598455109.420 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2020-08-26T15:18:29.420Z,1598455109.420 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2020-08-26T15:18:29.922Z,1598455109.922 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2020-08-26T15:18:29.923Z,1598455109.923 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2020-08-26T15:18:30.178Z,1598455110.178 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2020-08-26T15:18:30.179Z,1598455110.179 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2020-08-26T15:18:30.381Z,1598455110.381 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2020-08-26T15:18:30.382Z,1598455110.382 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2020-08-26T15:18:30.789Z,1598455110.789 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2020-08-26T15:18:30.790Z,1598455110.790 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2020-08-26T15:18:31.122Z,1598455111.122 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2020-08-26T15:18:31.124Z,1598455111.124 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-pontus/ 2020-08-26T15:18:31.125Z,1598455111.125 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/secure.cfg 2020-08-26T15:18:31.206Z,1598455111.206 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Sensor.cfg 2020-08-26T15:18:31.364Z,1598455111.364 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Servo.cfg 2020-08-26T15:18:31.471Z,1598455111.471 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Simulator.cfg 2020-08-26T15:18:31.554Z,1598455111.554 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/logger.cfg 2020-08-26T15:18:31.647Z,1598455111.647 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/vehicle.cfg 2020-08-26T15:18:31.876Z,1598455111.876 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Battery.cfg 2020-08-26T15:18:32.222Z,1598455112.222 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2020-08-26T15:18:32.223Z,1598455112.223 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Navigation.cfg 2020-08-26T15:18:32.401Z,1598455112.401 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/BIT.cfg 2020-08-26T15:18:32.575Z,1598455112.575 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Science.cfg 2020-08-26T15:18:32.949Z,1598455112.949 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Control.cfg 2020-08-26T15:18:33.050Z,1598455113.050 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-pontus/root/ 2020-08-26T15:18:33.050Z,1598455113.050 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg 2020-08-26T15:18:33.063Z,1598455113.063 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2020-08-26T15:18:33.138Z,1598455113.138 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2020-08-26T15:18:33.139Z,1598455113.139 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2020-08-26T15:18:33.184Z,1598455113.184 [VerticalControl](DEBUG): Construct VerticalControl. 2020-08-26T15:18:33.296Z,1598455113.296 [VerticalControl] Loaded 2020-08-26T15:18:33.296Z,1598455113.296 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2020-08-26T15:18:33.297Z,1598455113.297 [HorizontalControl](DEBUG): Construct HorizontalControl. 2020-08-26T15:18:33.376Z,1598455113.376 [HorizontalControl] Loaded 2020-08-26T15:18:33.376Z,1598455113.376 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2020-08-26T15:18:33.377Z,1598455113.377 [SpeedControl](DEBUG): Construct SpeedControl. 2020-08-26T15:18:33.382Z,1598455113.382 [SpeedControl] Loaded 2020-08-26T15:18:33.382Z,1598455113.382 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2020-08-26T15:18:33.383Z,1598455113.383 [LoopControl](DEBUG): Construct LoopControl. 2020-08-26T15:18:33.384Z,1598455113.384 [LoopControl] Loaded 2020-08-26T15:18:33.384Z,1598455113.384 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2020-08-26T15:18:33.384Z,1598455113.384 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2020-08-26T15:18:33.385Z,1598455113.385 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2020-08-26T15:18:33.425Z,1598455113.425 [DepthRateCalculator] Loaded 2020-08-26T15:18:33.426Z,1598455113.426 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2020-08-26T15:18:33.431Z,1598455113.431 [PitchRateCalculator] Loaded 2020-08-26T15:18:33.431Z,1598455113.431 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2020-08-26T15:18:33.446Z,1598455113.446 [SpeedCalculator] Loaded 2020-08-26T15:18:33.447Z,1598455113.447 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2020-08-26T15:18:33.468Z,1598455113.468 [TempGradientCalculator] Loaded 2020-08-26T15:18:33.468Z,1598455113.468 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread. 2020-08-26T15:18:33.473Z,1598455113.473 [YawRateCalculator] Loaded 2020-08-26T15:18:33.473Z,1598455113.473 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2020-08-26T15:18:33.502Z,1598455113.502 [ElevatorOffsetCalculator] Loaded 2020-08-26T15:18:33.502Z,1598455113.502 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2020-08-26T15:18:33.503Z,1598455113.503 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2020-08-26T15:18:33.503Z,1598455113.503 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2020-08-26T15:18:33.530Z,1598455113.530 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2020-08-26T15:18:33.531Z,1598455113.531 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2020-08-26T15:18:33.613Z,1598455113.613 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2020-08-26T15:18:33.613Z,1598455113.613 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2020-08-26T15:18:33.896Z,1598455113.896 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2020-08-26T15:18:33.897Z,1598455113.897 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2020-08-26T15:18:33.994Z,1598455113.994 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2020-08-26T15:18:33.995Z,1598455113.995 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2020-08-26T15:18:34.300Z,1598455114.300 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_orientation 2020-08-26T15:18:34.305Z,1598455114.305 [AHRS_M2](INFO): created writer for : platform_orientation 2020-08-26T15:18:34.307Z,1598455114.307 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_magnetic_orientation 2020-08-26T15:18:34.312Z,1598455114.312 [AHRS_M2](INFO): created writer for : platform_magnetic_orientation 2020-08-26T15:18:34.313Z,1598455114.313 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_pitch_angle 2020-08-26T15:18:34.318Z,1598455114.318 [AHRS_M2](INFO): created writer for : platform_pitch_angle 2020-08-26T15:18:34.318Z,1598455114.318 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_roll_angle 2020-08-26T15:18:34.324Z,1598455114.324 [AHRS_M2](INFO): created writer for : platform_roll_angle 2020-08-26T15:18:34.394Z,1598455114.394 [AHRS_M2] Loaded 2020-08-26T15:18:34.394Z,1598455114.394 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2020-08-26T15:18:34.471Z,1598455114.471 [DataOverHttps] Loaded 2020-08-26T15:18:34.471Z,1598455114.471 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2020-08-26T15:18:34.473Z,1598455114.473 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 4090D4E0 2020-08-26T15:18:34.473Z,1598455114.473 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 2167 2020-08-26T15:18:34.503Z,1598455114.503 [Depth_Keller] Loaded 2020-08-26T15:18:34.503Z,1598455114.503 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2020-08-26T15:18:34.617Z,1598455114.617 [NAL9602] Loaded 2020-08-26T15:18:34.617Z,1598455114.617 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2020-08-26T15:18:34.666Z,1598455114.666 [Onboard] Loaded 2020-08-26T15:18:34.666Z,1598455114.666 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2020-08-26T15:18:34.667Z,1598455114.667 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 4093D4E0 2020-08-26T15:18:34.668Z,1598455114.668 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 2168 2020-08-26T15:18:34.687Z,1598455114.687 [Radio_Surface] Loaded 2020-08-26T15:18:34.687Z,1598455114.687 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2020-08-26T15:18:34.688Z,1598455114.688 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 4096D4E0 2020-08-26T15:18:34.688Z,1598455114.688 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 2169 2020-08-26T15:18:34.839Z,1598455114.839 [DAT] Loaded 2020-08-26T15:18:34.839Z,1598455114.839 [ComponentRegistry](DEBUG): SyncComponent "DAT" handled in the control thread. 2020-08-26T15:18:36.322Z,1598455116.322 [BPC1] Loaded 2020-08-26T15:18:36.323Z,1598455116.323 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2020-08-26T15:18:36.355Z,1598455116.355 [AMEcho] Loaded 2020-08-26T15:18:36.355Z,1598455116.355 [ComponentRegistry](DEBUG): SyncComponent "AMEcho" handled in the control thread. 2020-08-26T15:18:36.355Z,1598455116.355 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2020-08-26T15:18:36.356Z,1598455116.356 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2020-08-26T15:18:36.473Z,1598455116.473 [DeadReckonUsingMultipleVelocitySources] Loaded 2020-08-26T15:18:36.473Z,1598455116.473 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2020-08-26T15:18:36.493Z,1598455116.493 [NavChart] Loaded 2020-08-26T15:18:36.494Z,1598455116.494 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2020-08-26T15:18:36.498Z,1598455116.498 [UniversalFixResidualReporter] Loaded 2020-08-26T15:18:36.498Z,1598455116.498 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2020-08-26T15:18:36.498Z,1598455116.498 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2020-08-26T15:18:36.499Z,1598455116.499 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2020-08-26T15:18:36.630Z,1598455116.630 [SBIT](DEBUG): Construct Startup Built In Test. 2020-08-26T15:18:36.641Z,1598455116.641 [SBIT] Loaded 2020-08-26T15:18:36.642Z,1598455116.642 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2020-08-26T15:18:36.642Z,1598455116.642 [IBIT](DEBUG): Construct Initiated Built In Test. 2020-08-26T15:18:36.655Z,1598455116.655 [IBIT] Loaded 2020-08-26T15:18:36.656Z,1598455116.656 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2020-08-26T15:18:36.659Z,1598455116.659 [CBIT](DEBUG): Construct Continuous Built In Test. 2020-08-26T15:18:36.797Z,1598455116.797 [CBIT] Loaded 2020-08-26T15:18:36.797Z,1598455116.797 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2020-08-26T15:18:36.797Z,1598455116.797 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2020-08-26T15:18:36.798Z,1598455116.798 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2020-08-26T15:18:36.917Z,1598455116.917 [BuoyancyServo] Loaded 2020-08-26T15:18:36.917Z,1598455116.917 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2020-08-26T15:18:37.021Z,1598455117.021 [ElevatorServo] Loaded 2020-08-26T15:18:37.021Z,1598455117.021 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2020-08-26T15:18:37.049Z,1598455117.049 [MassServo] Loaded 2020-08-26T15:18:37.050Z,1598455117.050 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2020-08-26T15:18:37.077Z,1598455117.077 [RudderServo] Loaded 2020-08-26T15:18:37.077Z,1598455117.077 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2020-08-26T15:18:37.107Z,1598455117.107 [ThrusterServo] Loaded 2020-08-26T15:18:37.107Z,1598455117.107 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread. 2020-08-26T15:18:37.108Z,1598455117.108 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2020-08-26T15:18:37.108Z,1598455117.108 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2020-08-26T15:18:37.126Z,1598455117.126 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2020-08-26T15:18:37.127Z,1598455117.127 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2020-08-26T15:18:37.362Z,1598455117.362 [BackSeatDriver] Loaded 2020-08-26T15:18:37.363Z,1598455117.363 [ComponentRegistry](DEBUG): Component "BackSeatDriver" handled in its own thread. 2020-08-26T15:18:37.364Z,1598455117.364 [BackSeatDriver ThreadHandler](DEBUG): Created PCaller Thread at 40B034E0 2020-08-26T15:18:37.364Z,1598455117.364 [BackSeatDriver ThreadHandler](INFO): Protected caller Thread ID is 2170 2020-08-26T15:18:37.393Z,1598455117.393 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_density 2020-08-26T15:18:37.398Z,1598455117.398 [CTD_Seabird](INFO): created writer for : sea_water_density 2020-08-26T15:18:37.399Z,1598455117.399 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): depth 2020-08-26T15:18:37.404Z,1598455117.404 [CTD_Seabird](INFO): created writer for : depth 2020-08-26T15:18:37.404Z,1598455117.404 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_pressure 2020-08-26T15:18:37.410Z,1598455117.410 [CTD_Seabird](INFO): created writer for : sea_water_pressure 2020-08-26T15:18:37.411Z,1598455117.411 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_salinity 2020-08-26T15:18:37.416Z,1598455117.416 [CTD_Seabird](INFO): created writer for : sea_water_salinity 2020-08-26T15:18:37.416Z,1598455117.416 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_temperature 2020-08-26T15:18:37.421Z,1598455117.421 [CTD_Seabird](INFO): created writer for : sea_water_temperature 2020-08-26T15:18:37.422Z,1598455117.422 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_electrical_conductivity 2020-08-26T15:18:37.428Z,1598455117.428 [CTD_Seabird](INFO): created writer for : sea_water_electrical_conductivity 2020-08-26T15:18:37.428Z,1598455117.428 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): speed_of_sound_in_sea_water 2020-08-26T15:18:37.433Z,1598455117.433 [CTD_Seabird](INFO): created writer for : speed_of_sound_in_sea_water 2020-08-26T15:18:37.461Z,1598455117.461 [CTD_Seabird] Loaded 2020-08-26T15:18:37.461Z,1598455117.461 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2020-08-26T15:18:37.463Z,1598455117.463 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40B334E0 2020-08-26T15:18:37.463Z,1598455117.463 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 2171 2020-08-26T15:18:37.485Z,1598455117.485 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.Output470 2020-08-26T15:18:37.485Z,1598455117.485 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: Output470 2020-08-26T15:18:37.489Z,1598455117.489 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.Output650 2020-08-26T15:18:37.489Z,1598455117.489 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: Output650 2020-08-26T15:18:37.494Z,1598455117.494 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.OutputChl 2020-08-26T15:18:37.494Z,1598455117.494 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: OutputChl 2020-08-26T15:18:37.498Z,1598455117.498 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.VolumeScatCoeff117deg470nm 2020-08-26T15:18:37.498Z,1598455117.498 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: VolumeScatCoeff117deg470nm 2020-08-26T15:18:37.502Z,1598455117.502 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.VolumeScatCoeff117deg650nm 2020-08-26T15:18:37.502Z,1598455117.502 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: VolumeScatCoeff117deg650nm 2020-08-26T15:18:37.507Z,1598455117.507 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.BackscatteringCoeff470nm 2020-08-26T15:18:37.507Z,1598455117.507 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: BackscatteringCoeff470nm 2020-08-26T15:18:37.511Z,1598455117.511 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.BackscatteringCoeff650nm 2020-08-26T15:18:37.511Z,1598455117.511 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: BackscatteringCoeff650nm 2020-08-26T15:18:37.516Z,1598455117.516 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): mass_concentration_of_chlorophyll_in_sea_water 2020-08-26T15:18:37.520Z,1598455117.520 [WetLabsBB2FL](INFO): created writer for : mass_concentration_of_chlorophyll_in_sea_water 2020-08-26T15:18:37.521Z,1598455117.521 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_median_mass_concentration_of_chlorophyll_in_sea_water 2020-08-26T15:18:37.521Z,1598455117.521 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_median_mass_concentration_of_chlorophyll_in_sea_water 2020-08-26T15:18:37.525Z,1598455117.525 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_mean_mass_concentration_of_chlorophyll_in_sea_water 2020-08-26T15:18:37.525Z,1598455117.525 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_mean_mass_concentration_of_chlorophyll_in_sea_water 2020-08-26T15:18:37.529Z,1598455117.529 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(DAtaURI): WetLabsBB2FL.bin_variance_mass_concentration_of_chlorophyll_in_sea_water 2020-08-26T15:18:37.529Z,1598455117.529 [WetLabsBB2FL](DEBUG): LcmSlateWriter::add(): dataName: bin_variance_mass_concentration_of_chlorophyll_in_sea_water 2020-08-26T15:18:37.533Z,1598455117.533 [WetLabsBB2FL] Loaded 2020-08-26T15:18:37.534Z,1598455117.534 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2020-08-26T15:18:37.535Z,1598455117.535 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40B634E0 2020-08-26T15:18:37.535Z,1598455117.535 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 2172 2020-08-26T15:18:37.536Z,1598455117.536 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2020-08-26T15:18:37.540Z,1598455117.540 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2020-08-26T15:18:37.540Z,1598455117.540 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2020-08-26T15:18:37.547Z,1598455117.547 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2020-08-26T15:18:37.548Z,1598455117.548 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40B934E0 2020-08-26T15:18:37.548Z,1598455117.548 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 2173 2020-08-26T15:18:37.553Z,1598455117.553 [Supervisor](INFO): Main Thread ID is 2080 2020-08-26T15:18:37.553Z,1598455117.553 [Supervisor](DEBUG): Running supervisor. 2020-08-26T15:18:37.554Z,1598455117.554 [CommandLine ThreadHandler](INFO): Handler Thread ID is 2174 2020-08-26T15:18:37.556Z,1598455117.556 [controlThread ThreadHandler](INFO): Handler Thread ID is 2175 2020-08-26T15:18:37.557Z,1598455117.557 [controlThread](DEBUG): Initializing ControlThread 2020-08-26T15:18:37.557Z,1598455117.557 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2020-08-26T15:18:37.559Z,1598455117.559 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2020-08-26T15:18:37.560Z,1598455117.560 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2020-08-26T15:18:37.560Z,1598455117.560 [LoopControl](DEBUG): Initialize LoopControlComponent. 2020-08-26T15:18:37.561Z,1598455117.561 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2020-08-26T15:18:37.561Z,1598455117.561 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2020-08-26T15:18:37.561Z,1598455117.561 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2020-08-26T15:18:37.562Z,1598455117.562 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator. 2020-08-26T15:18:37.562Z,1598455117.562 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2020-08-26T15:18:37.563Z,1598455117.563 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2020-08-26T15:18:37.568Z,1598455117.568 [NavChart](DEBUG): Initialize NavChart Navigation. 2020-08-26T15:18:37.568Z,1598455117.568 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2020-08-26T15:18:37.568Z,1598455117.568 [SBIT](INFO): Initialize SBIT Component. 2020-08-26T15:18:37.569Z,1598455117.569 [SBIT](IMPORTANT): git: 2020-08-18a-30-g8cc0a1c87 2020-08-26T15:18:37.569Z,1598455117.569 [SBIT](INFO): git hash: 8cc0a1c87b994ada9a621eded1d43a5b5e56617e 2020-08-26T15:18:37.569Z,1598455117.569 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2020-08-26T15:18:37.571Z,1598455117.571 [SBIT](INFO): Kernel Reporting Different Version From Configuration. Kernel Expected: #1 PREEMPT Thu Feb 21 11:17:40 PST 2019 Kernel Reported: #1 PREEMPT Thu Aug 6 12:04:53 PDT 2020 2020-08-26T15:18:37.572Z,1598455117.572 [SBIT](INFO): Beginning SBIT in 65.000000 seconds. 2020-08-26T15:18:37.572Z,1598455117.572 [IBIT](INFO): Initialize IBIT Component. 2020-08-26T15:18:37.573Z,1598455117.573 [CBIT](DEBUG): Initialize CBIT Component. 2020-08-26T15:18:37.574Z,1598455117.574 [logger ThreadHandler](INFO): Handler Thread ID is 2176 2020-08-26T15:18:37.586Z,1598455117.586 [CBIT](DEBUG): Initialized mux pins. 2020-08-26T15:18:37.586Z,1598455117.586 [CBIT](DEBUG): Initializing the watchdog timer. 2020-08-26T15:18:37.595Z,1598455117.595 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 2177 2020-08-26T15:18:37.596Z,1598455117.596 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2020-08-26T15:18:37.607Z,1598455117.607 [Onboard ThreadHandler](INFO): Handler Thread ID is 2178 2020-08-26T15:18:37.611Z,1598455117.611 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2020-08-26T15:18:37.611Z,1598455117.611 [CBIT](DEBUG): Initializing heartbeat. 2020-08-26T15:18:37.637Z,1598455117.637 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 2179 2020-08-26T15:18:37.647Z,1598455117.647 [BackSeatDriver ThreadHandler](INFO): Handler Thread ID is 2180 2020-08-26T15:18:37.667Z,1598455117.667 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 2181 2020-08-26T15:18:37.667Z,1598455117.667 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2020-08-26T15:18:37.672Z,1598455117.672 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 2183 2020-08-26T15:18:37.673Z,1598455117.673 [WetLabsBB2FL](INFO): Powering down 2020-08-26T15:18:37.683Z,1598455117.683 [CBIT](DEBUG): Deactivating GF circuits. 2020-08-26T15:18:37.683Z,1598455117.683 [CBIT](DEBUG): Deactivating emergency mode. 2020-08-26T15:18:37.699Z,1598455117.699 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 2184 2020-08-26T15:18:37.702Z,1598455117.702 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2020-08-26T15:18:37.702Z,1598455117.702 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2020-08-26T15:18:37.702Z,1598455117.702 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2020-08-26T15:18:37.703Z,1598455117.703 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2020-08-26T15:18:37.703Z,1598455117.703 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2020-08-26T15:18:37.703Z,1598455117.703 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2020-08-26T15:18:37.703Z,1598455117.703 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000 2020-08-26T15:18:37.703Z,1598455117.703 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000 2020-08-26T15:18:37.703Z,1598455117.703 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2020-08-26T15:18:37.704Z,1598455117.704 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2020-08-26T15:18:37.704Z,1598455117.704 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000 2020-08-26T15:18:37.704Z,1598455117.704 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000 2020-08-26T15:18:37.704Z,1598455117.704 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000 2020-08-26T15:18:37.704Z,1598455117.704 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000 2020-08-26T15:18:37.704Z,1598455117.704 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000 2020-08-26T15:18:37.705Z,1598455117.705 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000 2020-08-26T15:18:37.718Z,1598455117.718 [CBIT](DEBUG): Backplane powered. 2020-08-26T15:18:37.720Z,1598455117.720 [MissionManager](INFO): Loading Mission: Missions/Startup.xml 2020-08-26T15:18:37.730Z,1598455117.730 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2020-08-26T15:18:37.750Z,1598455117.750 [MissionManager](DEBUG): 2020-08-26T15:18:37.770Z,1598455117.770 [MissionManager](INFO): Loading Mission: Missions/Default.xml 2020-08-26T15:18:37.844Z,1598455117.844 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2020-08-26T15:18:37.845Z,1598455117.845 [Default:A.Wait](DEBUG): Construct Wait. 2020-08-26T15:18:37.847Z,1598455117.847 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2020-08-26T15:18:37.862Z,1598455117.862 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2020-08-26T15:18:37.895Z,1598455117.895 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2020-08-26T15:18:37.924Z,1598455117.924 [Default:E.Execute](DEBUG): Construct Execute. 2020-08-26T15:18:37.928Z,1598455117.928 [MissionManager](DEBUG): 0 Wait a moment to see if the scheduler starts a new mission before starting to actually run Default. 13 Burn on Dropped weight due to communications timeout. 5 Default mission has been running for Restarting logs and Default mission. restart logs 2020-08-26T15:18:37.932Z,1598455117.932 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,Depth_Keller,NAL9602,DAT,BPC1,AMEcho,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, 2020-08-26T15:18:37.950Z,1598455117.950 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2020-08-26T15:18:37.985Z,1598455117.985 [Depth_Keller](ERROR): Pressure reading out of range: 1650.297119 decibar 2020-08-26T15:18:38.004Z,1598455118.004 [DAT](INFO): Powered 24V power converter LCB with command: ! echo 1 > /dev/loadB2 2020-08-26T15:18:38.004Z,1598455118.004 [DAT](INFO): Powering up 2020-08-26T15:18:38.004Z,1598455118.004 [DAT](DEBUG): Initializing DAT. 2020-08-26T15:18:38.039Z,1598455118.039 [Radio_Surface](INFO): Powering up 2020-08-26T15:18:38.059Z,1598455118.059 [CommandLine](IMPORTANT): got command ! echo 1 > /dev/loadB2 2020-08-26T15:18:38.071Z,1598455118.071 [AMEcho](INFO): Powering up 2020-08-26T15:18:38.091Z,1598455118.091 [DepthRateCalculator](ERROR): Depth measurement is not active 2020-08-26T15:18:38.133Z,1598455118.133 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2020-08-26T15:18:38.143Z,1598455118.143 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2020-08-26T15:18:38.144Z,1598455118.144 [ElevatorServo](DEBUG): Initializing EZServoServo. 2020-08-26T15:18:38.155Z,1598455118.155 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2020-08-26T15:18:38.156Z,1598455118.156 [MassServo](DEBUG): Initializing EZServoServo. 2020-08-26T15:18:38.167Z,1598455118.167 [MassServo](DEBUG): Initializing MassServo. 2020-08-26T15:18:38.168Z,1598455118.168 [RudderServo](DEBUG): Initializing EZServoServo. 2020-08-26T15:18:38.179Z,1598455118.179 [RudderServo](DEBUG): Initializing RudderServo. 2020-08-26T15:18:38.180Z,1598455118.180 [ThrusterServo](DEBUG): Initializing EZServoServo. 2020-08-26T15:18:38.195Z,1598455118.195 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2020-08-26T15:18:38.639Z,1598455118.639 [AMEcho](INFO): Powering down 2020-08-26T15:18:39.094Z,1598455119.094 [RudderServo](ERROR): Rudder initialization uart error serial timeout 2020-08-26T15:18:39.095Z,1598455119.095 [RudderServo](FAULT): Rudder failed to initialize 2020-08-26T15:18:39.095Z,1598455119.095 [RudderServo] Communications Fault, FailCount= 1 2020-08-26T15:18:39.095Z,1598455119.095 [RudderServo](ERROR): Communications Fault 2020-08-26T15:18:39.206Z,1598455119.206 [CBIT](ERROR): Communications Fault in component: RudderServo 2020-08-26T15:18:39.355Z,1598455119.355 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2020-08-26T15:18:39.356Z,1598455119.356 [RudderServo](INFO): Powering down 2020-08-26T15:18:40.034Z,1598455120.034 [RudderServo](DEBUG): Initializing EZServoServo. 2020-08-26T15:18:40.155Z,1598455120.155 [RudderServo](DEBUG): Initializing RudderServo. 2020-08-26T15:18:40.159Z,1598455120.159 [CBIT](INFO): Clearing failed state for component RudderServo 2020-08-26T15:18:40.159Z,1598455120.159 [RudderServo] No Fault, FailCount= 1 2020-08-26T15:18:48.512Z,1598455128.512 [DAT](INFO): DAT read: 2020-08-26T15:18:48.514Z,1598455128.514 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series 2020-08-26T15:18:49.724Z,1598455129.724 [DAT](INFO): DAT read: MF Frequency Band 2020-08-26T15:18:49.725Z,1598455129.725 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.12.21 2020-08-26T15:18:49.726Z,1598455129.726 [DAT](INFO): DAT read: Aug 26 2020 15:18:26 2020-08-26T15:18:50.532Z,1598455130.532 [DAT](INFO): DAT read: Features enabled [Bearing] 2020-08-26T15:18:50.534Z,1598455130.534 [DAT](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP 2020-08-26T15:18:50.534Z,1598455130.534 [DAT](INFO): commRate: 800 2020-08-26T15:18:50.535Z,1598455130.535 [DAT](INFO): commRate: 800 2020-08-26T15:18:50.853Z,1598455130.853 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004933 2020-08-26T15:18:50.932Z,1598455130.932 [CommandLine](IMPORTANT): got command report touch Onboard.Humidity 2020-08-26T15:18:50.952Z,1598455130.952 [DAT](INFO): entering command mode 2020-08-26T15:18:51.340Z,1598455131.340 [DAT](DEBUG): checking for command mode acknowledgment 2020-08-26T15:18:51.744Z,1598455131.744 [DAT](INFO): DAT read: 2020-08-26T15:18:51.744Z,1598455131.744 [DAT](DEBUG): checking for command mode acknowledgment 2020-08-26T15:18:52.148Z,1598455132.148 [DAT](DEBUG): checking for command mode acknowledgment 2020-08-26T15:18:52.552Z,1598455132.552 [DAT](DEBUG): checking for command mode acknowledgment 2020-08-26T15:18:52.626Z,1598455132.626 [Reporter](INFO): Onboard.Humidity 26.242218 % 2020-08-26T15:18:52.956Z,1598455132.956 [DAT](DEBUG): checking for command mode acknowledgment 2020-08-26T15:18:53.360Z,1598455133.360 [DAT](DEBUG): checking for command mode acknowledgment 2020-08-26T15:18:53.764Z,1598455133.764 [DAT](DEBUG): checking for command mode acknowledgment 2020-08-26T15:18:54.168Z,1598455134.168 [DAT](DEBUG): checking for command mode acknowledgment 2020-08-26T15:18:54.572Z,1598455134.572 [DAT](DEBUG): checking for command mode acknowledgment 2020-08-26T15:18:54.976Z,1598455134.976 [DAT](DEBUG): checking for command mode acknowledgment 2020-08-26T15:18:55.390Z,1598455135.390 [DAT](DEBUG): checking for command mode acknowledgment 2020-08-26T15:18:55.784Z,1598455135.784 [DAT](DEBUG): checking for command mode acknowledgment 2020-08-26T15:18:56.188Z,1598455136.188 [DAT](DEBUG): checking for command mode acknowledgment 2020-08-26T15:18:56.592Z,1598455136.592 [DAT](DEBUG): checking for command mode acknowledgment 2020-08-26T15:18:56.996Z,1598455136.996 [DAT](DEBUG): checking for command mode acknowledgment 2020-08-26T15:18:57.400Z,1598455137.400 [DAT](DEBUG): checking for command mode acknowledgment 2020-08-26T15:18:57.804Z,1598455137.804 [DAT](DEBUG): checking for command mode acknowledgment 2020-08-26T15:18:58.208Z,1598455138.208 [DAT](DEBUG): checking for command mode acknowledgment 2020-08-26T15:18:58.612Z,1598455138.612 [DAT](DEBUG): checking for command mode acknowledgment 2020-08-26T15:18:59.016Z,1598455139.016 [DAT](DEBUG): checking for command mode acknowledgment 2020-08-26T15:18:59.420Z,1598455139.420 [DAT](DEBUG): checking for command mode acknowledgment 2020-08-26T15:18:59.824Z,1598455139.824 [DAT](DEBUG): checking for command mode acknowledgment 2020-08-26T15:19:00.228Z,1598455140.228 [DAT](DEBUG): checking for command mode acknowledgment 2020-08-26T15:19:00.632Z,1598455140.632 [DAT](DEBUG): checking for command mode acknowledgment 2020-08-26T15:19:01.036Z,1598455141.036 [DAT](DEBUG): checking for command mode acknowledgment 2020-08-26T15:19:01.440Z,1598455141.440 [DAT](DEBUG): checking for command mode acknowledgment 2020-08-26T15:19:01.844Z,1598455141.844 [DAT](DEBUG): checking for command mode acknowledgment 2020-08-26T15:19:02.248Z,1598455142.248 [DAT](DEBUG): checking for command mode acknowledgment 2020-08-26T15:19:02.652Z,1598455142.652 [DAT](DEBUG): checking for command mode acknowledgment 2020-08-26T15:19:02.747Z,1598455142.747 [Reporter](INFO): Onboard.Humidity 26.217800 % 2020-08-26T15:19:03.064Z,1598455143.064 [DAT](DEBUG): checking for command mode acknowledgment 2020-08-26T15:19:03.460Z,1598455143.460 [DAT](DEBUG): checking for command mode acknowledgment 2020-08-26T15:19:03.867Z,1598455143.867 [DAT](DEBUG): checking for command mode acknowledgment 2020-08-26T15:19:04.272Z,1598455144.272 [DAT](DEBUG): checking for command mode acknowledgment 2020-08-26T15:19:04.677Z,1598455144.677 [NAL9602](INFO): Powering up NAL9602 2020-08-26T15:19:04.679Z,1598455144.679 [DAT](DEBUG): checking for command mode acknowledgment 2020-08-26T15:19:05.076Z,1598455145.076 [DAT](DEBUG): checking for command mode acknowledgment 2020-08-26T15:19:05.480Z,1598455145.480 [DAT](DEBUG): checking for command mode acknowledgment 2020-08-26T15:19:05.888Z,1598455145.888 [DAT](DEBUG): checking for command mode acknowledgment 2020-08-26T15:19:06.289Z,1598455146.289 [DAT](DEBUG): checking for command mode acknowledgment 2020-08-26T15:19:06.289Z,1598455146.289 [DAT](FAULT): failed to enter command mode 2020-08-26T15:19:06.692Z,1598455146.692 [DAT](INFO): entering command mode 2020-08-26T15:19:07.096Z,1598455147.096 [DAT](INFO): DAT read: user:1> 2020-08-26T15:19:07.097Z,1598455147.097 [DAT](INFO): DAT read: Command '+++' not found 2020-08-26T15:19:07.097Z,1598455147.097 [DAT](INFO): DAT read: Error 2020-08-26T15:19:07.098Z,1598455147.098 [DAT](INFO): setting verbose to 3 2020-08-26T15:19:07.505Z,1598455147.505 [DAT](INFO): DAT read: user:2> 2020-08-26T15:19:07.506Z,1598455147.506 [DAT](INFO): DAT read: Verbose | 3 2020-08-26T15:19:07.506Z,1598455147.506 [DAT](INFO): set verbose to 3 2020-08-26T15:19:07.507Z,1598455147.507 [DAT](INFO): setting DatVerbose to 27440 2020-08-26T15:19:07.904Z,1598455147.904 [DAT](INFO): DAT read: user:3> 2020-08-26T15:19:07.905Z,1598455147.905 [DAT](INFO): DAT read: DatVerbose | 27440 2020-08-26T15:19:07.905Z,1598455147.905 [DAT](INFO): set DatVerbose to 27440 2020-08-26T15:19:07.906Z,1598455147.906 [DAT](INFO): setting transmit power to 8 2020-08-26T15:19:08.308Z,1598455148.308 [DAT](INFO): DAT read: user:4> 2020-08-26T15:19:08.309Z,1598455148.309 [DAT](INFO): DAT read: TxPower | 8 (Max) 2020-08-26T15:19:08.309Z,1598455148.309 [DAT](INFO): set transmit power to 8 2020-08-26T15:19:08.310Z,1598455148.310 [DAT](INFO): setting local address to 9 2020-08-26T15:19:08.713Z,1598455148.713 [DAT](INFO): DAT read: user:5> 2020-08-26T15:19:08.714Z,1598455148.714 [DAT](INFO): DAT read: LocalAddr | 9 2020-08-26T15:19:08.715Z,1598455148.715 [DAT](INFO): set local address to 9 2020-08-26T15:19:12.811Z,1598455152.811 [Reporter](INFO): Onboard.Humidity 26.181177 % 2020-08-26T15:19:15.580Z,1598455155.580 [NAL9602](INFO): NAL9602 initialized 2020-08-26T15:19:22.908Z,1598455162.908 [Reporter](INFO): Onboard.Humidity 26.144548 % 2020-08-26T15:19:33.008Z,1598455173.008 [Reporter](INFO): Onboard.Humidity 26.132339 % 2020-08-26T15:19:42.732Z,1598455182.732 [Reporter](INFO): Onboard.Humidity 26.083506 % 2020-08-26T15:19:43.092Z,1598455183.092 [SBIT](IMPORTANT): Beginning Startup BIT 2020-08-26T15:19:43.096Z,1598455183.096 [CBIT](IMPORTANT): Beginning ground fault scan 2020-08-26T15:19:51.659Z,1598455191.659 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-08-26T15:19:52.896Z,1598455192.896 [Reporter](INFO): Onboard.Humidity 26.059092 % 2020-08-26T15:19:54.094Z,1598455194.094 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): -0.010616 CHAN A1 (24V): -0.000355 CHAN A2 (12V): -0.007565 CHAN A3 (5V): -0.002410 CHAN B0 (3.3V): 0.000405 CHAN B1 (3.15aV): -0.000764 CHAN B2 (3.15bV): -0.000185 CHAN B3 (GND): 0.002207 OPEN: 0.005591 Full Scale Calc: 4.765 mA, -1.589 mA 2020-08-26T15:20:02.926Z,1598455202.926 [Reporter](INFO): Onboard.Humidity 26.059092 % 2020-08-26T15:20:13.012Z,1598455213.012 [Reporter](INFO): Onboard.Humidity 26.059092 % 2020-08-26T15:20:23.087Z,1598455223.087 [Reporter](INFO): Onboard.Humidity 26.059092 % 2020-08-26T15:20:32.805Z,1598455232.805 [Reporter](INFO): Onboard.Humidity 26.059092 % 2020-08-26T15:20:36.824Z,1598455236.824 [SBIT](IMPORTANT): SBIT PASSED 2020-08-26T15:20:36.825Z,1598455236.825 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2020-08-26T15:20:36.826Z,1598455236.826 [SBIT](IMPORTANT): BackSeatDriver.loadAtStartup=1 bool; 2020-08-26T15:20:36.826Z,1598455236.826 [SBIT](IMPORTANT): CBIT.gf24Offset=145 microampere; 2020-08-26T15:20:36.826Z,1598455236.826 [SBIT](IMPORTANT): DAT.sbdAddress=6 enum; 2020-08-26T15:20:36.826Z,1598455236.826 [SBIT](IMPORTANT): DAT.surfaceThreshold=-1 meter; 2020-08-26T15:20:36.826Z,1598455236.826 [SBIT](IMPORTANT): DAT.verbosity=3 count; 2020-08-26T15:20:36.826Z,1598455236.826 [SBIT](IMPORTANT): DropWeight.loadAtStartup=0 bool; 2020-08-26T15:20:36.827Z,1598455236.827 [SBIT](IMPORTANT): Express none ThrusterServo.component_avgCurrent; 2020-08-26T15:20:36.827Z,1598455236.827 [SBIT](IMPORTANT): Express linearApproximation WetLabsUBAT.flow_rate 1.000000 liter_per_second; 2020-08-26T15:20:36.827Z,1598455236.827 [SBIT](IMPORTANT): Express linearApproximation height_above_sea_floor 5.000000 meter; 2020-08-26T15:20:36.827Z,1598455236.827 [SBIT](IMPORTANT): RDI_Pathfinder.loadAtStartup=0 bool; 2020-08-26T15:20:36.827Z,1598455236.827 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=344.685708 cubic_centimeter; 2020-08-26T15:20:36.827Z,1598455236.827 [SBIT](IMPORTANT): VerticalControl.massDefault=11.293600 millimeter; 2020-08-26T15:20:36.827Z,1598455236.827 [SBIT](IMPORTANT): WetLabsUBAT.loadAtStartup=0 bool; 2020-08-26T15:20:37.208Z,1598455237.208 [MissionManager](IMPORTANT): Started mission Startup 2020-08-26T15:20:37.208Z,1598455237.208 [Startup] Running Loop=1 2020-08-26T15:20:37.208Z,1598455237.208 [Startup](DEBUG): Aggregate::initialize Startup 2020-08-26T15:20:37.208Z,1598455237.208 [Startup:A.GoToSurface] Running Loop=1 2020-08-26T15:20:37.208Z,1598455237.208 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2020-08-26T15:20:37.209Z,1598455237.209 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2020-08-26T15:20:37.209Z,1598455237.209 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2020-08-26T15:20:37.209Z,1598455237.209 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2020-08-26T15:20:37.210Z,1598455237.210 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2020-08-26T15:20:37.210Z,1598455237.210 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2020-08-26T15:20:37.212Z,1598455237.212 [Startup:StartupSatComms] Running Loop=1 2020-08-26T15:20:37.212Z,1598455237.212 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2020-08-26T15:20:37.212Z,1598455237.212 [Startup:StartupSatComms:A] Running Loop=1 2020-08-26T15:20:37.623Z,1598455237.623 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2020-08-26T15:20:38.012Z,1598455238.012 [AMEcho](INFO): Powering up 2020-08-26T15:20:42.885Z,1598455242.885 [Reporter](INFO): Onboard.Humidity 26.059092 % 2020-08-26T15:20:45.775Z,1598455245.775 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-08-26T15:20:53.004Z,1598455253.004 [Reporter](INFO): Onboard.Humidity 26.083506 % 2020-08-26T15:21:03.076Z,1598455263.076 [Reporter](INFO): Onboard.Humidity 26.083506 % 2020-08-26T15:21:12.403Z,1598455272.403 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-08-26T15:21:12.799Z,1598455272.799 [Reporter](INFO): Onboard.Humidity 26.083506 % 2020-08-26T15:21:22.872Z,1598455282.872 [Reporter](INFO): Onboard.Humidity 26.083506 % 2020-08-26T15:21:25.343Z,1598455285.343 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-08-26T15:21:32.957Z,1598455292.957 [Reporter](INFO): Onboard.Humidity 26.107922 % 2020-08-26T15:21:37.392Z,1598455297.392 [Startup:StartupSatComms:A](INFO): Timed out from 2020-08-26T15:20:37.2Z 2020-08-26T15:21:37.392Z,1598455297.392 [Startup:StartupSatComms:A] Stopped 2020-08-26T15:21:37.392Z,1598455297.392 [Startup:StartupSatComms:B] Running Loop=1 2020-08-26T15:21:37.798Z,1598455297.798 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2020-08-26T15:21:37.798Z,1598455297.798 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-08-26T15:21:37.800Z,1598455297.800 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2020-08-26T15:21:37.809Z,1598455297.809 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-08-26T15:21:38.468Z,1598455298.468 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-08-26T15:21:38.468Z,1598455298.468 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2020-08-26T15:21:39.516Z,1598455299.516 [DAT](INFO): DAT read: user:6>Rx Time:15:20:05.4529 2020-08-26T15:21:39.517Z,1598455299.517 [DAT](INFO): DAT read: 2020-08-26T15:21:39.517Z,1598455299.517 [DAT](INFO): DAT read: $Packet for address 0 2020-08-26T15:21:39.517Z,1598455299.517 [DAT](INFO): received a packet notification 2020-08-26T15:21:41.044Z,1598455301.044 [DAT](INFO): #Outgoing data=1 2020-08-26T15:21:41.044Z,1598455301.044 [DAT](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_TRANSMIT 2020-08-26T15:21:41.155Z,1598455301.155 [DAT](INFO): setting remote address to 6 2020-08-26T15:21:41.515Z,1598455301.515 [DAT](INFO): DAT read: 2020-08-26T15:21:41.516Z,1598455301.516 [DAT](INFO): DAT read: RemoteAddr | 6 2020-08-26T15:21:41.516Z,1598455301.516 [DAT](INFO): set remote address to 6 2020-08-26T15:21:41.517Z,1598455301.517 [DAT](INFO): entering online mode 2020-08-26T15:21:41.919Z,1598455301.919 [DAT](INFO): DAT read: user:7> 2020-08-26T15:21:41.920Z,1598455301.920 [DAT](INFO): DAT read: 2020-08-26T15:21:41.921Z,1598455301.921 [DAT](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP 2020-08-26T15:21:41.921Z,1598455301.921 [DAT](INFO): commRate: 800 2020-08-26T15:21:41.921Z,1598455301.921 [DAT](INFO): online mode acknowledged 2020-08-26T15:21:41.922Z,1598455301.922 [DAT](DEBUG): In sendingTransmit, set commsState_ = SENDING_TRANSMIT_VERIFY 2020-08-26T15:21:42.676Z,1598455302.676 [DataOverHttps](INFO): Sending 168 bytes from file Logs/20200825T211010/Courier0007.lzma 2020-08-26T15:21:42.782Z,1598455302.782 [Reporter](INFO): Onboard.Humidity 26.107922 % 2020-08-26T15:21:43.680Z,1598455303.680 [DataOverHttps](INFO): Moved sent file to Logs/20200825T211010/Courier0007.lzma.bak 2020-08-26T15:21:43.680Z,1598455303.680 [DataOverHttps](INFO): SBD MOMSN=12619937 2020-08-26T15:21:45.545Z,1598455305.545 [DAT](INFO): DAT read: Forwarding Delay UpTx time:15:21:25.5853 2020-08-26T15:21:45.546Z,1598455305.546 [DAT](DEBUG): In parseResponses, set commsState_ = SENDING_ACK_WAITING 2020-08-26T15:21:52.908Z,1598455312.908 [Reporter](INFO): Onboard.Humidity 26.107922 % 2020-08-26T15:21:59.163Z,1598455319.163 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20200826T151826/Courier0000.lzma 2020-08-26T15:22:00.164Z,1598455320.164 [DataOverHttps](INFO): Moved sent file to Logs/20200826T151826/Courier0000.lzma.bak 2020-08-26T15:22:00.165Z,1598455320.165 [DataOverHttps](INFO): SBD MOMSN=12619939 2020-08-26T15:22:02.123Z,1598455322.123 [DAT](FAULT): Ack receipt timeout failure. 2020-08-26T15:22:02.123Z,1598455322.123 [DAT](DEBUG): In sendingAckWaiting, timeout so set commsState_ = SENDING_FILL_BUFFER 2020-08-26T15:22:03.463Z,1598455323.463 [DAT](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_TRANSMIT 2020-08-26T15:22:03.471Z,1598455323.471 [Startup:StartupSatComms:B] Stopped 2020-08-26T15:22:03.471Z,1598455323.471 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2020-08-26T15:22:03.471Z,1598455323.471 [Startup:StartupSatComms] Stopped 2020-08-26T15:22:03.471Z,1598455323.471 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2020-08-26T15:22:03.472Z,1598455323.472 [Startup](INFO): Completed Startup 2020-08-26T15:22:03.472Z,1598455323.472 [MissionManager](INFO): Startup is completed. 2020-08-26T15:22:03.472Z,1598455323.472 [MissionManager](INFO): Uninitializing Mission Startup 2020-08-26T15:22:03.472Z,1598455323.472 [Startup] Stopped 2020-08-26T15:22:03.472Z,1598455323.472 [Startup](DEBUG): Aggregate::uninitialize Startup 2020-08-26T15:22:03.472Z,1598455323.472 [Startup:A.GoToSurface] Stopped 2020-08-26T15:22:03.472Z,1598455323.472 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2020-08-26T15:22:03.482Z,1598455323.482 [Reporter](INFO): Onboard.Humidity 26.107922 % 2020-08-26T15:22:03.616Z,1598455323.616 [MissionManager](IMPORTANT): Started mission Default 2020-08-26T15:22:03.616Z,1598455323.616 [Default] Running Loop=1 2020-08-26T15:22:03.616Z,1598455323.616 [Default](DEBUG): Aggregate::initialize Default 2020-08-26T15:22:03.616Z,1598455323.616 [Default:B.GoToSurface] Running Loop=1 2020-08-26T15:22:03.616Z,1598455323.616 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2020-08-26T15:22:03.617Z,1598455323.617 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2020-08-26T15:22:03.617Z,1598455323.617 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2020-08-26T15:22:03.617Z,1598455323.617 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2020-08-26T15:22:03.617Z,1598455323.617 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2020-08-26T15:22:03.618Z,1598455323.618 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2020-08-26T15:22:03.618Z,1598455323.618 [Default:A.Wait] Running Loop=1 2020-08-26T15:22:03.618Z,1598455323.618 [Default:A.Wait](DEBUG): Initialize Wait Component. 2020-08-26T15:22:04.067Z,1598455324.067 [AMEcho](INFO): Powering down 2020-08-26T15:22:05.231Z,1598455325.231 [AMEcho](INFO): Powering up 2020-08-26T15:22:08.409Z,1598455328.409 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-08-26T15:22:12.866Z,1598455332.866 [Reporter](INFO): Onboard.Humidity 26.107922 % 2020-08-26T15:22:16.847Z,1598455336.847 [Default:A.Wait](INFO): Done Waiting. 2020-08-26T15:22:16.848Z,1598455336.848 [Default:A.Wait] Stopped 2020-08-26T15:22:16.848Z,1598455336.848 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2020-08-26T15:22:17.312Z,1598455337.312 [Default:CheckIn] Running Loop=1 2020-08-26T15:22:17.312Z,1598455337.312 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2020-08-26T15:22:17.312Z,1598455337.312 [Default:CheckIn:Read_GPS] Running Loop=1 2020-08-26T15:22:17.544Z,1598455337.544 [DataOverHttps](INFO): Sending 1141 bytes from file Logs/20200825T211010/Express0001.lzma 2020-08-26T15:22:17.664Z,1598455337.664 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2020-08-26T15:22:18.544Z,1598455338.544 [DataOverHttps](INFO): Moved sent file to Logs/20200825T211010/Express0001.lzma.bak 2020-08-26T15:22:18.544Z,1598455338.544 [DataOverHttps](INFO): SBD MOMSN=12619942 2020-08-26T15:22:22.929Z,1598455342.929 [Reporter](INFO): Onboard.Humidity 26.107922 % 2020-08-26T15:22:33.029Z,1598455353.029 [Reporter](INFO): Onboard.Humidity 26.132339 % 2020-08-26T15:22:43.127Z,1598455363.127 [Reporter](INFO): Onboard.Humidity 26.132339 % 2020-08-26T15:22:53.277Z,1598455373.277 [Reporter](INFO): Onboard.Humidity 26.132339 % 2020-08-26T15:23:02.909Z,1598455382.909 [Reporter](INFO): Onboard.Humidity 26.132339 % 2020-08-26T15:23:13.015Z,1598455393.015 [Reporter](INFO): Onboard.Humidity 26.132339 % 2020-08-26T15:23:23.120Z,1598455403.120 [Reporter](INFO): Onboard.Humidity 26.156755 % 2020-08-26T15:23:33.205Z,1598455413.205 [Reporter](INFO): Onboard.Humidity 26.156755 % 2020-08-26T15:23:42.917Z,1598455422.917 [Reporter](INFO): Onboard.Humidity 26.144548 % 2020-08-26T15:23:43.693Z,1598455423.693 [BPC1](ERROR): BPC1A: No match for serial number 1717 in BPC1A's battery stick inventory (sticks 1-32 in onboard configuration file). 2020-08-26T15:23:53.020Z,1598455433.020 [Reporter](INFO): Onboard.Humidity 26.144548 % 2020-08-26T15:24:03.135Z,1598455443.135 [Reporter](INFO): Onboard.Humidity 26.156755 % 2020-08-26T15:24:07.593Z,1598455447.593 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-08-26T15:24:13.225Z,1598455453.225 [Reporter](INFO): Onboard.Humidity 26.144548 % 2020-08-26T15:24:18.436Z,1598455458.436 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2020-08-26T15:24:22.940Z,1598455462.940 [Reporter](INFO): Onboard.Humidity 26.144548 % 2020-08-26T15:24:33.013Z,1598455473.013 [Reporter](INFO): Onboard.Humidity 26.168966 % 2020-08-26T15:24:36.319Z,1598455476.319 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-08-26T15:24:39.046Z,1598455479.046 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2020-08-26T15:24:39.046Z,1598455479.046 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-08-26T15:24:39.085Z,1598455479.085 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-08-26T15:24:39.473Z,1598455479.473 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-08-26T15:24:39.473Z,1598455479.473 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2020-08-26T15:24:43.098Z,1598455483.098 [Reporter](INFO): Onboard.Humidity 26.168966 % 2020-08-26T15:24:53.221Z,1598455493.221 [Reporter](INFO): Onboard.Humidity 26.168966 % 2020-08-26T15:25:02.951Z,1598455502.951 [Reporter](INFO): Onboard.Humidity 26.168966 % 2020-08-26T15:25:13.024Z,1598455513.024 [Reporter](INFO): Onboard.Humidity 26.168966 % 2020-08-26T15:25:23.092Z,1598455523.092 [Reporter](INFO): Onboard.Humidity 26.168966 % 2020-08-26T15:25:30.471Z,1598455530.471 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-08-26T15:25:33.247Z,1598455533.247 [Reporter](INFO): Onboard.Humidity 26.168966 % 2020-08-26T15:25:43.340Z,1598455543.340 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-08-26T15:25:43.356Z,1598455543.356 [Reporter](INFO): Onboard.Humidity 26.168966 % 2020-08-26T15:25:53.016Z,1598455553.016 [Reporter](INFO): Onboard.Humidity 26.168966 % 2020-08-26T15:26:03.104Z,1598455563.104 [Reporter](INFO): Onboard.Humidity 26.168966 % 2020-08-26T15:26:13.185Z,1598455573.185 [Reporter](INFO): Onboard.Humidity 26.168966 % 2020-08-26T15:26:23.325Z,1598455583.325 [Reporter](INFO): Onboard.Humidity 26.168966 % 2020-08-26T15:26:33.396Z,1598455593.396 [Reporter](INFO): Onboard.Humidity 26.181177 % 2020-08-26T15:26:43.109Z,1598455603.109 [Reporter](INFO): Onboard.Humidity 26.168966 % 2020-08-26T15:26:53.192Z,1598455613.192 [Reporter](INFO): Onboard.Humidity 26.168966 % 2020-08-26T15:27:03.314Z,1598455623.314 [Reporter](INFO): Onboard.Humidity 26.199488 % 2020-08-26T15:27:13.397Z,1598455633.397 [Reporter](INFO): Onboard.Humidity 26.199488 % 2020-08-26T15:27:16.208Z,1598455636.208 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6. 2020-08-26T15:27:16.212Z,1598455636.212 [BPC1](INFO): Received data from all battery sticks. 2020-08-26T15:27:17.432Z,1598455637.432 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-08-26T15:22:17.3Z 2020-08-26T15:27:17.432Z,1598455637.432 [Default:CheckIn:Read_GPS] Stopped 2020-08-26T15:27:17.433Z,1598455637.433 [Default:CheckIn:Read_Iridium] Running Loop=1 2020-08-26T15:27:17.823Z,1598455637.823 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications 2020-08-26T15:27:19.433Z,1598455639.433 [DAT](DEBUG): In sendingTransmit, set commsState_ = SENDING_TRANSMIT_VERIFY 2020-08-26T15:27:23.076Z,1598455643.076 [DAT](INFO): DAT read: Forwarding Delay UpTx time:15:27:03.0840 2020-08-26T15:27:23.076Z,1598455643.076 [DAT](DEBUG): In parseResponses, set commsState_ = SENDING_ACK_WAITING 2020-08-26T15:27:23.111Z,1598455643.111 [Reporter](INFO): Onboard.Humidity 26.187281 % 2020-08-26T15:27:24.206Z,1598455644.206 [DataOverHttps](INFO): Sending 167 bytes from file Logs/20200826T151826/Courier0004.lzma 2020-08-26T15:27:25.208Z,1598455645.208 [DataOverHttps](INFO): Moved sent file to Logs/20200826T151826/Courier0004.lzma.bak 2020-08-26T15:27:25.208Z,1598455645.208 [DataOverHttps](INFO): SBD MOMSN=12619974 2020-08-26T15:27:33.193Z,1598455653.193 [Reporter](INFO): Onboard.Humidity 26.199488 % 2020-08-26T15:27:39.637Z,1598455659.637 [DAT](FAULT): Ack receipt timeout failure. 2020-08-26T15:27:39.637Z,1598455659.637 [DAT](DEBUG): In sendingAckWaiting, timeout so set commsState_ = SENDING_FILL_BUFFER 2020-08-26T15:27:41.437Z,1598455661.437 [DAT](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_TRANSMIT 2020-08-26T15:27:41.456Z,1598455661.456 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3 2020-08-26T15:27:41.456Z,1598455661.456 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-08-26T15:27:41.457Z,1598455661.457 [Default:CheckIn:Read_Iridium] Stopped 2020-08-26T15:27:41.457Z,1598455661.457 [Default:CheckIn:C.Wait] Running Loop=1 2020-08-26T15:27:41.457Z,1598455661.457 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2020-08-26T15:27:41.475Z,1598455661.475 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-08-26T15:27:41.597Z,1598455661.597 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-08-26T15:27:41.597Z,1598455661.597 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3 2020-08-26T15:27:43.152Z,1598455663.152 [Reporter](INFO): Onboard.Humidity 26.199488 % 2020-08-26T15:27:43.635Z,1598455663.635 [DataOverHttps](INFO): Sending 313 bytes from file Logs/20200825T211010/Express0005.lzma 2020-08-26T15:27:44.636Z,1598455664.636 [DataOverHttps](INFO): Moved sent file to Logs/20200825T211010/Express0005.lzma.bak 2020-08-26T15:27:44.636Z,1598455664.636 [DataOverHttps](INFO): SBD MOMSN=12619976 2020-08-26T15:27:53.233Z,1598455673.233 [Reporter](INFO): Onboard.Humidity 26.199488 % 2020-08-26T15:28:03.332Z,1598455683.332 [Reporter](INFO): Onboard.Humidity 26.199488 % 2020-08-26T15:28:13.448Z,1598455693.448 [Reporter](INFO): Onboard.Humidity 26.199488 % 2020-08-26T15:28:23.553Z,1598455703.553 [Reporter](INFO): Onboard.Humidity 26.199488 % 2020-08-26T15:28:33.234Z,1598455713.234 [Reporter](INFO): Onboard.Humidity 26.199488 % 2020-08-26T15:28:43.320Z,1598455723.320 [Reporter](INFO): Onboard.Humidity 26.199488 % 2020-08-26T15:28:53.433Z,1598455733.433 [Reporter](INFO): Onboard.Humidity 26.199488 % 2020-08-26T15:29:03.524Z,1598455743.524 [Reporter](INFO): Onboard.Humidity 26.199488 % 2020-08-26T15:29:13.216Z,1598455753.216 [Reporter](INFO): Onboard.Humidity 26.199488 % 2020-08-26T15:29:16.428Z,1598455756.428 [NAL9602](FAULT): GPS failed to acquire within timeout. 2020-08-26T15:29:16.428Z,1598455756.428 [NAL9602] Data Fault, FailCount= 1 2020-08-26T15:29:16.428Z,1598455756.428 [NAL9602](ERROR): Data Fault 2020-08-26T15:29:16.443Z,1598455756.443 [CBIT](ERROR): Data Fault in component: NAL9602 2020-08-26T15:29:16.836Z,1598455756.836 [NAL9602](INFO): Powering down 2020-08-26T15:29:17.655Z,1598455757.655 [CBIT](INFO): Clearing failed state for component NAL9602 2020-08-26T15:29:17.655Z,1598455757.655 [NAL9602] No Fault, FailCount= 1 2020-08-26T15:29:23.320Z,1598455763.320 [Reporter](INFO): Onboard.Humidity 26.199488 % 2020-08-26T15:29:33.413Z,1598455773.413 [Reporter](INFO): Onboard.Humidity 26.199488 % 2020-08-26T15:29:43.516Z,1598455783.516 [Reporter](INFO): Onboard.Humidity 26.199488 % 2020-08-26T15:29:47.140Z,1598455787.140 [NAL9602](INFO): Powering up NAL9602 2020-08-26T15:29:53.246Z,1598455793.246 [Reporter](INFO): Onboard.Humidity 26.199488 % 2020-08-26T15:29:58.044Z,1598455798.044 [NAL9602](INFO): NAL9602 initialized 2020-08-26T15:30:03.309Z,1598455803.309 [Reporter](INFO): Onboard.Humidity 26.199488 % 2020-08-26T15:30:13.412Z,1598455813.412 [Reporter](INFO): Onboard.Humidity 26.199488 % 2020-08-26T15:30:23.515Z,1598455823.515 [Reporter](INFO): Onboard.Humidity 26.199488 % 2020-08-26T15:30:33.615Z,1598455833.615 [Reporter](INFO): Onboard.Humidity 26.199488 % 2020-08-26T15:30:42.089Z,1598455842.089 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4 2020-08-26T15:30:42.089Z,1598455842.089 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-08-26T15:30:42.102Z,1598455842.102 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-08-26T15:30:42.511Z,1598455842.511 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-08-26T15:30:42.512Z,1598455842.512 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4 2020-08-26T15:30:43.321Z,1598455843.321 [Reporter](INFO): Onboard.Humidity 26.199488 % 2020-08-26T15:30:53.417Z,1598455853.417 [Reporter](INFO): Onboard.Humidity 26.181177 % 2020-08-26T15:31:03.523Z,1598455863.523 [Reporter](INFO): Onboard.Humidity 26.199488 % 2020-08-26T15:31:13.633Z,1598455873.633 [Reporter](INFO): Onboard.Humidity 26.181177 % 2020-08-26T15:31:23.349Z,1598455883.349 [Reporter](INFO): Onboard.Humidity 26.199488 % 2020-08-26T15:31:33.404Z,1598455893.404 [Reporter](INFO): Onboard.Humidity 26.181177 % 2020-08-26T15:31:43.525Z,1598455903.525 [Reporter](INFO): Onboard.Humidity 26.199488 % 2020-08-26T15:31:53.629Z,1598455913.629 [Reporter](INFO): Onboard.Humidity 26.181177 % 2020-08-26T15:32:03.716Z,1598455923.716 [Reporter](INFO): Onboard.Humidity 26.181177 % 2020-08-26T15:32:13.407Z,1598455933.407 [Reporter](INFO): Onboard.Humidity 26.199488 % 2020-08-26T15:32:23.518Z,1598455943.518 [Reporter](INFO): Onboard.Humidity 26.181177 % 2020-08-26T15:32:33.629Z,1598455953.629 [Reporter](INFO): Onboard.Humidity 26.181177 % 2020-08-26T15:32:41.692Z,1598455961.692 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2020-08-26T15:32:41.692Z,1598455961.692 [Default:CheckIn:C.Wait] Stopped 2020-08-26T15:32:41.692Z,1598455961.692 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2020-08-26T15:32:41.692Z,1598455961.692 [Default:CheckIn:D] Running Loop=1 2020-08-26T15:32:42.106Z,1598455962.106 [Default:CheckIn:D] Stopped 2020-08-26T15:32:42.106Z,1598455962.106 [Default:CheckIn:E] Running Loop=1 2020-08-26T15:32:42.519Z,1598455962.519 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 10.641498 min 2020-08-26T15:32:42.519Z,1598455962.519 [Default:CheckIn:E] Stopped 2020-08-26T15:32:42.520Z,1598455962.520 [Default:CheckIn](INFO): Completed Default:CheckIn 2020-08-26T15:32:42.520Z,1598455962.520 [Default:CheckIn] Stopped 2020-08-26T15:32:42.520Z,1598455962.520 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2020-08-26T15:32:42.520Z,1598455962.520 [Default:CheckIn](INFO): Running loop #2 2020-08-26T15:32:42.520Z,1598455962.520 [Default:CheckIn] Running Loop=2 2020-08-26T15:32:42.520Z,1598455962.520 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2020-08-26T15:32:42.520Z,1598455962.520 [Default:CheckIn:Read_GPS] Running Loop=1 2020-08-26T15:32:43.728Z,1598455963.728 [Reporter](INFO): Onboard.Humidity 26.181177 % 2020-08-26T15:32:53.419Z,1598455973.419 [Reporter](INFO): Onboard.Humidity 26.181177 % 2020-08-26T15:33:03.566Z,1598455983.566 [Reporter](INFO): Onboard.Humidity 26.181177 % 2020-08-26T15:33:13.609Z,1598455993.609 [Reporter](INFO): Onboard.Humidity 26.187281 % 2020-08-26T15:33:23.752Z,1598456003.752 [Reporter](INFO): Onboard.Humidity 26.181177 % 2020-08-26T15:33:33.453Z,1598456013.453 [Reporter](INFO): Onboard.Humidity 26.181177 % 2020-08-26T15:33:43.102Z,1598456023.102 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5 2020-08-26T15:33:43.102Z,1598456023.102 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-08-26T15:33:43.121Z,1598456023.121 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-08-26T15:33:43.537Z,1598456023.537 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-08-26T15:33:43.537Z,1598456023.537 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5 2020-08-26T15:33:43.538Z,1598456023.538 [Reporter](INFO): Onboard.Humidity 26.181177 % 2020-08-26T15:33:53.631Z,1598456033.631 [Reporter](INFO): Onboard.Humidity 26.181177 % 2020-08-26T15:34:03.709Z,1598456043.709 [Reporter](INFO): Onboard.Humidity 26.187281 % 2020-08-26T15:34:13.829Z,1598456053.829 [Reporter](INFO): Onboard.Humidity 26.181177 % 2020-08-26T15:34:23.500Z,1598456063.500 [Reporter](INFO): Onboard.Humidity 26.187281 % 2020-08-26T15:34:33.621Z,1598456073.621 [Reporter](INFO): Onboard.Humidity 26.181177 % 2020-08-26T15:34:43.706Z,1598456083.706 [Reporter](INFO): Onboard.Humidity 26.187281 % 2020-08-26T15:34:53.827Z,1598456093.827 [Reporter](INFO): Onboard.Humidity 26.187281 % 2020-08-26T15:35:03.540Z,1598456103.540 [Reporter](INFO): Onboard.Humidity 26.187281 % 2020-08-26T15:35:13.629Z,1598456113.629 [Reporter](INFO): Onboard.Humidity 26.187281 % 2020-08-26T15:35:23.696Z,1598456123.696 [Reporter](INFO): Onboard.Humidity 26.187281 % 2020-08-26T15:35:33.805Z,1598456133.805 [Reporter](INFO): Onboard.Humidity 26.187281 % 2020-08-26T15:35:43.912Z,1598456143.912 [Reporter](INFO): Onboard.Humidity 26.187281 % 2020-08-26T15:35:53.620Z,1598456153.620 [Reporter](INFO): Onboard.Humidity 26.187281 % 2020-08-26T15:36:03.697Z,1598456163.697 [Reporter](INFO): Onboard.Humidity 26.187281 % 2020-08-26T15:36:13.796Z,1598456173.796 [Reporter](INFO): Onboard.Humidity 26.187281 % 2020-08-26T15:36:23.925Z,1598456183.925 [Reporter](INFO): Onboard.Humidity 26.187281 % 2020-08-26T15:36:33.624Z,1598456193.624 [Reporter](INFO): Onboard.Humidity 26.187281 % 2020-08-26T15:36:43.693Z,1598456203.693 [Reporter](INFO): Onboard.Humidity 26.187281 % 2020-08-26T15:36:44.092Z,1598456204.092 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6 2020-08-26T15:36:44.092Z,1598456204.092 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-08-26T15:36:44.102Z,1598456204.102 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-08-26T15:36:44.510Z,1598456204.510 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-08-26T15:36:44.510Z,1598456204.510 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6 2020-08-26T15:36:53.798Z,1598456213.798 [Reporter](INFO): Onboard.Humidity 26.168966 % 2020-08-26T15:37:03.909Z,1598456223.909 [Reporter](INFO): Onboard.Humidity 26.187281 % 2020-08-26T15:37:13.652Z,1598456233.652 [Reporter](INFO): Onboard.Humidity 26.187281 % 2020-08-26T15:37:23.685Z,1598456243.685 [Reporter](INFO): Onboard.Humidity 26.168966 % 2020-08-26T15:37:33.796Z,1598456253.796 [Reporter](INFO): Onboard.Humidity 26.187281 % 2020-08-26T15:37:42.660Z,1598456262.660 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-08-26T15:32:42.5Z 2020-08-26T15:37:42.660Z,1598456262.660 [Default:CheckIn:Read_GPS] Stopped 2020-08-26T15:37:42.660Z,1598456262.660 [Default:CheckIn:Read_Iridium] Running Loop=1 2020-08-26T15:37:43.906Z,1598456263.906 [Reporter](INFO): Onboard.Humidity 26.168966 % 2020-08-26T15:37:44.681Z,1598456264.681 [DAT](INFO): DAT read: Rx Time:15:30:34.2122 2020-08-26T15:37:44.681Z,1598456264.681 [DAT](INFO): received an acoustic signal 2020-08-26T15:37:44.681Z,1598456264.681 [DAT](INFO): DAT read: 2020-08-26T15:37:44.682Z,1598456264.682 [DAT](INFO): DAT read: $Packet for address 0 2020-08-26T15:37:44.682Z,1598456264.682 [DAT](INFO): received a packet notification 2020-08-26T15:37:44.695Z,1598456264.695 [DAT](DEBUG): In sendingTransmit, set commsState_ = SENDING_TRANSMIT_VERIFY 2020-08-26T15:37:48.313Z,1598456268.313 [DAT](INFO): DAT read: Forwarding Delay UpTx time:15:37:28.3811 2020-08-26T15:37:48.314Z,1598456268.314 [DAT](DEBUG): In parseResponses, set commsState_ = SENDING_ACK_WAITING 2020-08-26T15:37:49.826Z,1598456269.826 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20200826T151826/Courier0007.lzma 2020-08-26T15:37:50.828Z,1598456270.828 [DataOverHttps](INFO): Moved sent file to Logs/20200826T151826/Courier0007.lzma.bak 2020-08-26T15:37:50.828Z,1598456270.828 [DataOverHttps](INFO): SBD MOMSN=12620015 2020-08-26T15:37:53.989Z,1598456273.989 [Reporter](INFO): Onboard.Humidity 26.168966 % 2020-08-26T15:38:03.720Z,1598456283.720 [Reporter](INFO): Onboard.Humidity 26.168966 % 2020-08-26T15:38:04.899Z,1598456284.899 [DAT](FAULT): Ack receipt timeout failure. 2020-08-26T15:38:04.899Z,1598456284.899 [DAT](DEBUG): In sendingAckWaiting, timeout so set commsState_ = SENDING_FILL_BUFFER 2020-08-26T15:38:06.734Z,1598456286.734 [DAT](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_TRANSMIT 2020-08-26T15:38:06.757Z,1598456286.757 [Default:CheckIn:Read_Iridium] Stopped 2020-08-26T15:38:06.757Z,1598456286.757 [Default:CheckIn:C.Wait] Running Loop=1 2020-08-26T15:38:06.757Z,1598456286.757 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2020-08-26T15:38:08.495Z,1598456288.495 [DataOverHttps](INFO): Sending 232 bytes from file Logs/20200825T211010/Express0008.lzma 2020-08-26T15:38:09.496Z,1598456289.496 [DataOverHttps](INFO): Moved sent file to Logs/20200825T211010/Express0008.lzma.bak 2020-08-26T15:38:09.496Z,1598456289.496 [DataOverHttps](INFO): SBD MOMSN=12620017 2020-08-26T15:38:13.713Z,1598456293.713 [Reporter](INFO): Onboard.Humidity 26.168966 % 2020-08-26T15:38:23.797Z,1598456303.797 [Reporter](INFO): Onboard.Humidity 26.168966 % 2020-08-26T15:38:33.880Z,1598456313.880 [Reporter](INFO): Onboard.Humidity 26.168966 % 2020-08-26T15:38:43.976Z,1598456323.976 [Reporter](INFO): Onboard.Humidity 26.168966 % 2020-08-26T15:38:53.701Z,1598456333.701 [Reporter](INFO): Onboard.Humidity 26.168966 % 2020-08-26T15:39:03.800Z,1598456343.800 [Reporter](INFO): Onboard.Humidity 26.168966 % 2020-08-26T15:39:13.868Z,1598456353.868 [Reporter](INFO): Onboard.Humidity 26.168966 % 2020-08-26T15:39:23.977Z,1598456363.977 [Reporter](INFO): Onboard.Humidity 26.168966 % 2020-08-26T15:39:34.093Z,1598456374.093 [Reporter](INFO): Onboard.Humidity 26.168966 % 2020-08-26T15:39:43.784Z,1598456383.784 [Reporter](INFO): Onboard.Humidity 26.168966 % 2020-08-26T15:39:44.963Z,1598456384.963 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7 2020-08-26T15:39:44.963Z,1598456384.963 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-08-26T15:39:44.973Z,1598456384.973 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-08-26T15:39:45.386Z,1598456385.386 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-08-26T15:39:45.386Z,1598456385.386 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7 2020-08-26T15:39:53.864Z,1598456393.864 [Reporter](INFO): Onboard.Humidity 26.168966 % 2020-08-26T15:40:01.116Z,1598456401.116 [NAL9602](FAULT): GPS failed to acquire within timeout. 2020-08-26T15:40:01.116Z,1598456401.116 [NAL9602] Data Fault, FailCount= 2 2020-08-26T15:40:01.116Z,1598456401.116 [NAL9602](ERROR): Data Fault 2020-08-26T15:40:01.172Z,1598456401.172 [CBIT](ERROR): Data Fault in component: NAL9602 2020-08-26T15:40:01.519Z,1598456401.519 [NAL9602](INFO): Powering down 2020-08-26T15:40:02.346Z,1598456402.346 [CBIT](INFO): Clearing failed state for component NAL9602 2020-08-26T15:40:02.346Z,1598456402.346 [NAL9602] No Fault, FailCount= 2 2020-08-26T15:40:03.966Z,1598456403.966 [Reporter](INFO): Onboard.Humidity 26.168966 % 2020-08-26T15:40:14.065Z,1598456414.065 [Reporter](INFO): Onboard.Humidity 26.168966 % 2020-08-26T15:40:23.796Z,1598456423.796 [Reporter](INFO): Onboard.Humidity 26.168966 % 2020-08-26T15:40:31.824Z,1598456431.824 [NAL9602](INFO): Powering up NAL9602 2020-08-26T15:40:33.857Z,1598456433.857 [Reporter](INFO): Onboard.Humidity 26.168966 % 2020-08-26T15:40:42.732Z,1598456442.732 [NAL9602](INFO): NAL9602 initialized 2020-08-26T15:40:44.012Z,1598456444.012 [Reporter](INFO): Onboard.Humidity 26.168966 % 2020-08-26T15:40:54.097Z,1598456454.097 [Reporter](INFO): Onboard.Humidity 26.168966 % 2020-08-26T15:41:03.801Z,1598456463.801 [Reporter](INFO): Onboard.Humidity 26.168966 % 2020-08-26T15:41:13.860Z,1598456473.860 [Reporter](INFO): Onboard.Humidity 26.144548 % 2020-08-26T15:41:23.960Z,1598456483.960 [Reporter](INFO): Onboard.Humidity 26.168966 % 2020-08-26T15:41:34.069Z,1598456494.069 [Reporter](INFO): Onboard.Humidity 26.168966 % 2020-08-26T15:41:44.181Z,1598456504.181 [Reporter](INFO): Onboard.Humidity 26.144548 % 2020-08-26T15:41:53.866Z,1598456513.866 [Reporter](INFO): Onboard.Humidity 26.144548 % 2020-08-26T15:42:03.964Z,1598456523.964 [Reporter](INFO): Onboard.Humidity 26.144548 % 2020-08-26T15:42:14.065Z,1598456534.065 [Reporter](INFO): Onboard.Humidity 26.168966 % 2020-08-26T15:42:24.157Z,1598456544.157 [Reporter](INFO): Onboard.Humidity 26.144548 % 2020-08-26T15:42:33.902Z,1598456553.902 [Reporter](INFO): Onboard.Humidity 26.144548 % 2020-08-26T15:42:43.969Z,1598456563.969 [Reporter](INFO): Onboard.Humidity 26.144548 % 2020-08-26T15:42:45.970Z,1598456565.970 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8 2020-08-26T15:42:45.970Z,1598456565.970 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-08-26T15:42:45.980Z,1598456565.980 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-08-26T15:42:46.393Z,1598456566.393 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-08-26T15:42:46.393Z,1598456566.393 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8 2020-08-26T15:42:54.063Z,1598456574.063 [Reporter](INFO): Onboard.Humidity 26.144548 % 2020-08-26T15:43:04.169Z,1598456584.169 [Reporter](INFO): Onboard.Humidity 26.144548 % 2020-08-26T15:43:06.976Z,1598456586.976 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2020-08-26T15:43:06.976Z,1598456586.976 [Default:CheckIn:C.Wait] Stopped 2020-08-26T15:43:06.976Z,1598456586.976 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2020-08-26T15:43:06.976Z,1598456586.976 [Default:CheckIn:D] Running Loop=1 2020-08-26T15:43:07.371Z,1598456587.371 [Default:CheckIn:D] Stopped 2020-08-26T15:43:07.372Z,1598456587.372 [Default:CheckIn:E] Running Loop=1 2020-08-26T15:43:07.776Z,1598456587.776 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 21.062590 min 2020-08-26T15:43:07.776Z,1598456587.776 [Default:CheckIn:E] Stopped 2020-08-26T15:43:07.776Z,1598456587.776 [Default:CheckIn](INFO): Completed Default:CheckIn 2020-08-26T15:43:07.776Z,1598456587.776 [Default:CheckIn] Stopped 2020-08-26T15:43:07.776Z,1598456587.776 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2020-08-26T15:43:07.776Z,1598456587.776 [Default:CheckIn](INFO): Running loop #3 2020-08-26T15:43:07.776Z,1598456587.776 [Default:CheckIn] Running Loop=3 2020-08-26T15:43:07.776Z,1598456587.776 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2020-08-26T15:43:07.776Z,1598456587.776 [Default:CheckIn:Read_GPS] Running Loop=1 2020-08-26T15:43:14.248Z,1598456594.248 [Reporter](INFO): Onboard.Humidity 26.144548 % 2020-08-26T15:43:23.974Z,1598456603.974 [Reporter](INFO): Onboard.Humidity 26.156755 % 2020-08-26T15:43:34.072Z,1598456614.072 [Reporter](INFO): Onboard.Humidity 26.144548 % 2020-08-26T15:43:44.143Z,1598456624.143 [Reporter](INFO): Onboard.Humidity 26.156755 % 2020-08-26T15:43:54.245Z,1598456634.245 [Reporter](INFO): Onboard.Humidity 26.156755 % 2020-08-26T15:44:03.984Z,1598456643.984 [Reporter](INFO): Onboard.Humidity 26.156755 % 2020-08-26T15:44:14.067Z,1598456654.067 [Reporter](INFO): Onboard.Humidity 26.156755 % 2020-08-26T15:44:24.141Z,1598456664.141 [Reporter](INFO): Onboard.Humidity 26.156755 % 2020-08-26T15:44:34.240Z,1598456674.240 [Reporter](INFO): Onboard.Humidity 26.156755 % 2020-08-26T15:44:44.370Z,1598456684.370 [Reporter](INFO): Onboard.Humidity 26.156755 % 2020-08-26T15:44:54.057Z,1598456694.057 [Reporter](INFO): Onboard.Humidity 26.132339 % 2020-08-26T15:45:04.133Z,1598456704.133 [Reporter](INFO): Onboard.Humidity 26.132339 % 2020-08-26T15:45:14.266Z,1598456714.266 [Reporter](INFO): Onboard.Humidity 26.132339 % 2020-08-26T15:45:24.329Z,1598456724.329 [Reporter](INFO): Onboard.Humidity 26.132339 % 2020-08-26T15:45:34.073Z,1598456734.073 [Reporter](INFO): Onboard.Humidity 26.132339 % 2020-08-26T15:45:44.138Z,1598456744.138 [Reporter](INFO): Onboard.Humidity 26.132339 % 2020-08-26T15:45:46.958Z,1598456746.958 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 9 2020-08-26T15:45:46.958Z,1598456746.958 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-08-26T15:45:46.980Z,1598456746.980 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-08-26T15:45:47.375Z,1598456747.375 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-08-26T15:45:47.375Z,1598456747.375 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 9 2020-08-26T15:45:54.270Z,1598456754.270 [Reporter](INFO): Onboard.Humidity 26.132339 % 2020-08-26T15:46:04.333Z,1598456764.333 [Reporter](INFO): Onboard.Humidity 26.132339 % 2020-08-26T15:46:14.087Z,1598456774.087 [Reporter](INFO): Onboard.Humidity 26.132339 % 2020-08-26T15:46:24.231Z,1598456784.231 [Reporter](INFO): Onboard.Humidity 26.132339 % 2020-08-26T15:46:34.253Z,1598456794.253 [Reporter](INFO): Onboard.Humidity 26.132339 % 2020-08-26T15:46:44.336Z,1598456804.336 [Reporter](INFO): Onboard.Humidity 26.132339 % 2020-08-26T15:46:54.445Z,1598456814.445 [Reporter](INFO): Onboard.Humidity 26.132339 % 2020-08-26T15:47:04.149Z,1598456824.149 [Reporter](INFO): Onboard.Humidity 26.132339 % 2020-08-26T15:47:14.263Z,1598456834.263 [Reporter](INFO): Onboard.Humidity 26.132339 % 2020-08-26T15:47:24.327Z,1598456844.327 [Reporter](INFO): Onboard.Humidity 26.132339 % 2020-08-26T15:47:34.441Z,1598456854.441 [Reporter](INFO): Onboard.Humidity 26.132339 % 2020-08-26T15:47:44.160Z,1598456864.160 [Reporter](INFO): Onboard.Humidity 26.132339 % 2020-08-26T15:47:54.220Z,1598456874.220 [Reporter](INFO): Onboard.Humidity 26.132339 % 2020-08-26T15:48:04.314Z,1598456884.314 [Reporter](INFO): Onboard.Humidity 26.132339 % 2020-08-26T15:48:07.952Z,1598456887.952 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-08-26T15:43:07.8Z 2020-08-26T15:48:07.952Z,1598456887.952 [Default:CheckIn:Read_GPS] Stopped 2020-08-26T15:48:07.952Z,1598456887.952 [Default:CheckIn:Read_Iridium] Running Loop=1 2020-08-26T15:48:09.967Z,1598456889.967 [DAT](INFO): DAT read: Rx Time:15:42:05.9553 2020-08-26T15:48:09.967Z,1598456889.967 [DAT](INFO): received an acoustic signal 2020-08-26T15:48:09.967Z,1598456889.967 [DAT](INFO): DAT read: 2020-08-26T15:48:09.968Z,1598456889.968 [DAT](INFO): DAT read: $Packet for address 0 2020-08-26T15:48:09.968Z,1598456889.968 [DAT](INFO): received a packet notification 2020-08-26T15:48:09.983Z,1598456889.983 [DAT](DEBUG): In sendingTransmit, set commsState_ = SENDING_TRANSMIT_VERIFY 2020-08-26T15:48:13.593Z,1598456893.593 [DAT](INFO): DAT read: Forwarding Delay UpTx time:15:47:53.6277 2020-08-26T15:48:13.593Z,1598456893.593 [DAT](DEBUG): In parseResponses, set commsState_ = SENDING_ACK_WAITING 2020-08-26T15:48:14.417Z,1598456894.417 [Reporter](INFO): Onboard.Humidity 26.132339 % 2020-08-26T15:48:15.378Z,1598456895.378 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20200826T151826/Courier0010.lzma 2020-08-26T15:48:16.380Z,1598456896.380 [DataOverHttps](INFO): Moved sent file to Logs/20200826T151826/Courier0010.lzma.bak 2020-08-26T15:48:16.380Z,1598456896.380 [DataOverHttps](INFO): SBD MOMSN=12620064 2020-08-26T15:48:24.173Z,1598456904.173 [Reporter](INFO): Onboard.Humidity 26.132339 % 2020-08-26T15:48:30.167Z,1598456910.167 [DAT](FAULT): Ack receipt timeout failure. 2020-08-26T15:48:30.167Z,1598456910.167 [DAT](DEBUG): In sendingAckWaiting, hit max timeouts so set commsState_ = SENDING_VERIFIED 2020-08-26T15:48:30.571Z,1598456910.571 [DAT](DEBUG): In sendingVerified, sbd done so set commsState_ = SENDING_FILL_BUFFER 2020-08-26T15:48:32.402Z,1598456912.402 [Default:CheckIn:Read_Iridium] Stopped 2020-08-26T15:48:32.402Z,1598456912.402 [Default:CheckIn:C.Wait] Running Loop=1 2020-08-26T15:48:32.403Z,1598456912.403 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2020-08-26T15:48:34.489Z,1598456914.489 [Reporter](INFO): Onboard.Humidity 26.132339 % 2020-08-26T15:48:34.836Z,1598456914.836 [DataOverHttps](INFO): Sending 1078 bytes from file Logs/20200826T151826/Express0001.lzma 2020-08-26T15:48:35.836Z,1598456915.836 [DataOverHttps](INFO): Moved sent file to Logs/20200826T151826/Express0001.lzma.bak 2020-08-26T15:48:35.836Z,1598456915.836 [DataOverHttps](INFO): SBD MOMSN=12620071 2020-08-26T15:48:44.212Z,1598456924.212 [Reporter](INFO): Onboard.Humidity 26.132339 % 2020-08-26T15:48:47.816Z,1598456927.816 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 10 2020-08-26T15:48:47.816Z,1598456927.816 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-08-26T15:48:47.851Z,1598456927.851 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-08-26T15:48:48.251Z,1598456928.251 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-08-26T15:48:48.251Z,1598456928.251 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 10 2020-08-26T15:48:54.309Z,1598456934.309 [Reporter](INFO): Onboard.Humidity 26.132339 % 2020-08-26T15:49:04.385Z,1598456944.385 [Reporter](INFO): Onboard.Humidity 26.132339 % 2020-08-26T15:49:14.493Z,1598456954.493 [Reporter](INFO): Onboard.Humidity 26.132339 % 2020-08-26T15:49:24.594Z,1598456964.594 [Reporter](INFO): Onboard.Humidity 26.132339 % 2020-08-26T15:49:34.298Z,1598456974.298 [Reporter](INFO): Onboard.Humidity 26.107922 % 2020-08-26T15:49:44.388Z,1598456984.388 [Reporter](INFO): Onboard.Humidity 26.107922 % 2020-08-26T15:49:54.495Z,1598456994.495 [Reporter](INFO): Onboard.Humidity 26.107922 % 2020-08-26T15:50:04.592Z,1598457004.592 [Reporter](INFO): Onboard.Humidity 26.132339 % 2020-08-26T15:50:14.295Z,1598457014.295 [Reporter](INFO): Onboard.Humidity 26.107922 % 2020-08-26T15:50:24.392Z,1598457024.392 [Reporter](INFO): Onboard.Humidity 26.107922 % 2020-08-26T15:50:34.493Z,1598457034.493 [Reporter](INFO): Onboard.Humidity 26.107922 % 2020-08-26T15:50:43.757Z,1598457043.757 [NAL9602](FAULT): GPS failed to acquire within timeout. 2020-08-26T15:50:43.757Z,1598457043.757 [NAL9602] Data Fault, FailCount= 3 2020-08-26T15:50:43.757Z,1598457043.757 [NAL9602](ERROR): Data Fault 2020-08-26T15:50:43.774Z,1598457043.774 [CBIT](ERROR): Data Fault in component: NAL9602 2020-08-26T15:50:44.155Z,1598457044.155 [NAL9602](INFO): Powering down 2020-08-26T15:50:44.573Z,1598457044.573 [Reporter](INFO): Onboard.Humidity 26.107922 % 2020-08-26T15:50:45.044Z,1598457045.044 [CBIT](INFO): Clearing failed state for component NAL9602 2020-08-26T15:50:45.044Z,1598457045.044 [NAL9602] No Fault, FailCount= 3 2020-08-26T15:50:54.300Z,1598457054.300 [Reporter](INFO): Onboard.Humidity 26.107922 % 2020-08-26T15:51:04.376Z,1598457064.376 [Reporter](INFO): Onboard.Humidity 26.107922 % 2020-08-26T15:51:14.461Z,1598457074.461 [NAL9602](INFO): Powering up NAL9602 2020-08-26T15:51:14.482Z,1598457074.482 [Reporter](INFO): Onboard.Humidity 26.107922 % 2020-08-26T15:51:24.585Z,1598457084.585 [Reporter](INFO): Onboard.Humidity 26.107922 % 2020-08-26T15:51:25.368Z,1598457085.368 [NAL9602](INFO): NAL9602 initialized 2020-08-26T15:51:34.697Z,1598457094.697 [Reporter](INFO): Onboard.Humidity 26.107922 % 2020-08-26T15:51:44.384Z,1598457104.384 [Reporter](INFO): Onboard.Humidity 26.120132 % 2020-08-26T15:51:48.821Z,1598457108.821 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 11 2020-08-26T15:51:48.821Z,1598457108.821 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-08-26T15:51:48.858Z,1598457108.858 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-08-26T15:51:49.236Z,1598457109.236 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-08-26T15:51:49.236Z,1598457109.236 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 11 2020-08-26T15:51:54.481Z,1598457114.481 [Reporter](INFO): Onboard.Humidity 26.107922 % 2020-08-26T15:52:04.586Z,1598457124.586 [Reporter](INFO): Onboard.Humidity 26.120132 % 2020-08-26T15:52:14.682Z,1598457134.682 [Reporter](INFO): Onboard.Humidity 26.120132 % 2020-08-26T15:52:24.390Z,1598457144.390 [Reporter](INFO): Onboard.Humidity 26.120132 % 2020-08-26T15:52:34.485Z,1598457154.485 [Reporter](INFO): Onboard.Humidity 26.120132 % 2020-08-26T15:52:44.593Z,1598457164.593 [Reporter](INFO): Onboard.Humidity 26.120132 % 2020-08-26T15:52:54.677Z,1598457174.677 [Reporter](INFO): Onboard.Humidity 26.120132 % 2020-08-26T15:53:04.772Z,1598457184.772 [Reporter](INFO): Onboard.Humidity 26.120132 % 2020-08-26T15:53:14.489Z,1598457194.489 [Reporter](INFO): Onboard.Humidity 26.120132 % 2020-08-26T15:53:24.561Z,1598457204.561 [Reporter](INFO): Onboard.Humidity 26.120132 % 2020-08-26T15:53:32.649Z,1598457212.649 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2020-08-26T15:53:32.649Z,1598457212.649 [Default:CheckIn:C.Wait] Stopped 2020-08-26T15:53:32.649Z,1598457212.649 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2020-08-26T15:53:32.650Z,1598457212.650 [Default:CheckIn:D] Running Loop=1 2020-08-26T15:53:33.060Z,1598457213.060 [Default:CheckIn:D] Stopped 2020-08-26T15:53:33.060Z,1598457213.060 [Default:CheckIn:E] Running Loop=1 2020-08-26T15:53:33.455Z,1598457213.455 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 31.490731 min 2020-08-26T15:53:33.455Z,1598457213.455 [Default:CheckIn:E] Stopped 2020-08-26T15:53:33.455Z,1598457213.455 [Default:CheckIn](INFO): Completed Default:CheckIn 2020-08-26T15:53:33.455Z,1598457213.455 [Default:CheckIn] Stopped 2020-08-26T15:53:33.456Z,1598457213.456 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2020-08-26T15:53:33.456Z,1598457213.456 [Default:CheckIn](INFO): Running loop #4 2020-08-26T15:53:33.456Z,1598457213.456 [Default:CheckIn] Running Loop=4 2020-08-26T15:53:33.456Z,1598457213.456 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2020-08-26T15:53:33.456Z,1598457213.456 [Default:CheckIn:Read_GPS] Running Loop=1 2020-08-26T15:53:34.685Z,1598457214.685 [Reporter](INFO): Onboard.Humidity 26.120132 % 2020-08-26T15:53:44.768Z,1598457224.768 [Reporter](INFO): Onboard.Humidity 26.120132 % 2020-08-26T15:53:54.500Z,1598457234.500 [Reporter](INFO): Onboard.Humidity 26.095715 % 2020-08-26T15:54:04.568Z,1598457244.568 [Reporter](INFO): Onboard.Humidity 26.120132 % 2020-08-26T15:54:14.681Z,1598457254.681 [Reporter](INFO): Onboard.Humidity 26.095715 % 2020-08-26T15:54:24.782Z,1598457264.782 [Reporter](INFO): Onboard.Humidity 26.120132 % 2020-08-26T15:54:34.522Z,1598457274.522 [Reporter](INFO): Onboard.Humidity 26.095715 % 2020-08-26T15:54:44.557Z,1598457284.557 [Reporter](INFO): Onboard.Humidity 26.095715 % 2020-08-26T15:54:49.818Z,1598457289.818 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 12 2020-08-26T15:54:49.819Z,1598457289.819 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-08-26T15:54:49.829Z,1598457289.829 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-08-26T15:54:50.227Z,1598457290.227 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-08-26T15:54:50.227Z,1598457290.227 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 12 2020-08-26T15:54:54.673Z,1598457294.673 [Reporter](INFO): Onboard.Humidity 26.095715 % 2020-08-26T15:55:04.781Z,1598457304.781 [Reporter](INFO): Onboard.Humidity 26.095715 % 2020-08-26T15:55:14.869Z,1598457314.869 [Reporter](INFO): Onboard.Humidity 26.095715 % 2020-08-26T15:55:24.568Z,1598457324.568 [Reporter](INFO): Onboard.Humidity 26.095715 % 2020-08-26T15:55:34.744Z,1598457334.744 [Reporter](INFO): Onboard.Humidity 26.095715 % 2020-08-26T15:55:44.781Z,1598457344.781 [Reporter](INFO): Onboard.Humidity 26.095715 % 2020-08-26T15:55:54.861Z,1598457354.861 [Reporter](INFO): Onboard.Humidity 26.095715 % 2020-08-26T15:56:04.573Z,1598457364.573 [Reporter](INFO): Onboard.Humidity 26.095715 % 2020-08-26T15:56:14.685Z,1598457374.685 [Reporter](INFO): Onboard.Humidity 26.095715 % 2020-08-26T15:56:24.763Z,1598457384.763 [Reporter](INFO): Onboard.Humidity 26.095715 % 2020-08-26T15:56:34.853Z,1598457394.853 [Reporter](INFO): Onboard.Humidity 26.095715 % 2020-08-26T15:56:44.593Z,1598457404.593 [Reporter](INFO): Onboard.Humidity 26.095715 % 2020-08-26T15:56:54.697Z,1598457414.697 [Reporter](INFO): Onboard.Humidity 26.095715 % 2020-08-26T15:57:04.765Z,1598457424.765 [Reporter](INFO): Onboard.Humidity 26.095715 % 2020-08-26T15:57:14.859Z,1598457434.859 [Reporter](INFO): Onboard.Humidity 26.095715 % 2020-08-26T15:57:24.965Z,1598457444.965 [Reporter](INFO): Onboard.Humidity 26.095715 % 2020-08-26T15:57:34.667Z,1598457454.667 [Reporter](INFO): Onboard.Humidity 26.095715 % 2020-08-26T15:57:44.757Z,1598457464.757 [Reporter](INFO): Onboard.Humidity 26.095715 % 2020-08-26T15:57:50.810Z,1598457470.810 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 13 2020-08-26T15:57:50.810Z,1598457470.810 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-08-26T15:57:50.821Z,1598457470.821 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-08-26T15:57:51.217Z,1598457471.217 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-08-26T15:57:51.217Z,1598457471.217 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 13 2020-08-26T15:57:54.837Z,1598457474.837 [Reporter](INFO): Onboard.Humidity 26.095715 % 2020-08-26T15:58:04.974Z,1598457484.974 [Reporter](INFO): Onboard.Humidity 26.095715 % 2020-08-26T15:58:14.674Z,1598457494.674 [Reporter](INFO): Onboard.Humidity 26.095715 % 2020-08-26T15:58:24.737Z,1598457504.737 [Reporter](INFO): Onboard.Humidity 26.095715 % 2020-08-26T15:58:33.611Z,1598457513.611 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-08-26T15:53:33.5Z 2020-08-26T15:58:33.611Z,1598457513.611 [Default:CheckIn:Read_GPS] Stopped 2020-08-26T15:58:33.611Z,1598457513.611 [Default:CheckIn:Read_Iridium] Running Loop=1 2020-08-26T15:58:34.863Z,1598457514.863 [Reporter](INFO): Onboard.Humidity 26.095715 % 2020-08-26T15:58:35.640Z,1598457515.640 [DAT](INFO): DAT read: Rx Time:15:57:19.5245 2020-08-26T15:58:35.640Z,1598457515.640 [DAT](INFO): received an acoustic signal 2020-08-26T15:58:35.640Z,1598457515.640 [DAT](INFO): DAT read: 2020-08-26T15:58:35.641Z,1598457515.641 [DAT](INFO): DAT read: $Packet for address 0 2020-08-26T15:58:35.642Z,1598457515.642 [DAT](INFO): received a packet notification 2020-08-26T15:58:36.419Z,1598457516.419 [DAT](INFO): #Outgoing data=1 2020-08-26T15:58:36.420Z,1598457516.420 [DAT](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_TRANSMIT 2020-08-26T15:58:36.524Z,1598457516.524 [DAT](DEBUG): In sendingTransmit, set commsState_ = SENDING_TRANSMIT_VERIFY 2020-08-26T15:58:40.085Z,1598457520.085 [DAT](INFO): DAT read: Forwarding Delay UpTx time:15:58:20.0745 2020-08-26T15:58:40.086Z,1598457520.086 [DAT](DEBUG): In parseResponses, set commsState_ = SENDING_ACK_WAITING 2020-08-26T15:58:42.158Z,1598457522.158 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20200826T151826/Courier0013.lzma 2020-08-26T15:58:43.160Z,1598457523.160 [DataOverHttps](INFO): Moved sent file to Logs/20200826T151826/Courier0013.lzma.bak 2020-08-26T15:58:43.160Z,1598457523.160 [DataOverHttps](INFO): SBD MOMSN=12620131 2020-08-26T15:58:44.996Z,1598457524.996 [Reporter](INFO): Onboard.Humidity 26.095715 % 2020-08-26T15:58:54.682Z,1598457534.682 [Reporter](INFO): Onboard.Humidity 26.095715 % 2020-08-26T15:58:56.663Z,1598457536.663 [DAT](FAULT): Ack receipt timeout failure. 2020-08-26T15:58:56.663Z,1598457536.663 [DAT](DEBUG): In sendingAckWaiting, hit max timeouts so set commsState_ = SENDING_VERIFIED 2020-08-26T15:58:57.071Z,1598457537.071 [DAT](INFO): Sent 39 bytes from file Logs/20200826T151826/Courier0013.lzma.parts 2020-08-26T15:58:57.071Z,1598457537.071 [DAT](INFO): Packets left to send: 0 2020-08-26T15:58:57.074Z,1598457537.074 [DAT](DEBUG): In sendingVerified, sbd waiting so set commsState_ = SENDING_FILL_BUFFER 2020-08-26T15:58:59.019Z,1598457539.019 [Default:CheckIn:Read_Iridium] Stopped 2020-08-26T15:58:59.019Z,1598457539.019 [Default:CheckIn:C.Wait] Running Loop=1 2020-08-26T15:58:59.019Z,1598457539.019 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2020-08-26T15:59:01.094Z,1598457541.094 [DataOverHttps](INFO): Sending 213 bytes from file Logs/20200826T151826/Express0005.lzma 2020-08-26T15:59:02.096Z,1598457542.096 [DataOverHttps](INFO): Moved sent file to Logs/20200826T151826/Express0005.lzma.bak 2020-08-26T15:59:02.096Z,1598457542.096 [DataOverHttps](INFO): SBD MOMSN=12620133 2020-08-26T15:59:04.749Z,1598457544.749 [Reporter](INFO): Onboard.Humidity 26.095715 % 2020-08-26T15:59:14.844Z,1598457554.844 [Reporter](INFO): Onboard.Humidity 26.095715 % 2020-08-26T15:59:25.072Z,1598457565.072 [Reporter](INFO): Onboard.Humidity 26.095715 % 2020-08-26T15:59:35.029Z,1598457575.029 [Reporter](INFO): Onboard.Humidity 26.095715 % 2020-08-26T15:59:44.756Z,1598457584.756 [Reporter](INFO): Onboard.Humidity 26.095715 % 2020-08-26T15:59:54.821Z,1598457594.821 [Reporter](INFO): Onboard.Humidity 26.095715 % 2020-08-26T16:00:04.964Z,1598457604.964 [Reporter](INFO): Onboard.Humidity 26.095715 % 2020-08-26T16:00:15.032Z,1598457615.032 [Reporter](INFO): Onboard.Humidity 26.071299 % 2020-08-26T16:00:25.128Z,1598457625.128 [Reporter](INFO): Onboard.Humidity 26.071299 % 2020-08-26T16:00:34.840Z,1598457634.840 [Reporter](INFO): Onboard.Humidity 26.095715 % 2020-08-26T16:00:44.921Z,1598457644.921 [Reporter](INFO): Onboard.Humidity 26.071299 % 2020-08-26T16:00:51.799Z,1598457651.799 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 14 2020-08-26T16:00:51.799Z,1598457651.799 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-08-26T16:00:51.817Z,1598457651.817 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-08-26T16:00:52.206Z,1598457652.206 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-08-26T16:00:52.206Z,1598457652.206 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 14 2020-08-26T16:00:55.057Z,1598457655.057 [Reporter](INFO): Onboard.Humidity 26.071299 % 2020-08-26T16:01:05.132Z,1598457665.132 [Reporter](INFO): Onboard.Humidity 26.071299 % 2020-08-26T16:01:14.831Z,1598457674.831 [Reporter](INFO): Onboard.Humidity 26.071299 % 2020-08-26T16:01:24.952Z,1598457684.952 [Reporter](INFO): Onboard.Humidity 26.071299 % 2020-08-26T16:01:27.324Z,1598457687.324 [NAL9602](FAULT): GPS failed to acquire within timeout. 2020-08-26T16:01:27.324Z,1598457687.324 [NAL9602] Data Fault, FailCount= 4 2020-08-26T16:01:27.324Z,1598457687.324 [NAL9602](ERROR): Data Fault 2020-08-26T16:01:27.379Z,1598457687.379 [CBIT](ERROR): Data Fault in component: NAL9602 2020-08-26T16:01:27.727Z,1598457687.727 [NAL9602](INFO): Powering down 2020-08-26T16:01:28.572Z,1598457688.572 [CBIT](INFO): Clearing failed state for component NAL9602 2020-08-26T16:01:28.572Z,1598457688.572 [NAL9602] No Fault, FailCount= 4 2020-08-26T16:01:35.020Z,1598457695.020 [Reporter](INFO): Onboard.Humidity 26.071299 % 2020-08-26T16:01:45.124Z,1598457705.124 [Reporter](INFO): Onboard.Humidity 26.071299 % 2020-08-26T16:01:54.860Z,1598457714.860 [Reporter](INFO): Onboard.Humidity 26.071299 % 2020-08-26T16:01:58.035Z,1598457718.035 [NAL9602](INFO): Powering up NAL9602 2020-08-26T16:02:04.924Z,1598457724.924 [Reporter](INFO): Onboard.Humidity 26.071299 % 2020-08-26T16:02:08.940Z,1598457728.940 [NAL9602](INFO): NAL9602 initialized 2020-08-26T16:02:15.037Z,1598457735.037 [Reporter](INFO): Onboard.Humidity 26.071299 % 2020-08-26T16:02:25.130Z,1598457745.130 [Reporter](INFO): Onboard.Humidity 26.071299 % 2020-08-26T16:02:35.237Z,1598457755.237 [Reporter](INFO): Onboard.Humidity 26.071299 % 2020-08-26T16:02:44.932Z,1598457764.932 [Reporter](INFO): Onboard.Humidity 26.071299 % 2020-08-26T16:02:55.031Z,1598457775.031 [Reporter](INFO): Onboard.Humidity 26.071299 % 2020-08-26T16:03:05.113Z,1598457785.113 [Reporter](INFO): Onboard.Humidity 26.071299 % 2020-08-26T16:03:15.248Z,1598457795.248 [Reporter](INFO): Onboard.Humidity 26.071299 % 2020-08-26T16:03:24.947Z,1598457804.947 [Reporter](INFO): Onboard.Humidity 26.071299 % 2020-08-26T16:03:35.005Z,1598457815.005 [Reporter](INFO): Onboard.Humidity 26.071299 % 2020-08-26T16:03:45.109Z,1598457825.109 [Reporter](INFO): Onboard.Humidity 26.071299 % 2020-08-26T16:03:52.798Z,1598457832.798 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 15 2020-08-26T16:03:52.798Z,1598457832.798 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-08-26T16:03:52.809Z,1598457832.809 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-08-26T16:03:53.187Z,1598457833.187 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-08-26T16:03:53.187Z,1598457833.187 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 15 2020-08-26T16:03:55.241Z,1598457835.241 [Reporter](INFO): Onboard.Humidity 26.071299 % 2020-08-26T16:03:59.253Z,1598457839.253 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2020-08-26T16:03:59.253Z,1598457839.253 [Default:CheckIn:C.Wait] Stopped 2020-08-26T16:03:59.253Z,1598457839.253 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2020-08-26T16:03:59.253Z,1598457839.253 [Default:CheckIn:D] Running Loop=1 2020-08-26T16:03:59.669Z,1598457839.669 [Default:CheckIn:D] Stopped 2020-08-26T16:03:59.669Z,1598457839.669 [Default:CheckIn:E] Running Loop=1 2020-08-26T16:04:00.048Z,1598457840.048 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 41.934212 min 2020-08-26T16:04:00.048Z,1598457840.048 [Default:CheckIn:E] Stopped 2020-08-26T16:04:00.048Z,1598457840.048 [Default:CheckIn](INFO): Completed Default:CheckIn 2020-08-26T16:04:00.048Z,1598457840.048 [Default:CheckIn] Stopped 2020-08-26T16:04:00.048Z,1598457840.048 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2020-08-26T16:04:00.048Z,1598457840.048 [Default:CheckIn](INFO): Running loop #5 2020-08-26T16:04:00.048Z,1598457840.048 [Default:CheckIn] Running Loop=5 2020-08-26T16:04:00.048Z,1598457840.048 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2020-08-26T16:04:00.049Z,1598457840.049 [Default:CheckIn:Read_GPS] Running Loop=1 2020-08-26T16:04:04.966Z,1598457844.966 [Reporter](INFO): Onboard.Humidity 26.071299 % 2020-08-26T16:04:15.009Z,1598457855.009 [Reporter](INFO): Onboard.Humidity 26.071299 % 2020-08-26T16:04:25.109Z,1598457865.109 [Reporter](INFO): Onboard.Humidity 26.046881 % 2020-08-26T16:04:35.229Z,1598457875.229 [Reporter](INFO): Onboard.Humidity 26.071299 % 2020-08-26T16:04:45.306Z,1598457885.306 [Reporter](INFO): Onboard.Humidity 26.071299 % 2020-08-26T16:04:55.025Z,1598457895.025 [Reporter](INFO): Onboard.Humidity 26.046881 % 2020-08-26T16:05:05.114Z,1598457905.114 [Reporter](INFO): Onboard.Humidity 26.071299 % 2020-08-26T16:05:15.226Z,1598457915.226 [Reporter](INFO): Onboard.Humidity 26.071299 % 2020-08-26T16:05:25.300Z,1598457925.300 [Reporter](INFO): Onboard.Humidity 26.046881 % 2020-08-26T16:05:35.065Z,1598457935.065 [Reporter](INFO): Onboard.Humidity 26.046881 % 2020-08-26T16:05:45.105Z,1598457945.105 [Reporter](INFO): Onboard.Humidity 26.071299 % 2020-08-26T16:05:55.261Z,1598457955.261 [Reporter](INFO): Onboard.Humidity 26.071299 % 2020-08-26T16:06:05.315Z,1598457965.315 [Reporter](INFO): Onboard.Humidity 26.071299 % 2020-08-26T16:06:15.409Z,1598457975.409 [Reporter](INFO): Onboard.Humidity 26.046881 % 2020-08-26T16:06:25.107Z,1598457985.107 [Reporter](INFO): Onboard.Humidity 26.071299 % 2020-08-26T16:06:35.198Z,1598457995.198 [Reporter](INFO): Onboard.Humidity 26.071299 % 2020-08-26T16:06:45.317Z,1598458005.317 [Reporter](INFO): Onboard.Humidity 26.071299 % 2020-08-26T16:06:53.770Z,1598458013.770 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 16 2020-08-26T16:06:53.770Z,1598458013.770 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-08-26T16:06:53.780Z,1598458013.780 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-08-26T16:06:54.188Z,1598458014.188 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-08-26T16:06:54.188Z,1598458014.188 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 16 2020-08-26T16:06:55.411Z,1598458015.411 [Reporter](INFO): Onboard.Humidity 26.071299 % 2020-08-26T16:07:05.131Z,1598458025.131 [Reporter](INFO): Onboard.Humidity 26.071299 % 2020-08-26T16:07:15.189Z,1598458035.189 [Reporter](INFO): Onboard.Humidity 26.071299 % 2020-08-26T16:07:25.289Z,1598458045.289 [Reporter](INFO): Onboard.Humidity 26.046881 % 2020-08-26T16:07:35.419Z,1598458055.419 [Reporter](INFO): Onboard.Humidity 26.046881 % 2020-08-26T16:07:45.488Z,1598458065.488 [Reporter](INFO): Onboard.Humidity 26.046881 % 2020-08-26T16:07:55.205Z,1598458075.205 [Reporter](INFO): Onboard.Humidity 26.046881 % 2020-08-26T16:08:05.288Z,1598458085.288 [Reporter](INFO): Onboard.Humidity 26.046881 % 2020-08-26T16:08:15.399Z,1598458095.399 [Reporter](INFO): Onboard.Humidity 26.046881 % 2020-08-26T16:08:25.497Z,1598458105.497 [Reporter](INFO): Onboard.Humidity 26.046881 % 2020-08-26T16:08:35.242Z,1598458115.242 [Reporter](INFO): Onboard.Humidity 26.046881 % 2020-08-26T16:08:45.296Z,1598458125.296 [Reporter](INFO): Onboard.Humidity 26.046881 % 2020-08-26T16:08:55.409Z,1598458135.409 [Reporter](INFO): Onboard.Humidity 26.046881 % 2020-08-26T16:09:00.245Z,1598458140.245 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-08-26T16:04:00.0Z 2020-08-26T16:09:00.245Z,1598458140.245 [Default:CheckIn:Read_GPS] Stopped 2020-08-26T16:09:00.245Z,1598458140.245 [Default:CheckIn:Read_Iridium] Running Loop=1 2020-08-26T16:09:02.231Z,1598458142.231 [DAT](INFO): DAT read: Rx Time:16:01:00.8777 2020-08-26T16:09:02.231Z,1598458142.231 [DAT](INFO): received an acoustic signal 2020-08-26T16:09:02.232Z,1598458142.232 [DAT](INFO): DAT read: 2020-08-26T16:09:02.235Z,1598458142.235 [DAT](INFO): DAT read: $Packet for address 0 2020-08-26T16:09:02.235Z,1598458142.235 [DAT](INFO): received a packet notification 2020-08-26T16:09:03.009Z,1598458143.009 [DAT](INFO): #Outgoing data=1 2020-08-26T16:09:03.009Z,1598458143.009 [DAT](DEBUG): In sendingFillBuffer, set commsState_ = SENDING_TRANSMIT 2020-08-26T16:09:03.094Z,1598458143.094 [DAT](DEBUG): In sendingTransmit, set commsState_ = SENDING_TRANSMIT_VERIFY 2020-08-26T16:09:05.518Z,1598458145.518 [Reporter](INFO): Onboard.Humidity 26.046881 % 2020-08-26T16:09:06.681Z,1598458146.681 [DAT](INFO): DAT read: Forwarding Delay UpTx time:16:08:46.6214 2020-08-26T16:09:06.682Z,1598458146.682 [DAT](DEBUG): In parseResponses, set commsState_ = SENDING_ACK_WAITING 2020-08-26T16:09:07.442Z,1598458147.442 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20200826T151826/Courier0016.lzma 2020-08-26T16:09:08.445Z,1598458148.445 [DataOverHttps](INFO): Moved sent file to Logs/20200826T151826/Courier0016.lzma.bak 2020-08-26T16:09:08.445Z,1598458148.445 [DataOverHttps](INFO): SBD MOMSN=12620171 2020-08-26T16:09:15.625Z,1598458155.625 [Reporter](INFO): Onboard.Humidity 26.046881 % 2020-08-26T16:09:23.255Z,1598458163.255 [DAT](FAULT): Ack receipt timeout failure. 2020-08-26T16:09:23.255Z,1598458163.255 [DAT](DEBUG): In sendingAckWaiting, hit max timeouts so set commsState_ = SENDING_VERIFIED 2020-08-26T16:09:23.656Z,1598458163.656 [DAT](INFO): Sent 39 bytes from file Logs/20200826T151826/Courier0016.lzma.parts 2020-08-26T16:09:23.656Z,1598458163.656 [DAT](INFO): Packets left to send: 0 2020-08-26T16:09:23.658Z,1598458163.658 [DAT](DEBUG): In sendingVerified, sbd waiting so set commsState_ = SENDING_FILL_BUFFER 2020-08-26T16:09:25.169Z,1598458165.169 [Default:CheckIn:Read_Iridium] Stopped 2020-08-26T16:09:25.169Z,1598458165.169 [Default:CheckIn:C.Wait] Running Loop=1 2020-08-26T16:09:25.169Z,1598458165.169 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2020-08-26T16:09:25.272Z,1598458165.272 [Reporter](INFO): Onboard.Humidity 26.046881 % 2020-08-26T16:09:25.823Z,1598458165.823 [DataOverHttps](INFO): Sending 208 bytes from file Logs/20200826T151826/Express0008.lzma 2020-08-26T16:09:26.824Z,1598458166.824 [DataOverHttps](INFO): Moved sent file to Logs/20200826T151826/Express0008.lzma.bak 2020-08-26T16:09:26.824Z,1598458166.824 [DataOverHttps](INFO): SBD MOMSN=12620173 2020-08-26T16:09:35.328Z,1598458175.328 [Reporter](INFO): Onboard.Humidity 26.046881 % 2020-08-26T16:09:45.416Z,1598458185.416 [Reporter](INFO): Onboard.Humidity 26.046881 % 2020-08-26T16:09:54.759Z,1598458194.759 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 17 2020-08-26T16:09:54.759Z,1598458194.759 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-08-26T16:09:54.785Z,1598458194.785 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-08-26T16:09:55.107Z,1598458195.107 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-08-26T16:09:55.108Z,1598458195.108 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 17 2020-08-26T16:09:55.509Z,1598458195.509 [Reporter](INFO): Onboard.Humidity 26.046881 % 2020-08-26T16:10:05.297Z,1598458205.297 [Reporter](INFO): Onboard.Humidity 26.046881 % 2020-08-26T16:10:15.317Z,1598458215.317 [Reporter](INFO): Onboard.Humidity 26.046881 % 2020-08-26T16:10:25.410Z,1598458225.410 [Reporter](INFO): Onboard.Humidity 26.046881 % 2020-08-26T16:10:35.513Z,1598458235.513 [Reporter](INFO): Onboard.Humidity 26.046881 % 2020-08-26T16:10:45.659Z,1598458245.659 [Reporter](INFO): Onboard.Humidity 26.046881 % 2020-08-26T16:10:55.347Z,1598458255.347 [Reporter](INFO): Onboard.Humidity 26.046881 % 2020-08-26T16:11:05.412Z,1598458265.412 [Reporter](INFO): Onboard.Humidity 26.046881 % 2020-08-26T16:11:15.557Z,1598458275.557 [Reporter](INFO): Onboard.Humidity 26.046881 % 2020-08-26T16:11:25.651Z,1598458285.651 [Reporter](INFO): Onboard.Humidity 26.046881 % 2020-08-26T16:11:35.713Z,1598458295.713 [Reporter](INFO): Onboard.Humidity 26.046881 % 2020-08-26T16:11:45.408Z,1598458305.408 [Reporter](INFO): Onboard.Humidity 26.046881 % 2020-08-26T16:11:55.509Z,1598458315.509 [Reporter](INFO): Onboard.Humidity 26.046881 % 2020-08-26T16:12:05.633Z,1598458325.633 [Reporter](INFO): Onboard.Humidity 26.046881 % 2020-08-26T16:12:10.853Z,1598458330.853 [NAL9602](FAULT): GPS failed to acquire within timeout. 2020-08-26T16:12:10.853Z,1598458330.853 [NAL9602] Data Fault, FailCount= 5 2020-08-26T16:12:10.853Z,1598458330.853 [NAL9602](ERROR): Data Fault 2020-08-26T16:12:10.869Z,1598458330.869 [CBIT](ERROR): Data Fault in component: NAL9602 2020-08-26T16:12:10.869Z,1598458330.869 [CBIT](CRITICAL): Data Fault in component: NAL9602 2020-08-26T16:12:11.247Z,1598458331.247 [NAL9602](INFO): Powering down 2020-08-26T16:12:11.286Z,1598458331.286 [CommandLine](FAULT): Scheduling is paused 2020-08-26T16:12:11.287Z,1598458331.287 [CBIT](INFO): Critical error at 20200826T161210 2020-08-26T16:12:11.287Z,1598458331.287 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2020-08-26T16:12:11.652Z,1598458331.652 [NAL9602](FAULT): LCB fault: Software Overcurrent. 2020-08-26T16:12:11.652Z,1598458331.652 [NAL9602] Hardware Fault, FailCount= 5 2020-08-26T16:12:11.652Z,1598458331.652 [NAL9602](ERROR): Hardware Fault 2020-08-26T16:12:15.713Z,1598458335.713 [Reporter](INFO): Onboard.Humidity 26.028568 % 2020-08-26T16:12:25.429Z,1598458345.429 [Reporter](INFO): Onboard.Humidity 26.046881 % 2020-08-26T16:12:35.512Z,1598458355.512 [Reporter](INFO): Onboard.Humidity 26.028568 % 2020-08-26T16:12:45.613Z,1598458365.613 [Reporter](INFO): Onboard.Humidity 26.028568 % 2020-08-26T16:12:55.706Z,1598458375.706 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 18 2020-08-26T16:12:55.706Z,1598458375.706 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-08-26T16:12:55.717Z,1598458375.717 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-08-26T16:12:55.718Z,1598458375.718 [Reporter](INFO): Onboard.Humidity 26.046881 % 2020-08-26T16:12:56.127Z,1598458376.127 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-08-26T16:12:56.127Z,1598458376.127 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 18 2020-08-26T16:13:05.805Z,1598458385.805 [Reporter](INFO): Onboard.Humidity 26.046881 % 2020-08-26T16:13:15.540Z,1598458395.540 [Reporter](INFO): Onboard.Humidity 26.046881 % 2020-08-26T16:13:25.600Z,1598458405.600 [Reporter](INFO): Onboard.Humidity 26.046881 % 2020-08-26T16:13:35.728Z,1598458415.728 [Reporter](INFO): Onboard.Humidity 26.028568 % 2020-08-26T16:13:45.512Z,1598458425.512 [Reporter](INFO): Onboard.Humidity 26.028568 % 2020-08-26T16:13:55.544Z,1598458435.544 [Reporter](INFO): Onboard.Humidity 26.028568 % 2020-08-26T16:14:05.617Z,1598458445.617 [Reporter](INFO): Onboard.Humidity 26.028568 % 2020-08-26T16:14:10.883Z,1598458450.883 [CBIT](INFO): Clearing failed state for component NAL9602 2020-08-26T16:14:10.883Z,1598458450.883 [NAL9602] No Fault, FailCount= 5 2020-08-26T16:14:11.268Z,1598458451.268 [NAL9602](INFO): Powering up NAL9602 2020-08-26T16:14:15.765Z,1598458455.765 [Reporter](INFO): Onboard.Humidity 26.028568 % 2020-08-26T16:14:22.172Z,1598458462.172 [NAL9602](INFO): NAL9602 initialized 2020-08-26T16:14:25.435Z,1598458465.435 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2020-08-26T16:14:25.435Z,1598458465.435 [Default:CheckIn:C.Wait] Stopped 2020-08-26T16:14:25.435Z,1598458465.435 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2020-08-26T16:14:25.436Z,1598458465.436 [Default:CheckIn:D] Running Loop=1 2020-08-26T16:14:25.844Z,1598458465.844 [Default:CheckIn:D] Stopped 2020-08-26T16:14:25.844Z,1598458465.844 [Default:CheckIn:E] Running Loop=1 2020-08-26T16:14:25.873Z,1598458465.873 [Reporter](INFO): Onboard.Humidity 26.046881 % 2020-08-26T16:14:26.228Z,1598458466.228 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 52.370471 min 2020-08-26T16:14:26.228Z,1598458466.228 [Default:CheckIn:E] Stopped 2020-08-26T16:14:26.228Z,1598458466.228 [Default:CheckIn](INFO): Completed Default:CheckIn 2020-08-26T16:14:26.228Z,1598458466.228 [Default:CheckIn] Stopped 2020-08-26T16:14:26.228Z,1598458466.228 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2020-08-26T16:14:26.229Z,1598458466.229 [Default:CheckIn](INFO): Running loop #6 2020-08-26T16:14:26.229Z,1598458466.229 [Default:CheckIn] Running Loop=6 2020-08-26T16:14:26.229Z,1598458466.229 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2020-08-26T16:14:26.229Z,1598458466.229 [Default:CheckIn:Read_GPS] Running Loop=1 2020-08-26T16:14:35.558Z,1598458475.558 [Reporter](INFO): Onboard.Humidity 26.046881 % 2020-08-26T16:14:45.689Z,1598458485.689 [Reporter](INFO): Onboard.Humidity 26.046881 % 2020-08-26T16:14:55.735Z,1598458495.735 [Reporter](INFO): Onboard.Humidity 26.046881 % 2020-08-26T16:15:05.824Z,1598458505.824 [Reporter](INFO): Onboard.Humidity 26.028568 % 2020-08-26T16:15:15.534Z,1598458515.534 [Reporter](INFO): Onboard.Humidity 26.028568 % 2020-08-26T16:15:25.641Z,1598458525.641 [Reporter](INFO): Onboard.Humidity 26.046881 % 2020-08-26T16:15:35.779Z,1598458535.779 [Reporter](INFO): Onboard.Humidity 26.028568 % 2020-08-26T16:15:45.824Z,1598458545.824 [Reporter](INFO): Onboard.Humidity 26.028568 % 2020-08-26T16:15:55.917Z,1598458555.917 [Reporter](INFO): Onboard.Humidity 26.028568 % 2020-08-26T16:15:56.730Z,1598458556.730 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 19 2020-08-26T16:15:56.730Z,1598458556.730 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-08-26T16:15:56.741Z,1598458556.741 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-08-26T16:15:57.146Z,1598458557.146 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-08-26T16:15:57.146Z,1598458557.146 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 19 2020-08-26T16:16:05.651Z,1598458565.651 [Reporter](INFO): Onboard.Humidity 26.028568 % 2020-08-26T16:16:15.719Z,1598458575.719 [Reporter](INFO): Onboard.Humidity 26.028568 % 2020-08-26T16:16:25.824Z,1598458585.824 [Reporter](INFO): Onboard.Humidity 26.028568 % 2020-08-26T16:16:35.905Z,1598458595.905 [Reporter](INFO): Onboard.Humidity 26.016361 % 2020-08-26T16:16:45.653Z,1598458605.653 [Reporter](INFO): Onboard.Humidity 26.028568 % 2020-08-26T16:16:55.706Z,1598458615.706 [Reporter](INFO): Onboard.Humidity 26.028568 % 2020-08-26T16:17:05.809Z,1598458625.809 [Reporter](INFO): Onboard.Humidity 26.028568 % 2020-08-26T16:17:15.910Z,1598458635.910 [Reporter](INFO): Onboard.Humidity 26.016361 % 2020-08-26T16:17:25.652Z,1598458645.652 [Reporter](INFO): Onboard.Humidity 26.016361 % 2020-08-26T16:17:35.724Z,1598458655.724 [Reporter](INFO): Onboard.Humidity 26.016361 % 2020-08-26T16:17:45.825Z,1598458665.825 [Reporter](INFO): Onboard.Humidity 26.016361 % 2020-08-26T16:17:55.928Z,1598458675.928 [Reporter](INFO): Onboard.Humidity 26.016361 % 2020-08-26T16:18:02.893Z,1598458682.893 [CommandLine](IMPORTANT): got command configSet BackSeatDriver.loadAtStartup 1.000000 bool persist 2020-08-26T16:18:02.894Z,1598458682.894 [CommandLine](IMPORTANT): configSet BackSeatDriver.loadAtStartup requires a restart to take effect. 2020-08-26T16:18:06.001Z,1598458686.001 [Reporter](INFO): Onboard.Humidity 26.016361 % 2020-08-26T16:18:15.736Z,1598458695.736 [Reporter](INFO): Onboard.Humidity 26.016361 % 2020-08-26T16:18:25.831Z,1598458705.831 [Reporter](INFO): Onboard.Humidity 26.016361 % 2020-08-26T16:18:35.933Z,1598458715.933 [Reporter](INFO): Onboard.Humidity 26.016361 % 2020-08-26T16:18:46.004Z,1598458726.004 [Reporter](INFO): Onboard.Humidity 26.016361 % 2020-08-26T16:18:55.756Z,1598458735.756 [Reporter](INFO): Onboard.Humidity 26.016361 % 2020-08-26T16:18:57.710Z,1598458737.710 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 20 2020-08-26T16:18:57.710Z,1598458737.710 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-08-26T16:18:57.733Z,1598458737.733 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-08-26T16:18:58.143Z,1598458738.143 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-08-26T16:18:58.143Z,1598458738.143 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 20 2020-08-26T16:19:05.816Z,1598458745.816 [Reporter](INFO): Onboard.Humidity 26.004150 % 2020-08-26T16:19:15.907Z,1598458755.907 [Reporter](INFO): Onboard.Humidity 26.016361 % 2020-08-26T16:19:25.993Z,1598458765.993 [Reporter](INFO): Onboard.Humidity 26.004150 % 2020-08-26T16:19:26.391Z,1598458766.391 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-08-26T16:14:26.2Z 2020-08-26T16:19:26.392Z,1598458766.392 [Default:CheckIn:Read_GPS] Stopped 2020-08-26T16:19:26.392Z,1598458766.392 [Default:CheckIn:Read_Iridium] Running Loop=1 2020-08-26T16:19:28.412Z,1598458768.412 [DAT](INFO): DAT read: Rx Time:16:10:32.6856 2020-08-26T16:19:28.412Z,1598458768.412 [DAT](INFO): received an acoustic signal 2020-08-26T16:19:28.413Z,1598458768.413 [DAT](INFO): DAT read: 2020-08-26T16:19:28.416Z,1598458768.416 [DAT](INFO): DAT read: DATA(0002):~~ 2020-08-26T16:19:28.416Z,1598458768.416 [DAT](INFO): Got DATA 2 2020-08-26T16:19:28.421Z,1598458768.421 [DAT](INFO): DAT read: Source:006 Destination:009 2020-08-26T16:19:28.421Z,1598458768.421 [DAT](INFO): Got Src/Dest after DATA 2020-08-26T16:19:28.421Z,1598458768.421 [DAT](INFO): DATA Src=6, Dst=9 2020-08-26T16:19:28.430Z,1598458768.430 [DAT](INFO): DAT read: CRC:Pass MPD:14.2 PSNR:15.9 AGC:77 SPD:-00.1 CCERR:010 2020-08-26T16:19:28.430Z,1598458768.430 [DAT](INFO): Got CRC:Pass 2020-08-26T16:19:28.430Z,1598458768.430 [DAT](INFO): Got CRC:Pass 2020-08-26T16:19:28.430Z,1598458768.430 [DAT](INFO): Incoming data is intended for us 2020-08-26T16:19:28.430Z,1598458768.430 [DAT](INFO): Got ack 2020-08-26T16:19:28.431Z,1598458768.431 [DAT](INFO): DAT read: 2020-08-26T16:19:28.432Z,1598458768.432 [DAT](INFO): DAT read: 2020-08-26T16:19:28.436Z,1598458768.436 [DAT](INFO): DAT read: Rx Time:16:10:35.9356 2020-08-26T16:19:28.437Z,1598458768.437 [DAT](INFO): received an acoustic signal 2020-08-26T16:19:28.508Z,1598458768.508 [DAT](INFO): DAT read: 16:10:35.9356 LVL= 13984, 18065, 22434, 32755, AGC= 71, IDX= 369,-0.04,-1.282,-3.018,-2.136,-0.743, PHS=-0.505,-2.245,-1.321, RAW= 122.1, 43.7, CAL= 121.5, 49.7, ROT= 13.5, -49.7 2020-08-26T16:19:28.509Z,1598458768.509 [DAT](INFO): got valid direction response: 16:10:35.9356 LVL= 13984, 18065, 22434, 32755, AGC= 71, IDX= 369,-0.04,-1.282,-3.018,-2.136,-0.743, PHS=-0.505,-2.245,-1.321, RAW= 122.1, 43.7, CAL= 121.5, 49.7, ROT= 13.5, -49.7 2020-08-26T16:19:28.509Z,1598458768.509 [DAT](INFO): DAT read: 2020-08-26T16:19:28.552Z,1598458768.552 [DAT](INFO): DAT read: DATA(0034):set _.pressure 0.542838 atmosphere 2020-08-26T16:19:28.552Z,1598458768.552 [DAT](INFO): Got DATA 34 2020-08-26T16:19:28.564Z,1598458768.564 [DAT](INFO): DAT read: Source:006 Destination:009 2020-08-26T16:19:28.564Z,1598458768.564 [DAT](INFO): Got Src/Dest after DATA 2020-08-26T16:19:28.565Z,1598458768.565 [DAT](INFO): DATA Src=6, Dst=9 2020-08-26T16:19:28.584Z,1598458768.584 [DAT](INFO): DAT read: CRC:Pass MPD:14.1 PSNR:13.2 AGC:77 SPD:-00.3 CCERR:010 2020-08-26T16:19:28.584Z,1598458768.584 [DAT](INFO): Got CRC:Pass 2020-08-26T16:19:28.584Z,1598458768.584 [DAT](INFO): Got CRC:Pass 2020-08-26T16:19:28.584Z,1598458768.584 [DAT](INFO): Incoming data is intended for us 2020-08-26T16:19:28.585Z,1598458768.585 [DAT](INFO): Received command:set _.pressure 0.542838 atmosphere 2020-08-26T16:19:29.583Z,1598458769.583 [CommandLine](IMPORTANT): got command set _.pressure 0.542838 atmosphere 2020-08-26T16:19:29.607Z,1598458769.607 [DAT](INFO): Sending ack 2020-08-26T16:19:29.607Z,1598458769.607 [DAT](INFO): DAT read: 2020-08-26T16:19:29.609Z,1598458769.609 [DAT](INFO): DAT read: 2020-08-26T16:19:29.623Z,1598458769.624 [DAT](INFO): DAT read: Rx Time:16:10:57.3359 2020-08-26T16:19:29.624Z,1598458769.624 [DAT](INFO): received an acoustic signal 2020-08-26T16:19:29.624Z,1598458769.624 [DAT](INFO): DAT read: 2020-08-26T16:19:29.630Z,1598458769.630 [DAT](INFO): DAT read: DATA(0035):set _.temperature 26.596277 celsius 2020-08-26T16:19:29.630Z,1598458769.630 [DAT](INFO): Got DATA 35 2020-08-26T16:19:29.633Z,1598458769.633 [DAT](INFO): DAT read: Source:006 Destination:009 2020-08-26T16:19:29.633Z,1598458769.633 [DAT](INFO): Got Src/Dest after DATA 2020-08-26T16:19:29.634Z,1598458769.634 [DAT](INFO): DATA Src=6, Dst=9 2020-08-26T16:19:29.689Z,1598458769.689 [DAT](INFO): DAT read: CRC:Pass MPD:12.7 PSNR:13.8 AGC:76 SPD:+00.0 CCERR:010 2020-08-26T16:19:29.690Z,1598458769.690 [DAT](INFO): Got CRC:Pass 2020-08-26T16:19:29.690Z,1598458769.690 [DAT](INFO): Got CRC:Pass 2020-08-26T16:19:29.690Z,1598458769.690 [DAT](INFO): Incoming data is intended for us 2020-08-26T16:19:29.702Z,1598458769.702 [DAT](INFO): Received command:set _.temperature 26.596277 celsius 2020-08-26T16:19:31.241Z,1598458771.241 [CommandLine](IMPORTANT): got command set _.temperature 26.596277 celsius 2020-08-26T16:19:31.245Z,1598458771.245 [DAT](INFO): Sending ack 2020-08-26T16:19:31.245Z,1598458771.245 [DAT](INFO): DAT read: 2020-08-26T16:19:31.258Z,1598458771.258 [DAT](INFO): DAT read: 2020-08-26T16:19:31.261Z,1598458771.261 [DAT](INFO): DAT read: Rx Time:16:11:18.7362 2020-08-26T16:19:31.261Z,1598458771.261 [DAT](INFO): received an acoustic signal 2020-08-26T16:19:31.261Z,1598458771.261 [DAT](INFO): DAT read: 2020-08-26T16:19:31.266Z,1598458771.266 [DAT](INFO): DAT read: DATA(0031):set _.humidity 7.703577 percent 2020-08-26T16:19:31.266Z,1598458771.266 [DAT](INFO): Got DATA 31 2020-08-26T16:19:31.269Z,1598458771.269 [DAT](INFO): DAT read: Source:006 Destination:009 2020-08-26T16:19:31.269Z,1598458771.269 [DAT](INFO): Got Src/Dest after DATA 2020-08-26T16:19:31.270Z,1598458771.270 [DAT](INFO): DATA Src=6, Dst=9 2020-08-26T16:19:31.348Z,1598458771.348 [DAT](INFO): DAT read: CRC:Pass MPD:11.5 PSNR:14.2 AGC:77 SPD:+00.0 CCERR:010 2020-08-26T16:19:31.348Z,1598458771.348 [DAT](INFO): Got CRC:Pass 2020-08-26T16:19:31.348Z,1598458771.348 [DAT](INFO): Got CRC:Pass 2020-08-26T16:19:31.348Z,1598458771.348 [DAT](INFO): Incoming data is intended for us 2020-08-26T16:19:31.348Z,1598458771.348 [DAT](INFO): Received command:set _.humidity 7.703577 percent 2020-08-26T16:19:32.520Z,1598458772.520 [CommandLine](IMPORTANT): got command set _.humidity 7.703577 percent 2020-08-26T16:19:32.524Z,1598458772.524 [DAT](INFO): Sending ack 2020-08-26T16:19:32.524Z,1598458772.524 [DAT](INFO): DAT read: 2020-08-26T16:19:32.525Z,1598458772.525 [DAT](INFO): DAT read: 2020-08-26T16:19:32.527Z,1598458772.527 [DAT](INFO): DAT read: Rx Time:16:13:43.7882 2020-08-26T16:19:32.528Z,1598458772.528 [DAT](INFO): received an acoustic signal 2020-08-26T16:19:32.528Z,1598458772.528 [DAT](INFO): DAT read: 2020-08-26T16:19:32.586Z,1598458772.586 [DAT](INFO): DAT read: DATA(0034):set _.pressure 0.544052 atmosphere 2020-08-26T16:19:32.587Z,1598458772.587 [DAT](INFO): Got DATA 34 2020-08-26T16:19:32.589Z,1598458772.589 [DAT](INFO): DAT read: Source:006 Destination:009 2020-08-26T16:19:32.589Z,1598458772.589 [DAT](INFO): Got Src/Dest after DATA 2020-08-26T16:19:32.590Z,1598458772.590 [DAT](INFO): DATA Src=6, Dst=9 2020-08-26T16:19:32.606Z,1598458772.606 [DAT](INFO): DAT read: CRC:Pass MPD:12.1 PSNR:13.5 AGC:76 SPD:+00.0 CCERR:010 2020-08-26T16:19:32.606Z,1598458772.606 [DAT](INFO): Got CRC:Pass 2020-08-26T16:19:32.606Z,1598458772.606 [DAT](INFO): Got CRC:Pass 2020-08-26T16:19:32.606Z,1598458772.606 [DAT](INFO): Incoming data is intended for us 2020-08-26T16:19:32.607Z,1598458772.607 [DAT](INFO): Received command:set _.pressure 0.544052 atmosphere 2020-08-26T16:19:33.769Z,1598458773.769 [CommandLine](IMPORTANT): got command set _.pressure 0.544052 atmosphere 2020-08-26T16:19:33.775Z,1598458773.775 [DAT](INFO): Sending ack 2020-08-26T16:19:33.775Z,1598458773.775 [DAT](INFO): DAT read: 2020-08-26T16:19:33.776Z,1598458773.776 [DAT](INFO): DAT read: 2020-08-26T16:19:33.778Z,1598458773.778 [DAT](INFO): DAT read: Rx Time:16:14:05.1884 2020-08-26T16:19:33.778Z,1598458773.778 [DAT](INFO): received an acoustic signal 2020-08-26T16:19:33.838Z,1598458773.838 [DAT](INFO): DAT read: 16:14:05.1884 LVL= 15424, 17313, 22450, 32755, AGC= 72, IDX= 307,-0.27,-2.642,-0.289,-0.972,-1.491, PHS=-1.118, 1.231, 0.591, RAW= 285.3, -6.8, CAL= 286.1, -11.6, ROT= 208.9, 11.6 2020-08-26T16:19:33.843Z,1598458773.843 [DAT](INFO): got valid direction response: 16:14:05.1884 LVL= 15424, 17313, 22450, 32755, AGC= 72, IDX= 307,-0.27,-2.642,-0.289,-0.972,-1.491, PHS=-1.118, 1.231, 0.591, RAW= 285.3, -6.8, CAL= 286.1, -11.6, ROT= 208.9, 11.6 2020-08-26T16:19:33.844Z,1598458773.844 [DAT](INFO): DAT read: 2020-08-26T16:19:33.847Z,1598458773.847 [DAT](INFO): DAT read: DATA(0035):set _.temperature 26.636560 celsius 2020-08-26T16:19:33.847Z,1598458773.847 [DAT](INFO): Got DATA 35 2020-08-26T16:19:33.848Z,1598458773.848 [DAT](INFO): DAT read: Source:006 Destination:009 2020-08-26T16:19:33.849Z,1598458773.849 [DAT](INFO): Got Src/Dest after DATA 2020-08-26T16:19:33.849Z,1598458773.849 [DAT](INFO): DATA Src=6, Dst=9 2020-08-26T16:19:33.876Z,1598458773.876 [DAT](INFO): DAT read: CRC:Pass MPD:12.3 PSNR:11.7 AGC:76 SPD:-00.1 CCERR:009 2020-08-26T16:19:33.876Z,1598458773.876 [DAT](INFO): Got CRC:Pass 2020-08-26T16:19:33.876Z,1598458773.876 [DAT](INFO): Got CRC:Pass 2020-08-26T16:19:33.876Z,1598458773.876 [DAT](INFO): Incoming data is intended for us 2020-08-26T16:19:33.877Z,1598458773.877 [DAT](INFO): Received command:set _.temperature 26.636560 celsius 2020-08-26T16:19:35.037Z,1598458775.037 [CommandLine](IMPORTANT): got command set _.temperature 26.636560 celsius 2020-08-26T16:19:35.038Z,1598458775.038 [DAT](INFO): Sending ack 2020-08-26T16:19:35.039Z,1598458775.039 [DAT](INFO): DAT read: 2020-08-26T16:19:35.039Z,1598458775.039 [DAT](INFO): DAT read: 2020-08-26T16:19:35.041Z,1598458775.041 [DAT](INFO): DAT read: Rx Time:16:14:26.5887 2020-08-26T16:19:35.041Z,1598458775.041 [DAT](INFO): received an acoustic signal 2020-08-26T16:19:35.041Z,1598458775.041 [DAT](INFO): DAT read: 2020-08-26T16:19:35.043Z,1598458775.043 [DAT](INFO): DAT read: DATA(0031):set _.humidity 7.727994 percent 2020-08-26T16:19:35.043Z,1598458775.043 [DAT](INFO): Got DATA 31 2020-08-26T16:19:35.045Z,1598458775.045 [DAT](INFO): DAT read: Source:006 Destination:009 2020-08-26T16:19:35.045Z,1598458775.045 [DAT](INFO): Got Src/Dest after DATA 2020-08-26T16:19:35.045Z,1598458775.045 [DAT](INFO): DATA Src=6, Dst=9 2020-08-26T16:19:35.047Z,1598458775.047 [DAT](INFO): DAT read: CRC:Pass MPD:11.8 PSNR:13.3 AGC:77 SPD:+00.0 CCERR:010 2020-08-26T16:19:35.047Z,1598458775.047 [DAT](INFO): Got CRC:Pass 2020-08-26T16:19:35.047Z,1598458775.047 [DAT](INFO): Got CRC:Pass 2020-08-26T16:19:35.047Z,1598458775.047 [DAT](INFO): Incoming data is intended for us 2020-08-26T16:19:35.048Z,1598458775.048 [DAT](INFO): Received command:set _.humidity 7.727994 percent 2020-08-26T16:19:35.683Z,1598458775.683 [CommandLine](IMPORTANT): got command set _.humidity 7.727994 percent 2020-08-26T16:19:35.685Z,1598458775.685 [DAT](INFO): Sending ack 2020-08-26T16:19:35.685Z,1598458775.685 [DAT](INFO): DAT read: 2020-08-26T16:19:35.686Z,1598458775.686 [DAT](INFO): DAT read: 2020-08-26T16:19:35.687Z,1598458775.687 [DAT](INFO): DAT read: Rx Time:16:18:59.2925 2020-08-26T16:19:35.687Z,1598458775.687 [DAT](INFO): received an acoustic signal 2020-08-26T16:19:35.687Z,1598458775.687 [DAT](INFO): DAT read: 2020-08-26T16:19:35.689Z,1598458775.689 [DAT](INFO): DAT read: DATA(0034):set _.pressure 0.541725 atmosphere 2020-08-26T16:19:35.689Z,1598458775.689 [DAT](INFO): Got DATA 34 2020-08-26T16:19:35.690Z,1598458775.690 [DAT](INFO): DAT read: Source:006 Destination:009 2020-08-26T16:19:35.690Z,1598458775.690 [DAT](INFO): Got Src/Dest after DATA 2020-08-26T16:19:35.690Z,1598458775.690 [DAT](INFO): DATA Src=6, Dst=9 2020-08-26T16:19:35.691Z,1598458775.691 [DAT](INFO): DAT read: CRC:Pass MPD:11.7 PSNR:13.2 AGC:76 SPD:-00.1 CCERR:010 2020-08-26T16:19:35.691Z,1598458775.691 [DAT](INFO): Got CRC:Pass 2020-08-26T16:19:35.692Z,1598458775.692 [DAT](INFO): Got CRC:Pass 2020-08-26T16:19:35.692Z,1598458775.692 [DAT](INFO): Incoming data is intended for us 2020-08-26T16:19:35.692Z,1598458775.692 [DAT](INFO): Received command:set _.pressure 0.541725 atmosphere 2020-08-26T16:19:35.714Z,1598458775.714 [DataOverHttps](INFO): Sending 105 bytes from file Logs/20200826T151826/Courier0019.lzma 2020-08-26T16:19:36.389Z,1598458776.389 [CommandLine](IMPORTANT): got command set _.pressure 0.541725 atmosphere 2020-08-26T16:19:36.396Z,1598458776.396 [DAT](INFO): Sending ack 2020-08-26T16:19:36.396Z,1598458776.396 [DAT](INFO): DAT read: 2020-08-26T16:19:36.397Z,1598458776.397 [DAT](INFO): DAT read: 2020-08-26T16:19:36.716Z,1598458776.716 [DataOverHttps](INFO): Moved sent file to Logs/20200826T151826/Courier0019.lzma.bak 2020-08-26T16:19:36.716Z,1598458776.716 [DataOverHttps](INFO): SBD MOMSN=12620235 2020-08-26T16:19:37.143Z,1598458777.143 [DAT](INFO): Read direction message, but no range. 2020-08-26T16:19:37.150Z,1598458777.150 [Default:CheckIn:Read_Iridium] Stopped 2020-08-26T16:19:37.150Z,1598458777.150 [Default:CheckIn:C.Wait] Running Loop=1 2020-08-26T16:19:37.151Z,1598458777.151 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2020-08-26T16:19:37.160Z,1598458777.160 [Reporter](INFO): Onboard.Humidity 26.016361 % 2020-08-26T16:19:46.106Z,1598458786.106 [Reporter](INFO): Onboard.Humidity 26.016361 % 2020-08-26T16:19:55.817Z,1598458795.817 [Reporter](INFO): Onboard.Humidity 26.004150 % 2020-08-26T16:20:05.894Z,1598458805.894 [Reporter](INFO): Onboard.Humidity 26.004150 % 2020-08-26T16:20:15.977Z,1598458815.977 [Reporter](INFO): Onboard.Humidity 26.004150 % 2020-08-26T16:20:26.109Z,1598458826.109 [Reporter](INFO): Onboard.Humidity 26.004150 % 2020-08-26T16:20:35.838Z,1598458835.838 [Reporter](INFO): Onboard.Humidity 26.004150 % 2020-08-26T16:20:45.897Z,1598458845.897 [Reporter](INFO): Onboard.Humidity 26.004150 % 2020-08-26T16:20:55.973Z,1598458855.973 [Reporter](INFO): Onboard.Humidity 26.016361 % 2020-08-26T16:21:05.827Z,1598458865.827 [Reporter](INFO): Onboard.Humidity 26.004150 % 2020-08-26T16:21:16.172Z,1598458876.172 [Reporter](INFO): Onboard.Humidity 26.004150 % 2020-08-26T16:21:25.875Z,1598458885.875 [Reporter](INFO): Onboard.Humidity 26.004150 % 2020-08-26T16:21:35.997Z,1598458895.997 [Reporter](INFO): Onboard.Humidity 26.016361 % 2020-08-26T16:21:46.086Z,1598458906.086 [Reporter](INFO): Onboard.Humidity 26.004150 % 2020-08-26T16:21:56.180Z,1598458916.180 [Reporter](INFO): Onboard.Humidity 26.004150 % 2020-08-26T16:21:58.578Z,1598458918.578 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 21 2020-08-26T16:21:58.578Z,1598458918.578 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-08-26T16:21:58.588Z,1598458918.588 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-08-26T16:21:58.999Z,1598458918.999 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-08-26T16:21:58.999Z,1598458918.999 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 21 2020-08-26T16:22:05.910Z,1598458925.910 [Reporter](INFO): Onboard.Humidity 26.004150 % 2020-08-26T16:22:15.977Z,1598458935.977 [Reporter](INFO): Onboard.Humidity 26.004150 % 2020-08-26T16:22:26.084Z,1598458946.084 [Reporter](INFO): Onboard.Humidity 26.004150 % 2020-08-26T16:22:36.221Z,1598458956.221 [Reporter](INFO): Onboard.Humidity 26.004150 % 2020-08-26T16:22:43.652Z,1598458963.652 [CommandLine](IMPORTANT): got command restart application 2020-08-26T16:22:44.667Z,1598458964.667 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2020-08-26T16:22:44.667Z,1598458964.667 [CommandLine ThreadHandler](INFO): Thread cancelled. 2020-08-26T16:22:44.670Z,1598458964.670 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2020-08-26T16:22:44.670Z,1598458964.670 [CommandLine ThreadHandler](INFO): Thread cancelled. 2020-08-26T16:22:44.671Z,1598458964.671 [CommandLine](INFO): Join timeout helper Thread ID is 2400 2020-08-26T16:22:44.678Z,1598458964.678 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2020-08-26T16:22:44.678Z,1598458964.678 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2020-08-26T16:22:44.679Z,1598458964.679 [NavChartDb](INFO): Join timeout helper Thread ID is 2401 2020-08-26T16:22:44.931Z,1598458964.931 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2020-08-26T16:22:44.931Z,1598458964.931 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2020-08-26T16:22:44.938Z,1598458964.938 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2020-08-26T16:22:44.938Z,1598458964.938 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2020-08-26T16:22:44.939Z,1598458964.939 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 2402 2020-08-26T16:22:45.063Z,1598458965.063 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2020-08-26T16:22:45.063Z,1598458965.063 [WetLabsBB2FL](INFO): Powering down 2020-08-26T16:22:45.064Z,1598458965.064 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2020-08-26T16:22:45.082Z,1598458965.082 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2020-08-26T16:22:45.082Z,1598458965.082 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2020-08-26T16:22:45.083Z,1598458965.083 [CTD_Seabird](INFO): Join timeout helper Thread ID is 2403 2020-08-26T16:22:45.871Z,1598458965.871 [CTD_Seabird](INFO): Powering down 2020-08-26T16:22:45.883Z,1598458965.883 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2020-08-26T16:22:45.884Z,1598458965.884 [CTD_Seabird](INFO): Powering down 2020-08-26T16:22:45.898Z,1598458965.898 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2020-08-26T16:22:45.903Z,1598458965.903 [ComponentRegistry](INFO): Shutting down BackSeatDriver ThreadHandler 2020-08-26T16:22:45.903Z,1598458965.903 [BackSeatDriver ThreadHandler](INFO): Thread cancelled. 2020-08-26T16:22:45.904Z,1598458965.904 [BackSeatDriver](INFO): Join timeout helper Thread ID is 2404 2020-08-26T16:22:45.919Z,1598458965.919 [Reporter](INFO): Onboard.Humidity 26.004150 % 2020-08-26T16:22:46.147Z,1598458966.147 [BackSeatDriver ThreadHandler](INFO): Uninitializing protected caller thread. 2020-08-26T16:22:46.147Z,1598458966.147 [BackSeatDriver ThreadHandler](INFO): Thread cancelled. 2020-08-26T16:22:46.163Z,1598458966.163 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2020-08-26T16:22:46.163Z,1598458966.163 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2020-08-26T16:22:46.164Z,1598458966.164 [Radio_Surface](INFO): Join timeout helper Thread ID is 2405 2020-08-26T16:22:46.470Z,1598458966.470 [Radio_Surface](INFO): Powering down 2020-08-26T16:22:46.471Z,1598458966.471 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2020-08-26T16:22:46.472Z,1598458966.472 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2020-08-26T16:22:46.487Z,1598458966.487 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2020-08-26T16:22:46.487Z,1598458966.487 [Onboard ThreadHandler](INFO): Thread cancelled. 2020-08-26T16:22:46.488Z,1598458966.488 [Onboard](INFO): Join timeout helper Thread ID is 2406 2020-08-26T16:22:47.307Z,1598458967.307 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2020-08-26T16:22:50.882Z,1598458970.882 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2020-08-26T16:22:50.883Z,1598458970.883 [Onboard ThreadHandler](INFO): Thread cancelled. 2020-08-26T16:22:50.887Z,1598458970.887 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2020-08-26T16:22:50.887Z,1598458970.887 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2020-08-26T16:22:50.888Z,1598458970.888 [DataOverHttps](INFO): Join timeout helper Thread ID is 2407 2020-08-26T16:22:51.108Z,1598458971.108 [CBIT](FAULT): Humidity exceeds 50% of running average: Humidity:2285304 %. Average:280391.281250 2020-08-26T16:22:51.323Z,1598458971.323 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2020-08-26T16:22:51.323Z,1598458971.323 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2020-08-26T16:22:51.335Z,1598458971.335 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2020-08-26T16:22:51.335Z,1598458971.335 [logger ThreadHandler](INFO): Thread cancelled. 2020-08-26T16:22:51.336Z,1598458971.336 [logger](INFO): Join timeout helper Thread ID is 2408 2020-08-26T16:22:51.382Z,1598458971.382 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2020-08-26T16:22:51.383Z,1598458971.383 [logger ThreadHandler](INFO): Thread cancelled. 2020-08-26T16:22:51.395Z,1598458971.395 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2020-08-26T16:22:51.395Z,1598458971.395 [CommandLine ThreadHandler](INFO): Thread cancelled. 2020-08-26T16:22:51.395Z,1598458971.395 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2020-08-26T16:22:51.395Z,1598458971.395 [controlThread ThreadHandler](INFO): Thread cancelled. 2020-08-26T16:22:51.396Z,1598458971.396 [controlThread](INFO): Join timeout helper Thread ID is 2409 2020-08-26T16:22:51.482Z,1598458971.482 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2020-08-26T16:22:51.483Z,1598458971.483 [controlThread](DEBUG): Uninitializing ControlThread 2020-08-26T16:22:51.483Z,1598458971.483 [AHRS_M2](INFO): Powering down 2020-08-26T16:22:51.555Z,1598458971.555 [NAL9602](INFO): Powering down 2020-08-26T16:22:51.556Z,1598458971.556 [DAT](INFO): Powering down 2020-08-26T16:22:51.842Z,1598458971.842 [AMEcho](INFO): Powering down 2020-08-26T16:22:51.844Z,1598458971.844 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2020-08-26T16:22:51.845Z,1598458971.845 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2020-08-26T16:22:51.845Z,1598458971.845 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2020-08-26T16:22:51.845Z,1598458971.845 [MissionManager](INFO): Uninitializing Mission Default 2020-08-26T16:22:51.846Z,1598458971.846 [Default] Stopped 2020-08-26T16:22:51.846Z,1598458971.846 [Default](DEBUG): Aggregate::uninitialize Default 2020-08-26T16:22:51.846Z,1598458971.846 [Default:B.GoToSurface] Stopped 2020-08-26T16:22:51.846Z,1598458971.846 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2020-08-26T16:22:51.846Z,1598458971.846 [Default:CheckIn] Stopped 2020-08-26T16:22:51.846Z,1598458971.846 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2020-08-26T16:22:51.846Z,1598458971.846 [Default:CheckIn:C.Wait] Stopped 2020-08-26T16:22:51.846Z,1598458971.846 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2020-08-26T16:22:51.849Z,1598458971.849 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2020-08-26T16:22:51.849Z,1598458971.849 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2020-08-26T16:22:51.849Z,1598458971.849 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2020-08-26T16:22:51.850Z,1598458971.850 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2020-08-26T16:22:51.850Z,1598458971.850 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2020-08-26T16:22:51.850Z,1598458971.850 [BuoyancyServo](INFO): Powering down 2020-08-26T16:22:51.862Z,1598458971.862 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2020-08-26T16:22:51.863Z,1598458971.863 [ElevatorServo](INFO): Powering down 2020-08-26T16:22:51.863Z,1598458971.863 [MassServo](DEBUG): Uninitialize Mass Servo. 2020-08-26T16:22:51.863Z,1598458971.863 [MassServo](INFO): Powering down 2020-08-26T16:22:51.864Z,1598458971.864 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2020-08-26T16:22:51.864Z,1598458971.864 [RudderServo](INFO): Powering down 2020-08-26T16:22:51.865Z,1598458971.865 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2020-08-26T16:22:51.865Z,1598458971.865 [ThrusterServo](INFO): Powering down 2020-08-26T16:22:51.866Z,1598458971.866 [SBIT](DEBUG): Uninitialize SBIT Component. 2020-08-26T16:22:51.866Z,1598458971.866 [IBIT](DEBUG): Uninitialize IBIT Component. 2020-08-26T16:22:51.867Z,1598458971.867 [CBIT](DEBUG): Uninitialize CBIT Component. 2020-08-26T16:22:51.867Z,1598458971.867 [CBIT](DEBUG): Powering off loads. 2020-08-26T16:22:51.878Z,1598458971.878 [CBIT](DEBUG): Disabling WDT. 2020-08-26T16:22:51.890Z,1598458971.890 [CBIT](DEBUG): Opening all GF detection circuits. 2020-08-26T16:22:51.891Z,1598458971.891 [controlThread ThreadHandler](INFO): Thread cancelled. 2020-08-26T16:22:51.996Z,1598458971.996 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2020-08-26T16:22:51.998Z,1598458971.998 [Onboard ThreadHandler](INFO): Thread cancelled. 2020-08-26T16:22:52.004Z,1598458972.004 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2020-08-26T16:22:52.076Z,1598458972.076 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2020-08-26T16:22:52.080Z,1598458972.080 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2020-08-26T16:22:52.083Z,1598458972.083 [BackSeatDriver ThreadHandler](INFO): Thread cancelled. 2020-08-26T16:22:52.097Z,1598458972.097 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2020-08-26T16:22:52.159Z,1598458972.159 [logger ThreadHandler](INFO): Thread cancelled.