2024-04-25T19:01:43.866Z,1714071703.866 [Supervisor](DEBUG): Initializing supervisor. 2024-04-25T19:01:43.870Z,1714071703.870 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2024-04-25T19:01:43.871Z,1714071703.871 [SyncHandler](INFO): Protected caller Thread ID is 458 2024-04-25T19:01:43.871Z,1714071703.871 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2024-04-25T19:01:43.872Z,1714071703.872 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2024-04-25T19:01:43.872Z,1714071703.872 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 459 2024-04-25T19:01:43.876Z,1714071703.876 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2024-04-25T19:01:43.894Z,1714071703.894 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2024-04-25T19:01:43.895Z,1714071703.895 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2024-04-25T19:01:43.895Z,1714071703.895 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 460 2024-04-25T19:01:43.899Z,1714071703.899 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2024-04-25T19:01:43.900Z,1714071703.900 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2024-04-25T19:01:43.901Z,1714071703.901 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 461 2024-04-25T19:01:43.903Z,1714071703.903 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2024-04-25T19:01:43.904Z,1714071703.904 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2024-04-25T19:01:43.904Z,1714071703.904 [logger ThreadHandler](INFO): Protected caller Thread ID is 462 2024-04-25T19:01:43.908Z,1714071703.908 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2024-04-25T19:01:43.908Z,1714071703.908 [Supervisor](INFO): Looking for Config files in directory: Config/ 2024-04-25T19:01:43.910Z,1714071703.910 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2024-04-25T19:01:44.134Z,1714071704.134 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2024-04-25T19:01:44.134Z,1714071704.134 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2024-04-25T19:01:44.256Z,1714071704.256 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2024-04-25T19:01:44.256Z,1714071704.256 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2024-04-25T19:01:44.363Z,1714071704.363 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2024-04-25T19:01:44.364Z,1714071704.364 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2024-04-25T19:01:44.930Z,1714071704.930 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2024-04-25T19:01:44.931Z,1714071704.931 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2024-04-25T19:01:45.307Z,1714071705.307 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2024-04-25T19:01:45.308Z,1714071705.308 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2024-04-25T19:01:45.662Z,1714071705.662 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2024-04-25T19:01:45.663Z,1714071705.663 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2024-04-25T19:01:45.867Z,1714071705.867 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2024-04-25T19:01:45.868Z,1714071705.868 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2024-04-25T19:01:45.958Z,1714071705.958 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2024-04-25T19:01:46.051Z,1714071706.051 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2024-04-25T19:01:46.474Z,1714071706.474 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2024-04-25T19:01:46.475Z,1714071706.475 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2024-04-25T19:01:46.781Z,1714071706.781 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2024-04-25T19:01:46.782Z,1714071706.782 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2024-04-25T19:01:47.359Z,1714071707.359 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2024-04-25T19:01:47.360Z,1714071707.360 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2024-04-25T19:01:47.596Z,1714071707.596 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2024-04-25T19:01:47.597Z,1714071707.597 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2024-04-25T19:01:47.855Z,1714071707.855 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2024-04-25T19:01:47.855Z,1714071707.855 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2024-04-25T19:01:48.005Z,1714071708.005 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2024-04-25T19:01:48.006Z,1714071708.006 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2024-04-25T19:01:48.912Z,1714071708.912 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2024-04-25T19:01:48.914Z,1714071708.914 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-galene/ 2024-04-25T19:01:48.915Z,1714071708.915 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/secure.cfg 2024-04-25T19:01:49.071Z,1714071709.071 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/vehicle.cfg 2024-04-25T19:01:49.423Z,1714071709.423 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Battery.cfg 2024-04-25T19:01:49.899Z,1714071709.899 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2024-04-25T19:01:49.900Z,1714071709.900 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Science.cfg 2024-04-25T19:01:50.036Z,1714071710.036 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Control.cfg 2024-04-25T19:01:50.147Z,1714071710.147 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/logger.cfg 2024-04-25T19:01:50.251Z,1714071710.251 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Servo.cfg 2024-04-25T19:01:50.371Z,1714071710.371 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Navigation.cfg 2024-04-25T19:01:50.478Z,1714071710.478 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Simulator.cfg 2024-04-25T19:01:50.575Z,1714071710.575 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/BIT.cfg 2024-04-25T19:01:50.677Z,1714071710.677 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/workSite.cfg 2024-04-25T19:01:50.771Z,1714071710.771 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Sensor.cfg 2024-04-25T19:01:50.950Z,1714071710.950 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-galene/root/ 2024-04-25T19:01:50.950Z,1714071710.950 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg 2024-04-25T19:01:50.958Z,1714071710.958 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2024-04-25T19:01:51.009Z,1714071711.009 [DepthRateCalculator] Loaded 2024-04-25T19:01:51.010Z,1714071711.010 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2024-04-25T19:01:51.015Z,1714071711.015 [PitchRateCalculator] Loaded 2024-04-25T19:01:51.015Z,1714071711.015 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2024-04-25T19:01:51.025Z,1714071711.025 [SpeedCalculator] Loaded 2024-04-25T19:01:51.025Z,1714071711.025 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2024-04-25T19:01:51.030Z,1714071711.030 [YawRateCalculator] Loaded 2024-04-25T19:01:51.031Z,1714071711.031 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2024-04-25T19:01:51.052Z,1714071711.052 [ElevatorOffsetCalculator] Loaded 2024-04-25T19:01:51.052Z,1714071711.052 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2024-04-25T19:01:51.052Z,1714071711.052 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2024-04-25T19:01:51.053Z,1714071711.053 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2024-04-25T19:01:51.080Z,1714071711.080 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2024-04-25T19:01:51.080Z,1714071711.080 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2024-04-25T19:01:51.090Z,1714071711.090 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2024-04-25T19:01:51.091Z,1714071711.091 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2024-04-25T19:01:51.520Z,1714071711.520 [AHRS_M2] Loaded 2024-04-25T19:01:51.520Z,1714071711.520 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2024-04-25T19:01:51.555Z,1714071711.555 [BackseatComponent] Loaded 2024-04-25T19:01:51.556Z,1714071711.556 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2024-04-25T19:01:51.557Z,1714071711.557 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 408584E0 2024-04-25T19:01:51.557Z,1714071711.557 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 548 2024-04-25T19:01:51.560Z,1714071711.560 [LcmUniversalReporter] Loaded 2024-04-25T19:01:51.560Z,1714071711.560 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread. 2024-04-25T19:01:52.356Z,1714071712.356 [BPC1] Loaded 2024-04-25T19:01:52.356Z,1714071712.356 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2024-04-25T19:01:52.430Z,1714071712.430 [DataOverHttps] Loaded 2024-04-25T19:01:52.430Z,1714071712.430 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2024-04-25T19:01:52.431Z,1714071712.431 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 408884E0 2024-04-25T19:01:52.431Z,1714071712.431 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 549 2024-04-25T19:01:52.451Z,1714071712.451 [Depth_Keller] Loaded 2024-04-25T19:01:52.452Z,1714071712.452 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2024-04-25T19:01:52.457Z,1714071712.457 [DropWeight] Loaded 2024-04-25T19:01:52.457Z,1714071712.457 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2024-04-25T19:01:52.475Z,1714071712.475 [MultiRay] Loaded 2024-04-25T19:01:52.475Z,1714071712.475 [ComponentRegistry](DEBUG): SyncComponent "MultiRay" handled in the control thread. 2024-04-25T19:01:52.536Z,1714071712.536 [NAL9602] Loaded 2024-04-25T19:01:52.537Z,1714071712.537 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2024-04-25T19:01:52.566Z,1714071712.566 [Onboard] Loaded 2024-04-25T19:01:52.566Z,1714071712.566 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2024-04-25T19:01:52.567Z,1714071712.567 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 408B84E0 2024-04-25T19:01:52.567Z,1714071712.567 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 550 2024-04-25T19:01:52.573Z,1714071712.573 [PowerOnly](INFO): Adding load control power supply at /dev/loadC3 2024-04-25T19:01:52.584Z,1714071712.584 [PowerOnly] Loaded 2024-04-25T19:01:52.584Z,1714071712.584 [ComponentRegistry](DEBUG): SyncComponent "PowerOnly" handled in the control thread. 2024-04-25T19:01:52.596Z,1714071712.596 [Power24vConverter] Loaded 2024-04-25T19:01:52.596Z,1714071712.596 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2024-04-25T19:01:52.610Z,1714071712.610 [Radio_Surface] Loaded 2024-04-25T19:01:52.610Z,1714071712.610 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2024-04-25T19:01:52.611Z,1714071712.611 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 408E84E0 2024-04-25T19:01:52.612Z,1714071712.612 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 551 2024-04-25T19:01:52.701Z,1714071712.701 [DAT] Loaded 2024-04-25T19:01:52.701Z,1714071712.701 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread. 2024-04-25T19:01:52.702Z,1714071712.702 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 409184E0 2024-04-25T19:01:52.703Z,1714071712.703 [DAT ThreadHandler](INFO): Protected caller Thread ID is 552 2024-04-25T19:01:52.703Z,1714071712.703 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2024-04-25T19:01:52.704Z,1714071712.704 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2024-04-25T19:01:52.813Z,1714071712.813 [DeadReckonUsingMultipleVelocitySources] Loaded 2024-04-25T19:01:52.813Z,1714071712.813 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2024-04-25T19:01:52.854Z,1714071712.854 [DeadReckonUsingSpeedCalculator] Loaded 2024-04-25T19:01:52.854Z,1714071712.854 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread. 2024-04-25T19:01:52.868Z,1714071712.868 [NavChart] Loaded 2024-04-25T19:01:52.868Z,1714071712.868 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2024-04-25T19:01:52.874Z,1714071712.874 [UniversalFixResidualReporter] Loaded 2024-04-25T19:01:52.874Z,1714071712.874 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2024-04-25T19:01:52.874Z,1714071712.874 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2024-04-25T19:01:52.875Z,1714071712.875 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2024-04-25T19:01:53.014Z,1714071713.014 [SBIT](DEBUG): Construct Startup Built In Test. 2024-04-25T19:01:53.028Z,1714071713.028 [SBIT] Loaded 2024-04-25T19:01:53.028Z,1714071713.028 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2024-04-25T19:01:53.031Z,1714071713.031 [IBIT](DEBUG): Construct Initiated Built In Test. 2024-04-25T19:01:53.043Z,1714071713.043 [IBIT] Loaded 2024-04-25T19:01:53.044Z,1714071713.044 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2024-04-25T19:01:53.049Z,1714071713.049 [CBIT](DEBUG): Construct Continuous Built In Test. 2024-04-25T19:01:53.152Z,1714071713.152 [CBIT] Loaded 2024-04-25T19:01:53.152Z,1714071713.152 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2024-04-25T19:01:53.153Z,1714071713.153 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2024-04-25T19:01:53.153Z,1714071713.153 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2024-04-25T19:01:53.324Z,1714071713.324 [CTD_Seabird] Loaded 2024-04-25T19:01:53.324Z,1714071713.324 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2024-04-25T19:01:53.326Z,1714071713.326 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40A204E0 2024-04-25T19:01:53.326Z,1714071713.326 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 553 2024-04-25T19:01:53.346Z,1714071713.346 [PAR_Licor] Loaded 2024-04-25T19:01:53.346Z,1714071713.346 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2024-04-25T19:01:53.390Z,1714071713.390 [WetLabsBB2FL] Loaded 2024-04-25T19:01:53.390Z,1714071713.390 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2024-04-25T19:01:53.391Z,1714071713.391 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40A504E0 2024-04-25T19:01:53.391Z,1714071713.391 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 554 2024-04-25T19:01:53.392Z,1714071713.392 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2024-04-25T19:01:53.393Z,1714071713.393 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2024-04-25T19:01:53.524Z,1714071713.524 [BuoyancyServo] Loaded 2024-04-25T19:01:53.524Z,1714071713.524 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2024-04-25T19:01:53.546Z,1714071713.546 [ElevatorServo] Loaded 2024-04-25T19:01:53.546Z,1714071713.546 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2024-04-25T19:01:53.566Z,1714071713.566 [MassServo] Loaded 2024-04-25T19:01:53.567Z,1714071713.567 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2024-04-25T19:01:53.586Z,1714071713.586 [RudderServo] Loaded 2024-04-25T19:01:53.587Z,1714071713.587 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2024-04-25T19:01:53.602Z,1714071713.602 [ThrusterHE] Loaded 2024-04-25T19:01:53.602Z,1714071713.602 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread. 2024-04-25T19:01:53.603Z,1714071713.603 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2024-04-25T19:01:53.603Z,1714071713.603 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2024-04-25T19:01:53.656Z,1714071713.656 [VerticalControl](DEBUG): Construct VerticalControl. 2024-04-25T19:01:53.707Z,1714071713.707 [VerticalControl] Loaded 2024-04-25T19:01:53.707Z,1714071713.707 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2024-04-25T19:01:53.710Z,1714071713.710 [HorizontalControl](DEBUG): Construct HorizontalControl. 2024-04-25T19:01:53.753Z,1714071713.753 [HorizontalControl] Loaded 2024-04-25T19:01:53.754Z,1714071713.754 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2024-04-25T19:01:53.756Z,1714071713.756 [SpeedControl](DEBUG): Construct SpeedControl. 2024-04-25T19:01:53.758Z,1714071713.758 [SpeedControl] Loaded 2024-04-25T19:01:53.758Z,1714071713.758 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2024-04-25T19:01:53.761Z,1714071713.761 [LoopControl](DEBUG): Construct LoopControl. 2024-04-25T19:01:53.761Z,1714071713.761 [LoopControl] Loaded 2024-04-25T19:01:53.761Z,1714071713.761 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2024-04-25T19:01:53.762Z,1714071713.762 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2024-04-25T19:01:53.762Z,1714071713.762 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2024-04-25T19:01:53.874Z,1714071713.874 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2024-04-25T19:01:53.875Z,1714071713.875 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2024-04-25T19:01:54.084Z,1714071714.084 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2024-04-25T19:01:54.085Z,1714071714.085 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2024-04-25T19:01:54.923Z,1714071714.923 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2024-04-25T19:01:54.924Z,1714071714.924 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2024-04-25T19:01:54.980Z,1714071714.980 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2024-04-25T19:01:54.986Z,1714071714.986 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2024-04-25T19:01:54.989Z,1714071714.989 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2024-04-25T19:01:55.000Z,1714071715.000 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2024-04-25T19:01:55.001Z,1714071715.001 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C374E0 2024-04-25T19:01:55.002Z,1714071715.002 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 555 2024-04-25T19:01:55.006Z,1714071715.006 [Supervisor](INFO): Main Thread ID is 457 2024-04-25T19:01:55.006Z,1714071715.006 [Supervisor](DEBUG): Running supervisor. 2024-04-25T19:01:55.007Z,1714071715.007 [CommandExec ThreadHandler](INFO): Handler Thread ID is 556 2024-04-25T19:01:55.007Z,1714071715.007 [CommandExec](INFO): Initializing the command executive. 2024-04-25T19:01:55.009Z,1714071715.009 [CommandLine ThreadHandler](INFO): Handler Thread ID is 557 2024-04-25T19:01:55.011Z,1714071715.011 [controlThread ThreadHandler](INFO): Handler Thread ID is 558 2024-04-25T19:01:55.011Z,1714071715.011 [controlThread](DEBUG): Initializing ControlThread 2024-04-25T19:01:55.012Z,1714071715.012 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2024-04-25T19:01:55.013Z,1714071715.013 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2024-04-25T19:01:55.013Z,1714071715.013 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2024-04-25T19:01:55.013Z,1714071715.013 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2024-04-25T19:01:55.014Z,1714071715.014 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2024-04-25T19:01:55.021Z,1714071715.021 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-04-25T19:01:55.021Z,1714071715.021 [NavChart](DEBUG): Initialize NavChart Navigation. 2024-04-25T19:01:55.022Z,1714071715.022 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2024-04-25T19:01:55.022Z,1714071715.022 [SBIT](INFO): Initialize SBIT Component. 2024-04-25T19:01:55.023Z,1714071715.023 [SBIT](IMPORTANT): git: 2024-04-23_A 2024-04-25T19:01:55.023Z,1714071715.023 [SBIT](INFO): git hash: 3837c7def9641db7634367ed9b83ca26f76bd349 2024-04-25T19:01:55.023Z,1714071715.023 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2024-04-25T19:01:55.024Z,1714071715.024 [SBIT](INFO): Kernel Reporting Different Version From Configuration. Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018 Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021 2024-04-25T19:01:55.026Z,1714071715.026 [SBIT](INFO): Beginning SBIT in 24.000000 seconds. 2024-04-25T19:01:55.026Z,1714071715.026 [IBIT](INFO): Initialize IBIT Component. 2024-04-25T19:01:55.027Z,1714071715.027 [CBIT](DEBUG): Initialize CBIT Component. 2024-04-25T19:01:55.028Z,1714071715.028 [logger ThreadHandler](INFO): Handler Thread ID is 559 2024-04-25T19:01:55.038Z,1714071715.038 [CBIT](DEBUG): Initialized mux pins. 2024-04-25T19:01:55.038Z,1714071715.038 [CBIT](DEBUG): Initializing the watchdog timer. 2024-04-25T19:01:55.046Z,1714071715.046 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 560 2024-04-25T19:01:55.058Z,1714071715.058 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 561 2024-04-25T19:01:55.060Z,1714071715.060 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2024-04-25T19:01:55.062Z,1714071715.062 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2024-04-25T19:01:55.062Z,1714071715.062 [CBIT](DEBUG): Initializing heartbeat. 2024-04-25T19:01:55.070Z,1714071715.070 [Onboard ThreadHandler](INFO): Handler Thread ID is 562 2024-04-25T19:01:55.100Z,1714071715.100 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 563 2024-04-25T19:01:55.111Z,1714071715.111 [DAT ThreadHandler](INFO): Handler Thread ID is 564 2024-04-25T19:01:55.111Z,1714071715.111 [DAT](INFO): Powering up 2024-04-25T19:01:55.112Z,1714071715.112 [DAT](DEBUG): Initializing DAT. 2024-04-25T19:01:55.115Z,1714071715.115 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 566 2024-04-25T19:01:55.116Z,1714071715.116 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2024-04-25T19:01:55.119Z,1714071715.119 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 568 2024-04-25T19:01:55.122Z,1714071715.122 [WetLabsBB2FL](INFO): Powering up 2024-04-25T19:01:55.123Z,1714071715.123 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 570 2024-04-25T19:01:55.126Z,1714071715.126 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2024-04-25T19:01:55.127Z,1714071715.127 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2024-04-25T19:01:55.127Z,1714071715.127 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2024-04-25T19:01:55.127Z,1714071715.127 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2024-04-25T19:01:55.127Z,1714071715.127 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2024-04-25T19:01:55.127Z,1714071715.127 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2024-04-25T19:01:55.127Z,1714071715.127 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2024-04-25T19:01:55.128Z,1714071715.128 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2024-04-25T19:01:55.134Z,1714071715.134 [CBIT](DEBUG): Deactivating GF circuits. 2024-04-25T19:01:55.134Z,1714071715.134 [CBIT](DEBUG): Deactivating emergency mode. 2024-04-25T19:01:55.174Z,1714071715.174 [CBIT](DEBUG): Backplane powered. 2024-04-25T19:01:55.179Z,1714071715.179 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2024-04-25T19:01:55.181Z,1714071715.181 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2024-04-25T19:01:55.182Z,1714071715.182 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2024-04-25T19:01:55.182Z,1714071715.182 [LoopControl](DEBUG): Initialize LoopControlComponent. 2024-04-25T19:01:55.183Z,1714071715.183 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser 2024-04-25T19:01:55.184Z,1714071715.184 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl 2024-04-25T19:01:55.184Z,1714071715.184 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl 2024-04-25T19:01:55.185Z,1714071715.185 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl 2024-04-25T19:01:55.227Z,1714071715.227 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into: 2024-04-25T19:01:55.240Z,1714071715.240 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2024-04-25T19:01:55.274Z,1714071715.274 [MissionManager](DEBUG): # Copyright (c) 2024 MBARI # MBARI Proprietary Information. Confidential. All Rights Reserved # Unauthorized copying or distribution of this file via any medium is strictly # prohibited. # # WARNING - This file contains information whose export is restricted by the # Export Administration Act of 1979 (Title 50, U.S.C., App. 2401 et seq.), as # amended. Violations of these export laws are subject to severe civil and/or # criminal penalties. mission Startup { behavior Guidance:GoToSurface { run in progression } aggregate StartupSatComms { run in sequence readDatum { timeout duration=P1M Universal:latitude_fix } readDatum { timeout duration=P1M Universal:platform_communications } } } 2024-04-25T19:01:55.274Z,1714071715.274 [MissionManager](INFO): Loading Mission from file: Missions/Default.xml 2024-04-25T19:01:55.333Z,1714071715.333 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2024-04-25T19:01:55.335Z,1714071715.335 [Default:A.Wait](DEBUG): Construct Wait. 2024-04-25T19:01:55.337Z,1714071715.337 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2024-04-25T19:01:55.380Z,1714071715.380 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2024-04-25T19:01:55.382Z,1714071715.382 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2024-04-25T19:01:55.401Z,1714071715.401 [Default:E.Execute](DEBUG): Construct Execute. 2024-04-25T19:01:55.417Z,1714071715.417 [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 2024-04-25T19:01:55.423Z,1714071715.423 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,MultiRay,NAL9602,PowerOnly,Power24vConverter,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2024-04-25T19:01:55.441Z,1714071715.441 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2024-04-25T19:01:55.495Z,1714071715.495 [Depth_Keller](ERROR): Pressure or depth reading out of range: 1629.131348 decibar, 0.000000 m 2024-04-25T19:01:55.495Z,1714071715.495 [MultiRay](INFO): Powering up MultiRay Lights 2024-04-25T19:01:55.502Z,1714071715.502 [Radio_Surface](INFO): Powering up 2024-04-25T19:01:55.539Z,1714071715.539 [PowerOnly](INFO): Powering up loadControl 2024-04-25T19:01:55.558Z,1714071715.558 [Power24vConverter](INFO): Powering up. 2024-04-25T19:01:55.566Z,1714071715.566 [DepthRateCalculator](ERROR): Depth measurement is not active 2024-04-25T19:01:55.592Z,1714071715.592 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2024-04-25T19:01:55.598Z,1714071715.598 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2024-04-25T19:01:55.599Z,1714071715.599 [ElevatorServo](DEBUG): Initializing EZServoServo. 2024-04-25T19:01:55.606Z,1714071715.606 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2024-04-25T19:01:55.607Z,1714071715.607 [MassServo](DEBUG): Initializing EZServoServo. 2024-04-25T19:01:55.615Z,1714071715.615 [MassServo](DEBUG): Initializing MassServo. 2024-04-25T19:01:55.616Z,1714071715.616 [RudderServo](DEBUG): Initializing EZServoServo. 2024-04-25T19:01:55.622Z,1714071715.622 [RudderServo](DEBUG): Initializing RudderServo. 2024-04-25T19:01:55.623Z,1714071715.623 [ThrusterHE](DEBUG): Initializing EZServoServo. 2024-04-25T19:01:55.630Z,1714071715.630 [ThrusterHE](DEBUG): Initializing ThrusterHE. 2024-04-25T19:01:55.895Z,1714071715.895 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2024-04-25T19:01:55.896Z,1714071715.896 [DropWeight] Hardware Fault, FailCount= 1 2024-04-25T19:01:55.896Z,1714071715.896 [DropWeight](ERROR): Hardware Fault 2024-04-25T19:01:55.952Z,1714071715.952 [CommandExec](FAULT): Scheduling is paused 2024-04-25T19:01:55.952Z,1714071715.952 [CBIT](INFO): Critical error at 20240425T190155 2024-04-25T19:01:55.952Z,1714071715.952 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2024-04-25T19:01:55.959Z,1714071715.959 [CBIT](ERROR): Hardware Fault in component: DropWeight 2024-04-25T19:01:55.959Z,1714071715.959 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2024-04-25T19:01:56.265Z,1714071716.265 [CBIT](INFO): Critical error at 20240425T190155 2024-04-25T19:01:57.734Z,1714071717.734 [WetLabsBB2FL](INFO): Powering down 2024-04-25T19:02:01.318Z,1714071721.318 [ThrusterHE](ERROR): Zero Speed Commanded. 2024-04-25T19:02:02.146Z,1714071722.146 [CTD_Seabird](ERROR): Device message queue exceeded the allowed limit. 2024-04-25T19:02:07.474Z,1714071727.474 [DAT](INFO): DAT read: 2024-04-25T19:02:07.476Z,1714071727.476 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series 2024-04-25T19:02:09.243Z,1714071729.243 [DAT](INFO): DAT read: MF Frequency Band 2024-04-25T19:02:09.244Z,1714071729.244 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.15.0 2024-04-25T19:02:09.244Z,1714071729.244 [DAT](INFO): DAT read: Apr 25 2024 19:02:03 2024-04-25T19:02:10.251Z,1714071730.251 [DAT](INFO): DAT read: Features enabled [Bearing] 2024-04-25T19:02:10.252Z,1714071730.252 [DAT](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP 2024-04-25T19:02:10.252Z,1714071730.252 [DAT](INFO): commRate: 800 2024-04-25T19:02:12.322Z,1714071732.322 [DAT](INFO): entering command mode 2024-04-25T19:02:12.522Z,1714071732.522 [DAT](INFO): DAT read: 2024-04-25T19:02:12.523Z,1714071732.523 [DAT](INFO): DAT read: user:1> 2024-04-25T19:02:12.523Z,1714071732.523 [DAT](INFO): setting verbose to 3 2024-04-25T19:02:12.774Z,1714071732.774 [DAT](INFO): DAT read: user:1> 2024-04-25T19:02:12.775Z,1714071732.775 [DAT](INFO): DAT read: Verbose | 3 2024-04-25T19:02:12.776Z,1714071732.776 [DAT](INFO): set verbose to 3 2024-04-25T19:02:12.776Z,1714071732.776 [DAT](INFO): setting DatVerbose to 27440 2024-04-25T19:02:13.026Z,1714071733.026 [DAT](INFO): DAT read: user:2> 2024-04-25T19:02:13.027Z,1714071733.027 [DAT](INFO): DAT read: DatVerbose | 27440 2024-04-25T19:02:13.028Z,1714071733.028 [DAT](INFO): set DatVerbose to 27440 2024-04-25T19:02:13.028Z,1714071733.028 [DAT](INFO): setting transmit power to 8 2024-04-25T19:02:13.278Z,1714071733.278 [DAT](INFO): DAT read: user:3> 2024-04-25T19:02:13.279Z,1714071733.279 [DAT](INFO): DAT read: TxPower | 8 (Max) 2024-04-25T19:02:13.280Z,1714071733.280 [DAT](INFO): set transmit power to 8 2024-04-25T19:02:13.280Z,1714071733.280 [DAT](INFO): setting local address to 9 2024-04-25T19:02:13.530Z,1714071733.530 [DAT](INFO): DAT read: user:4> 2024-04-25T19:02:13.531Z,1714071733.531 [DAT](INFO): DAT read: LocalAddr | 9 2024-04-25T19:02:13.532Z,1714071733.532 [DAT](INFO): set local address to 9 2024-04-25T19:02:13.533Z,1714071733.533 [DAT](INFO): Setting time to: 19:2:13 And date to:4/25/2024 2024-04-25T19:02:13.782Z,1714071733.782 [DAT](INFO): DAT read: user:5> 2024-04-25T19:02:13.783Z,1714071733.783 [DAT](INFO): DAT read: Thu Apr 25, 2024 19:02:13 2024-04-25T19:02:13.784Z,1714071733.784 [DAT](INFO): Local DAT time set to Thu Apr 25, 2024 19:02:13 2024-04-25T19:02:19.747Z,1714071739.747 [SBIT](IMPORTANT): Beginning Startup BIT 2024-04-25T19:02:19.752Z,1714071739.752 [CBIT](IMPORTANT): Beginning ground fault scan 2024-04-25T19:02:22.935Z,1714071742.935 [NAL9602](INFO): Powering up NAL9602 2024-04-25T19:02:30.728Z,1714071750.728 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): 0.013434 CHAN A1 (24V): 0.000230 CHAN A2 (12V): -0.005334 CHAN A3 (5V): -0.003179 CHAN B0 (3.3V): 0.001084 CHAN B1 (3.15aV): -0.000711 CHAN B2 (3.15bV): -0.001456 CHAN B3 (GND): -0.000222 OPEN: 0.004929 Full Scale: +/- 1 mA 2024-04-25T19:02:33.843Z,1714071753.843 [NAL9602](INFO): NAL9602 initialized 2024-04-25T19:03:13.086Z,1714071793.086 [CommandExec](IMPORTANT): got command maintain control VerticalControl.buoyancyAction 100 cubic_centimeter 2024-04-25T19:03:13.090Z,1714071793.090 [ComponentRegistry](DEBUG): SyncComponent "Maintain_VerticalControl.buoyancyAction" handled in the control thread. 2024-04-25T19:03:13.460Z,1714071793.460 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,MultiRay,NAL9602,PowerOnly,Power24vConverter,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,Maintain_VerticalControl.buoyancyAction,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2024-04-25T19:03:13.879Z,1714071793.879 [SBIT](IMPORTANT): SBIT PASSED 2024-04-25T19:03:13.879Z,1714071793.879 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2024-04-25T19:03:13.880Z,1714071793.880 [SBIT](IMPORTANT): BuoyancyServo.limitLo=500 count; 2024-04-25T19:03:13.880Z,1714071793.880 [SBIT](IMPORTANT): BuoyancyServo.offsetVolume=0 cubic_centimeter; 2024-04-25T19:03:13.880Z,1714071793.880 [SBIT](IMPORTANT): MultiRay.loadAtStartup=1 bool; 2024-04-25T19:03:13.880Z,1714071793.880 [SBIT](IMPORTANT): PowerOnly.sampleTime1=0 second; 2024-04-25T19:03:13.880Z,1714071793.880 [SBIT](IMPORTANT): Vehicle.useTlLoader=1 bool; 2024-04-25T19:03:13.880Z,1714071793.880 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=325.783869 cubic_centimeter; 2024-04-25T19:03:13.880Z,1714071793.880 [SBIT](IMPORTANT): VerticalControl.massDefault=-1.183276 millimeter; 2024-04-25T19:03:14.273Z,1714071794.273 [MissionManager](IMPORTANT): Started mission Startup 2024-04-25T19:03:14.273Z,1714071794.273 [Startup] Running Loop=1 2024-04-25T19:03:14.273Z,1714071794.273 [Startup](DEBUG): Aggregate::initialize Startup 2024-04-25T19:03:14.273Z,1714071794.273 [Startup:A.GoToSurface] Running Loop=1 2024-04-25T19:03:14.273Z,1714071794.273 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2024-04-25T19:03:14.274Z,1714071794.274 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2024-04-25T19:03:14.275Z,1714071794.275 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2024-04-25T19:03:14.275Z,1714071794.275 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2024-04-25T19:03:14.276Z,1714071794.276 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2024-04-25T19:03:14.276Z,1714071794.276 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2024-04-25T19:03:14.279Z,1714071794.279 [Startup:StartupSatComms] Running Loop=1 2024-04-25T19:03:14.279Z,1714071794.279 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2024-04-25T19:03:14.279Z,1714071794.279 [Startup:StartupSatComms:A] Running Loop=1 2024-04-25T19:03:14.681Z,1714071794.681 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2024-04-25T19:04:14.461Z,1714071854.461 [Startup:StartupSatComms:A](INFO): Timed out from 2024-04-25T19:03:14.3Z 2024-04-25T19:04:14.461Z,1714071854.461 [Startup:StartupSatComms:A] Stopped 2024-04-25T19:04:14.461Z,1714071854.461 [Startup:StartupSatComms:B] Running Loop=1 2024-04-25T19:04:14.853Z,1714071854.853 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2024-04-25T19:04:23.064Z,1714071863.064 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004946 2024-04-25T19:04:30.541Z,1714071870.541 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240425T152029/Courier0076.lzma 2024-04-25T19:04:31.544Z,1714071871.544 [DataOverHttps](INFO): Moved sent file to Logs/20240425T152029/Courier0076.lzma.bak 2024-04-25T19:04:31.545Z,1714071871.545 [DataOverHttps](INFO): SBD MOMSN=19432338 2024-04-25T19:04:46.183Z,1714071886.183 [CommandExec](IMPORTANT): got command maintain control VerticalControl.buoyancyAction 1000 cubic_centimeter 2024-04-25T19:04:48.442Z,1714071888.442 [DataOverHttps](INFO): Sending 243 bytes from file Logs/20240425T190143/Courier0000.lzma 2024-04-25T19:04:49.443Z,1714071889.443 [DataOverHttps](INFO): Moved sent file to Logs/20240425T190143/Courier0000.lzma.bak 2024-04-25T19:04:49.444Z,1714071889.444 [DataOverHttps](INFO): SBD MOMSN=19432390 2024-04-25T19:04:55.254Z,1714071895.254 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2024-04-25T19:04:55.254Z,1714071895.254 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-04-25T19:04:55.256Z,1714071895.256 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1 2024-04-25T19:04:55.256Z,1714071895.256 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-04-25T19:04:55.327Z,1714071895.327 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-04-25T19:04:55.328Z,1714071895.328 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-04-25T19:04:55.703Z,1714071895.703 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-04-25T19:04:55.703Z,1714071895.703 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2024-04-25T19:04:55.703Z,1714071895.703 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-04-25T19:04:55.703Z,1714071895.703 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1 2024-04-25T19:04:56.067Z,1714071896.067 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-04-25T19:05:06.074Z,1714071906.074 [DataOverHttps](INFO): Sending 292 bytes from file Logs/20240425T152029/Express0077.lzma 2024-04-25T19:05:07.076Z,1714071907.076 [DataOverHttps](INFO): Moved sent file to Logs/20240425T152029/Express0077.lzma.bak 2024-04-25T19:05:07.076Z,1714071907.076 [DataOverHttps](INFO): SBD MOMSN=19432396 2024-04-25T19:05:14.665Z,1714071914.665 [Startup:StartupSatComms:B](INFO): Timed out from 2024-04-25T19:04:14.5Z 2024-04-25T19:05:14.665Z,1714071914.665 [Startup:StartupSatComms:B] Stopped 2024-04-25T19:05:14.665Z,1714071914.665 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2024-04-25T19:05:14.665Z,1714071914.665 [Startup:StartupSatComms] Stopped 2024-04-25T19:05:14.665Z,1714071914.665 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2024-04-25T19:05:14.666Z,1714071914.666 [Startup](INFO): Completed Startup 2024-04-25T19:05:14.667Z,1714071914.667 [MissionManager](INFO): Startup is completed. 2024-04-25T19:05:14.667Z,1714071914.667 [MissionManager](INFO): Uninitializing Mission Startup 2024-04-25T19:05:14.667Z,1714071914.667 [Startup] Stopped 2024-04-25T19:05:14.667Z,1714071914.667 [Startup](DEBUG): Aggregate::uninitialize Startup 2024-04-25T19:05:14.667Z,1714071914.667 [Startup:A.GoToSurface] Stopped 2024-04-25T19:05:14.667Z,1714071914.667 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2024-04-25T19:05:15.068Z,1714071915.068 [MissionManager](IMPORTANT): Started mission Default 2024-04-25T19:05:15.068Z,1714071915.068 [Default] Running Loop=1 2024-04-25T19:05:15.068Z,1714071915.068 [Default](DEBUG): Aggregate::initialize Default 2024-04-25T19:05:15.068Z,1714071915.068 [Default:B.GoToSurface] Running Loop=1 2024-04-25T19:05:15.068Z,1714071915.068 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2024-04-25T19:05:15.068Z,1714071915.068 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2024-04-25T19:05:15.069Z,1714071915.069 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2024-04-25T19:05:15.069Z,1714071915.069 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2024-04-25T19:05:15.069Z,1714071915.069 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2024-04-25T19:05:15.070Z,1714071915.070 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2024-04-25T19:05:15.070Z,1714071915.070 [Default:A.Wait] Running Loop=1 2024-04-25T19:05:15.070Z,1714071915.070 [Default:A.Wait](DEBUG): Initialize Wait Component. 2024-04-25T19:05:22.867Z,1714071922.867 [DataOverHttps](INFO): Sending 864 bytes from file Logs/20240425T190143/Express0001.lzma 2024-04-25T19:05:23.867Z,1714071923.867 [DataOverHttps](INFO): Moved sent file to Logs/20240425T190143/Express0001.lzma.bak 2024-04-25T19:05:23.868Z,1714071923.868 [DataOverHttps](INFO): SBD MOMSN=19432403 2024-04-25T19:05:28.380Z,1714071928.380 [Default:A.Wait](INFO): Done Waiting. 2024-04-25T19:05:28.380Z,1714071928.380 [Default:A.Wait] Stopped 2024-04-25T19:05:28.380Z,1714071928.380 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2024-04-25T19:05:28.789Z,1714071928.789 [Default:CheckIn] Running Loop=1 2024-04-25T19:05:28.789Z,1714071928.789 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-04-25T19:05:28.789Z,1714071928.789 [Default:CheckIn:Read_GPS] Running Loop=1 2024-04-25T19:05:29.248Z,1714071929.248 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2024-04-25T19:06:09.271Z,1714071969.271 [CommandExec](IMPORTANT): got command maintain control VerticalControl.buoyancyAction 100 cubic_centimeter 2024-04-25T19:07:35.425Z,1714072055.425 [CommandExec](IMPORTANT): got command maintain control VerticalControl.buoyancyAction 1000 cubic_centimeter 2024-04-25T19:07:37.714Z,1714072057.714 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2024-04-25T19:07:56.270Z,1714072076.270 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2024-04-25T19:07:56.270Z,1714072076.270 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-04-25T19:07:56.271Z,1714072076.271 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 2 2024-04-25T19:07:56.271Z,1714072076.271 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-04-25T19:07:56.330Z,1714072076.330 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-04-25T19:07:56.331Z,1714072076.331 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-04-25T19:07:56.699Z,1714072076.699 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-04-25T19:07:56.699Z,1714072076.699 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2024-04-25T19:07:56.700Z,1714072076.700 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-04-25T19:07:56.700Z,1714072076.700 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 2 2024-04-25T19:07:57.050Z,1714072077.050 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-04-25T19:09:02.359Z,1714072142.359 [CommandExec](IMPORTANT): got command maintain control VerticalControl.buoyancyAction 100 cubic_centimeter 2024-04-25T19:10:25.235Z,1714072225.235 [CommandExec](IMPORTANT): got command maintain control VerticalControl.buoyancyAction 1000 cubic_centimeter 2024-04-25T19:10:28.989Z,1714072228.989 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-04-25T19:05:28.8Z 2024-04-25T19:10:28.989Z,1714072228.989 [Default:CheckIn:Read_GPS] Stopped 2024-04-25T19:10:28.989Z,1714072228.989 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-04-25T19:10:29.381Z,1714072229.381 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications 2024-04-25T19:10:37.895Z,1714072237.895 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240425T190143/Courier0004.lzma 2024-04-25T19:10:38.836Z,1714072238.836 [DataOverHttps](INFO): Moved sent file to Logs/20240425T190143/Courier0004.lzma.bak 2024-04-25T19:10:38.836Z,1714072238.836 [DataOverHttps](INFO): SBD MOMSN=19432486 2024-04-25T19:10:57.346Z,1714072257.346 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3 2024-04-25T19:10:57.346Z,1714072257.346 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-04-25T19:10:57.348Z,1714072257.348 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 3 2024-04-25T19:10:57.348Z,1714072257.348 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-04-25T19:10:57.411Z,1714072257.411 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-04-25T19:10:57.411Z,1714072257.411 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-04-25T19:10:57.782Z,1714072257.782 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-04-25T19:10:57.782Z,1714072257.782 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3 2024-04-25T19:10:57.783Z,1714072257.783 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-04-25T19:10:57.783Z,1714072257.783 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 3 2024-04-25T19:10:58.109Z,1714072258.109 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-04-25T19:11:06.303Z,1714072266.303 [DataOverHttps](INFO): Sending 289 bytes from file Logs/20240425T190143/Express0005.lzma 2024-04-25T19:11:07.304Z,1714072267.304 [DataOverHttps](INFO): Moved sent file to Logs/20240425T190143/Express0005.lzma.bak 2024-04-25T19:11:07.304Z,1714072267.304 [DataOverHttps](INFO): SBD MOMSN=19432488 2024-04-25T19:11:09.044Z,1714072269.044 [Default:CheckIn:Read_Iridium] Stopped 2024-04-25T19:11:09.045Z,1714072269.045 [Default:CheckIn:C.Wait] Running Loop=1 2024-04-25T19:11:09.045Z,1714072269.045 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-04-25T19:12:36.677Z,1714072356.677 [NAL9602](FAULT): GPS failed to acquire within timeout. 2024-04-25T19:12:36.677Z,1714072356.677 [NAL9602] Data Fault, FailCount= 1 2024-04-25T19:12:36.677Z,1714072356.677 [NAL9602](ERROR): Data Fault 2024-04-25T19:12:36.696Z,1714072356.696 [CBIT](ERROR): Data Fault in component: NAL9602 2024-04-25T19:12:37.076Z,1714072357.076 [NAL9602](INFO): Powering down 2024-04-25T19:12:37.905Z,1714072357.905 [CBIT](INFO): Clearing failed state for component NAL9602 2024-04-25T19:12:37.905Z,1714072357.905 [NAL9602] No Fault, FailCount= 1 2024-04-25T19:13:07.379Z,1714072387.379 [NAL9602](INFO): Powering up NAL9602 2024-04-25T19:13:12.268Z,1714072392.268 [CommandExec](IMPORTANT): got command show variable elevatorOffset 2024-04-25T19:13:12.347Z,1714072392.347 [CommandExec](IMPORTANT): ElevatorOffsetCalculator.loadAtStartup (bool) 2024-04-25T19:13:12.348Z,1714072392.348 [CommandExec](IMPORTANT): ElevatorOffsetCalculator.targetConfidenceLevel (percent) 2024-04-25T19:13:12.348Z,1714072392.348 [CommandExec](IMPORTANT): ElevatorOffsetCalculator.targetErrorBound (degree) 2024-04-25T19:13:12.349Z,1714072392.349 [CommandExec](IMPORTANT): ElevatorOffsetCalculator.verbosity (count) 2024-04-25T19:13:12.497Z,1714072392.497 [CommandExec](IMPORTANT): ElevatorOffsetCalculator.enableBroadcast (bool) 2024-04-25T19:13:12.497Z,1714072392.497 [CommandExec](IMPORTANT): ElevatorOffsetCalculator.elevator_angle_average (radian) 2024-04-25T19:13:12.498Z,1714072392.498 [CommandExec](IMPORTANT): ElevatorOffsetCalculator.elevator_angle_variance (radian) 2024-04-25T19:13:12.498Z,1714072392.498 [CommandExec](IMPORTANT): ElevatorOffsetCalculator.elevator_angle_error_bound (radian) 2024-04-25T19:13:12.499Z,1714072392.499 [CommandExec](IMPORTANT): ElevatorOffsetCalculator.elevator_angle_cmd_speed_identifier (meter_per_second) 2024-04-25T19:13:12.499Z,1714072392.499 [CommandExec](IMPORTANT): ElevatorOffsetCalculator.elevator_angle_cmd_pitch_identifier (radian) 2024-04-25T19:13:12.499Z,1714072392.499 [CommandExec](IMPORTANT): ElevatorOffsetCalculator.elevator_angle_cmd_mass_position_identifier (meter) 2024-04-25T19:13:18.345Z,1714072398.345 [NAL9602](INFO): NAL9602 initialized 2024-04-25T19:13:24.785Z,1714072404.785 [CommandExec](IMPORTANT): got command get 2024-04-25T19:13:24.785Z,1714072404.785 [CommandExec](FAULT): Incomplete syntax. Try: help get 2024-04-25T19:13:41.652Z,1714072421.652 [CommandExec](IMPORTANT): got command show variable elevatorServo 2024-04-25T19:13:41.692Z,1714072421.692 [CommandExec](IMPORTANT): ElevatorServo.loadControl (none) 2024-04-25T19:13:41.693Z,1714072421.693 [CommandExec](IMPORTANT): ElevatorServo.uart (none) 2024-04-25T19:13:41.693Z,1714072421.693 [CommandExec](IMPORTANT): ElevatorServo.baud (bit_per_second) 2024-04-25T19:13:41.791Z,1714072421.791 [CommandExec](IMPORTANT): ElevatorServo.loadAtStartup (bool) 2024-04-25T19:13:41.791Z,1714072421.791 [CommandExec](IMPORTANT): ElevatorServo.simulateHardware (bool) 2024-04-25T19:13:41.791Z,1714072421.791 [CommandExec](IMPORTANT): ElevatorServo.countsPerDeg (count_per_angular_degree) 2024-04-25T19:13:41.792Z,1714072421.792 [CommandExec](IMPORTANT): ElevatorServo.currLimit (percent) 2024-04-25T19:13:41.792Z,1714072421.792 [CommandExec](IMPORTANT): ElevatorServo.deviationAngle (angular_degree) 2024-04-25T19:13:41.792Z,1714072421.792 [CommandExec](IMPORTANT): ElevatorServo.limitHi (count) 2024-04-25T19:13:41.793Z,1714072421.793 [CommandExec](IMPORTANT): ElevatorServo.limitLo (count) 2024-04-25T19:13:41.793Z,1714072421.793 [CommandExec](IMPORTANT): ElevatorServo.mtrCenter (count) 2024-04-25T19:13:41.799Z,1714072421.799 [CommandExec](IMPORTANT): ElevatorServo.offsetAngle (degree) 2024-04-25T19:13:41.799Z,1714072421.799 [CommandExec](IMPORTANT): ElevatorServo.pidW (count) 2024-04-25T19:13:41.800Z,1714072421.800 [CommandExec](IMPORTANT): ElevatorServo.pidX (count) 2024-04-25T19:13:41.800Z,1714072421.800 [CommandExec](IMPORTANT): ElevatorServo.pidY (count) 2024-04-25T19:13:41.800Z,1714072421.800 [CommandExec](IMPORTANT): ElevatorServo.powerOnTimeout (second) 2024-04-25T19:13:42.028Z,1714072422.028 [CommandExec](IMPORTANT): ElevatorServo.enableBroadcast (bool) 2024-04-25T19:13:42.028Z,1714072422.028 [CommandExec](IMPORTANT): ElevatorServo.component_voltage (volt) 2024-04-25T19:13:42.028Z,1714072422.028 [CommandExec](IMPORTANT): ElevatorServo.component_avgVoltage (volt) 2024-04-25T19:13:42.029Z,1714072422.029 [CommandExec](IMPORTANT): ElevatorServo.component_current (milliampere) 2024-04-25T19:13:42.029Z,1714072422.029 [CommandExec](IMPORTANT): ElevatorServo.component_avgCurrent (milliampere) 2024-04-25T19:13:42.030Z,1714072422.030 [CommandExec](IMPORTANT): ElevatorServo.platform_elevator_angle (radian) 2024-04-25T19:13:50.108Z,1714072430.108 [CommandExec](IMPORTANT): got command get ElevatorServo.offsetAngle 2024-04-25T19:13:50.109Z,1714072430.109 [CommandExec](IMPORTANT): ElevatorServo.offsetAngle 0.000000 arcdeg 2024-04-25T19:13:58.371Z,1714072438.371 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4 2024-04-25T19:13:58.371Z,1714072438.371 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-04-25T19:13:58.372Z,1714072438.372 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 4 2024-04-25T19:13:58.372Z,1714072438.372 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-04-25T19:13:58.384Z,1714072438.384 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-04-25T19:13:58.384Z,1714072438.384 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-04-25T19:13:58.765Z,1714072438.765 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-04-25T19:13:58.765Z,1714072438.765 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4 2024-04-25T19:13:58.766Z,1714072438.766 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-04-25T19:13:58.766Z,1714072438.766 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 4 2024-04-25T19:13:59.147Z,1714072439.147 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-04-25T19:15:08.111Z,1714072508.111 [CommandExec](IMPORTANT): got command maintain control VerticalControl.buoyancyAction 100 cubic_centimeter 2024-04-25T19:15:29.101Z,1714072529.101 [CommandExec](IMPORTANT): got command get ElevatorServo.offsetAngle 2024-04-25T19:15:29.102Z,1714072529.102 [CommandExec](IMPORTANT): ElevatorServo.offsetAngle 0.000000 arcdeg 2024-04-25T19:16:09.596Z,1714072569.596 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-04-25T19:16:09.597Z,1714072569.597 [Default:CheckIn:C.Wait] Stopped 2024-04-25T19:16:09.597Z,1714072569.597 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-04-25T19:16:09.597Z,1714072569.597 [Default:CheckIn:D] Running Loop=1 2024-04-25T19:16:10.030Z,1714072570.030 [Default:CheckIn:D] Stopped 2024-04-25T19:16:10.030Z,1714072570.030 [Default:CheckIn:E] Running Loop=1 2024-04-25T19:16:10.426Z,1714072570.426 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 10.916030 min 2024-04-25T19:16:10.426Z,1714072570.426 [Default:CheckIn:E] Stopped 2024-04-25T19:16:10.426Z,1714072570.426 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-04-25T19:16:10.426Z,1714072570.426 [Default:CheckIn] Stopped 2024-04-25T19:16:10.426Z,1714072570.426 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-04-25T19:16:10.427Z,1714072570.427 [Default:CheckIn](INFO): Running loop #2 2024-04-25T19:16:10.427Z,1714072570.427 [Default:CheckIn] Running Loop=2 2024-04-25T19:16:10.427Z,1714072570.427 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-04-25T19:16:10.427Z,1714072570.427 [Default:CheckIn:Read_GPS] Running Loop=1 2024-04-25T19:16:18.007Z,1714072578.007 [CommandExec](IMPORTANT): got command maintain control VerticalControl.elevatorAngleAction 15 2024-04-25T19:16:18.007Z,1714072578.007 [CommandExec](FAULT): Incomplete syntax. Try: help maintain 2024-04-25T19:16:36.028Z,1714072596.028 [CommandExec](IMPORTANT): got command show variable elevatorAngle 2024-04-25T19:16:36.196Z,1714072596.196 [CommandExec](IMPORTANT): VerticalControl.elevatorAngleCmd (radian) 2024-04-25T19:16:36.220Z,1714072596.220 [CommandExec](IMPORTANT): VerticalControl.elevatorAngleAction (radian) 2024-04-25T19:16:49.848Z,1714072609.848 [CommandExec](IMPORTANT): got command maintain control VerticalControl.elevatorAngleAction 14 degree 2024-04-25T19:16:49.851Z,1714072609.851 [ComponentRegistry](DEBUG): SyncComponent "Maintain_VerticalControl.elevatorAngleAction" handled in the control thread. 2024-04-25T19:16:50.064Z,1714072610.064 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,MultiRay,NAL9602,PowerOnly,Power24vConverter,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,Maintain_VerticalControl.buoyancyAction,Maintain_VerticalControl.elevatorAngleAction,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2024-04-25T19:16:56.119Z,1714072616.119 [CBIT](INFO): Clearing failed state for component DropWeight 2024-04-25T19:16:56.120Z,1714072616.120 [DropWeight] No Fault, FailCount= 1 2024-04-25T19:16:59.331Z,1714072619.331 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5 2024-04-25T19:16:59.331Z,1714072619.331 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-04-25T19:16:59.333Z,1714072619.333 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 5 2024-04-25T19:16:59.333Z,1714072619.333 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-04-25T19:16:59.345Z,1714072619.345 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-04-25T19:16:59.345Z,1714072619.345 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-04-25T19:16:59.756Z,1714072619.756 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-04-25T19:16:59.756Z,1714072619.756 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5 2024-04-25T19:16:59.756Z,1714072619.756 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-04-25T19:16:59.756Z,1714072619.756 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 5 2024-04-25T19:17:00.149Z,1714072620.149 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-04-25T19:17:10.591Z,1714072630.591 [CommandExec](IMPORTANT): got command get platform_elevator_angle degree 2024-04-25T19:17:10.591Z,1714072630.591 [CommandExec](IMPORTANT): platform_elevator_angle 14.021282 arcdeg 2024-04-25T19:17:20.776Z,1714072640.776 [CommandExec](IMPORTANT): got command maintain control VerticalControl.elevatorAngleAction 15 degree 2024-04-25T19:17:29.545Z,1714072649.545 [CommandExec](IMPORTANT): got command maintain control VerticalControl.elevatorAngleAction -15 degree 2024-04-25T19:17:42.471Z,1714072662.471 [CommandExec](IMPORTANT): got command get platform_elevator_angle degree 2024-04-25T19:17:42.471Z,1714072662.471 [CommandExec](IMPORTANT): platform_elevator_angle -15.044011 arcdeg 2024-04-25T19:17:54.005Z,1714072674.005 [CommandExec](IMPORTANT): got command maintain control VerticalControl.elevatorAngleAction -16 degree 2024-04-25T19:18:00.492Z,1714072680.492 [CommandExec](IMPORTANT): got command get platform_elevator_angle degree 2024-04-25T19:18:00.492Z,1714072680.492 [CommandExec](IMPORTANT): platform_elevator_angle -15.996358 arcdeg 2024-04-25T19:18:42.359Z,1714072722.359 [CommandExec](IMPORTANT): got command show variable offset 2024-04-25T19:18:42.372Z,1714072722.372 [CommandExec](IMPORTANT): ElevatorOffsetCalculator.loadAtStartup (bool) 2024-04-25T19:18:42.372Z,1714072722.372 [CommandExec](IMPORTANT): ElevatorOffsetCalculator.targetConfidenceLevel (percent) 2024-04-25T19:18:42.373Z,1714072722.373 [CommandExec](IMPORTANT): ElevatorOffsetCalculator.targetErrorBound (degree) 2024-04-25T19:18:42.373Z,1714072722.373 [CommandExec](IMPORTANT): ElevatorOffsetCalculator.verbosity (count) 2024-04-25T19:18:42.475Z,1714072722.475 [CommandExec](IMPORTANT): CTD_NeilBrown.offset (decibar) 2024-04-25T19:18:42.476Z,1714072722.476 [CommandExec](IMPORTANT): CTD_Seabird.offset (decibar) 2024-04-25T19:18:42.476Z,1714072722.476 [CommandExec](IMPORTANT): CTD_Seabird.oxygenCalCoeffFOffset (none) 2024-04-25T19:18:42.521Z,1714072722.521 [CommandExec](IMPORTANT): BuoyancyServo.offsetVolume (cubic_centimeter) 2024-04-25T19:18:42.527Z,1714072722.527 [CommandExec](IMPORTANT): DockingServo.offsetAngle (degree) 2024-04-25T19:18:42.529Z,1714072722.529 [CommandExec](IMPORTANT): ElevatorServo.offsetAngle (degree) 2024-04-25T19:18:42.544Z,1714072722.544 [CommandExec](IMPORTANT): RudderServo.offsetAngle (degree) 2024-04-25T19:18:42.593Z,1714072722.593 [CommandExec](IMPORTANT): Simulator.buoyancyNeutralOffset (cubic_centimeter) 2024-04-25T19:18:42.593Z,1714072722.593 [CommandExec](IMPORTANT): Simulator.massPositionOffset (millimeter) 2024-04-25T19:18:42.596Z,1714072722.596 [CommandExec](IMPORTANT): CBIT.runElevOffsetCalc (bool) 2024-04-25T19:18:42.596Z,1714072722.596 [CommandExec](IMPORTANT): CBIT.gfBattOffset (microampere) 2024-04-25T19:18:42.597Z,1714072722.597 [CommandExec](IMPORTANT): CBIT.gf24Offset (microampere) 2024-04-25T19:18:42.597Z,1714072722.597 [CommandExec](IMPORTANT): CBIT.gf12Offset (microampere) 2024-04-25T19:18:42.598Z,1714072722.598 [CommandExec](IMPORTANT): CBIT.gf5Offset (microampere) 2024-04-25T19:18:42.598Z,1714072722.598 [CommandExec](IMPORTANT): CBIT.gf3_3Offset (microampere) 2024-04-25T19:18:42.598Z,1714072722.598 [CommandExec](IMPORTANT): CBIT.gf3_15Offset (microampere) 2024-04-25T19:18:42.599Z,1714072722.599 [CommandExec](IMPORTANT): CBIT.gfCommOffset (microampere) 2024-04-25T19:18:42.600Z,1714072722.600 [CommandExec](IMPORTANT): Docked.dockingDepthOffset (meter) 2024-04-25T19:18:42.611Z,1714072722.611 [CommandExec](IMPORTANT): Depth_Keller.offset (decibar) 2024-04-25T19:18:42.612Z,1714072722.612 [CommandExec](IMPORTANT): DepthKeller33X.offset (decibar) 2024-04-25T19:18:42.613Z,1714072722.613 [CommandExec](IMPORTANT): DVL_micro.pitchOffset (degree) 2024-04-25T19:18:42.613Z,1714072722.613 [CommandExec](IMPORTANT): DVL_micro.rollOffset (degree) 2024-04-25T19:18:42.658Z,1714072722.658 [CommandExec](IMPORTANT): PNI_TCM.pitchOffset (degree) 2024-04-25T19:18:42.658Z,1714072722.658 [CommandExec](IMPORTANT): PNI_TCM.rollOffset (degree) 2024-04-25T19:18:42.659Z,1714072722.659 [CommandExec](IMPORTANT): Rowe_600.headingOffset (degree) 2024-04-25T19:18:42.660Z,1714072722.660 [CommandExec](IMPORTANT): Rowe_600.pitchOffset (degree) 2024-04-25T19:18:42.660Z,1714072722.660 [CommandExec](IMPORTANT): Rowe_600.rollOffset (degree) 2024-04-25T19:18:42.702Z,1714072722.702 [CommandExec](IMPORTANT): ElevatorOffsetCalculator.enableBroadcast (bool) 2024-04-25T19:18:42.703Z,1714072722.703 [CommandExec](IMPORTANT): ElevatorOffsetCalculator.elevator_angle_average (radian) 2024-04-25T19:18:42.703Z,1714072722.703 [CommandExec](IMPORTANT): ElevatorOffsetCalculator.elevator_angle_variance (radian) 2024-04-25T19:18:42.704Z,1714072722.704 [CommandExec](IMPORTANT): ElevatorOffsetCalculator.elevator_angle_error_bound (radian) 2024-04-25T19:18:42.704Z,1714072722.704 [CommandExec](IMPORTANT): ElevatorOffsetCalculator.elevator_angle_cmd_speed_identifier (meter_per_second) 2024-04-25T19:18:42.704Z,1714072722.704 [CommandExec](IMPORTANT): ElevatorOffsetCalculator.elevator_angle_cmd_pitch_identifier (radian) 2024-04-25T19:18:42.705Z,1714072722.705 [CommandExec](IMPORTANT): ElevatorOffsetCalculator.elevator_angle_cmd_mass_position_identifier (meter) 2024-04-25T19:18:42.863Z,1714072722.863 [CommandExec](IMPORTANT): CBIT.empiricalFaultElevOffset (radian) 2024-04-25T19:18:57.573Z,1714072737.573 [CommandExec](IMPORTANT): got command configSet ElevatorServo.offsetAngle -1 degree persist 2024-04-25T19:19:12.866Z,1714072752.866 [CommandExec](IMPORTANT): got command maintain control VerticalControl.elevatorAngleAction 0 degree 2024-04-25T19:19:39.359Z,1714072779.359 [CommandExec](IMPORTANT): got command maintain control VerticalControl.elevatorAngleAction -15 degree 2024-04-25T19:19:52.762Z,1714072792.762 [CommandExec](IMPORTANT): got command get platform_elevator_angle degree 2024-04-25T19:19:52.762Z,1714072792.762 [CommandExec](IMPORTANT): platform_elevator_angle -14.994159 arcdeg 2024-04-25T19:20:00.345Z,1714072800.345 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6 2024-04-25T19:20:00.345Z,1714072800.345 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-04-25T19:20:00.346Z,1714072800.346 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 6 2024-04-25T19:20:00.346Z,1714072800.346 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-04-25T19:20:00.358Z,1714072800.358 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-04-25T19:20:00.358Z,1714072800.358 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-04-25T19:20:00.821Z,1714072800.821 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-04-25T19:20:00.821Z,1714072800.821 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6 2024-04-25T19:20:00.838Z,1714072800.838 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-04-25T19:20:00.838Z,1714072800.838 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 6 2024-04-25T19:20:01.155Z,1714072801.155 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-04-25T19:20:02.620Z,1714072802.620 [CommandExec](IMPORTANT): got command maintain control VerticalControl.elevatorAngleAction 15 degree 2024-04-25T19:20:15.213Z,1714072815.213 [CommandExec](IMPORTANT): got command get platform_elevator_angle degree 2024-04-25T19:20:15.213Z,1714072815.213 [CommandExec](IMPORTANT): platform_elevator_angle 15.021282 arcdeg 2024-04-25T19:20:29.663Z,1714072829.663 [CommandExec](IMPORTANT): got command maintain control VerticalControl.elevatorAngleAction 0 degree 2024-04-25T19:21:10.625Z,1714072870.625 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-04-25T19:16:10.4Z 2024-04-25T19:21:10.625Z,1714072870.625 [Default:CheckIn:Read_GPS] Stopped 2024-04-25T19:21:10.625Z,1714072870.625 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-04-25T19:21:18.277Z,1714072878.277 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240425T190143/Courier0007.lzma 2024-04-25T19:21:19.280Z,1714072879.280 [DataOverHttps](INFO): Moved sent file to Logs/20240425T190143/Courier0007.lzma.bak 2024-04-25T19:21:19.280Z,1714072879.280 [DataOverHttps](INFO): SBD MOMSN=19432565 2024-04-25T19:21:35.192Z,1714072895.192 [DataOverHttps](INFO): Sending 1504 bytes from file Logs/20240425T190143/Express0008.lzma 2024-04-25T19:21:36.194Z,1714072896.194 [DataOverHttps](INFO): Moved sent file to Logs/20240425T190143/Express0008.lzma.bak 2024-04-25T19:21:36.194Z,1714072896.194 [DataOverHttps](INFO): SBD MOMSN=19432567 2024-04-25T19:21:38.132Z,1714072898.132 [Default:CheckIn:Read_Iridium] Stopped 2024-04-25T19:21:38.132Z,1714072898.132 [Default:CheckIn:C.Wait] Running Loop=1 2024-04-25T19:21:38.133Z,1714072898.133 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-04-25T19:23:01.333Z,1714072981.333 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7 2024-04-25T19:23:01.333Z,1714072981.333 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-04-25T19:23:01.334Z,1714072981.334 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 7 2024-04-25T19:23:01.334Z,1714072981.334 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-04-25T19:23:01.346Z,1714072981.346 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-04-25T19:23:01.346Z,1714072981.346 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-04-25T19:23:01.803Z,1714072981.803 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-04-25T19:23:01.803Z,1714072981.803 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7 2024-04-25T19:23:01.804Z,1714072981.804 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-04-25T19:23:01.804Z,1714072981.804 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 7 2024-04-25T19:23:02.132Z,1714072982.132 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-04-25T19:23:21.111Z,1714073001.111 [NAL9602](FAULT): GPS failed to acquire within timeout. 2024-04-25T19:23:21.112Z,1714073001.112 [NAL9602] Data Fault, FailCount= 2 2024-04-25T19:23:21.112Z,1714073001.112 [NAL9602](ERROR): Data Fault 2024-04-25T19:23:21.185Z,1714073001.185 [CBIT](ERROR): Data Fault in component: NAL9602 2024-04-25T19:23:21.515Z,1714073001.515 [NAL9602](INFO): Powering down 2024-04-25T19:23:22.346Z,1714073002.346 [CBIT](INFO): Clearing failed state for component NAL9602 2024-04-25T19:23:22.346Z,1714073002.346 [NAL9602] No Fault, FailCount= 2 2024-04-25T19:23:51.815Z,1714073031.815 [NAL9602](INFO): Powering up NAL9602 2024-04-25T19:24:02.719Z,1714073042.719 [NAL9602](INFO): NAL9602 initialized 2024-04-25T19:25:15.820Z,1714073115.820 [CommandExec](IMPORTANT): got command maintain control VerticalControl.buoyancyAction 1000 cubic_centimeter 2024-04-25T19:26:02.314Z,1714073162.314 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8 2024-04-25T19:26:02.314Z,1714073162.314 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-04-25T19:26:02.315Z,1714073162.315 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 8 2024-04-25T19:26:02.315Z,1714073162.315 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-04-25T19:26:02.383Z,1714073162.383 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-04-25T19:26:02.383Z,1714073162.383 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-04-25T19:26:02.798Z,1714073162.798 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-04-25T19:26:02.798Z,1714073162.798 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8 2024-04-25T19:26:02.799Z,1714073162.799 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-04-25T19:26:02.799Z,1714073162.799 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 8 2024-04-25T19:26:03.143Z,1714073163.143 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-04-25T19:26:38.693Z,1714073198.693 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-04-25T19:26:38.693Z,1714073198.693 [Default:CheckIn:C.Wait] Stopped 2024-04-25T19:26:38.693Z,1714073198.693 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-04-25T19:26:38.693Z,1714073198.693 [Default:CheckIn:D] Running Loop=1 2024-04-25T19:26:39.077Z,1714073199.077 [Default:CheckIn:D] Stopped 2024-04-25T19:26:39.077Z,1714073199.077 [Default:CheckIn:E] Running Loop=1 2024-04-25T19:26:39.499Z,1714073199.499 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 21.400146 min 2024-04-25T19:26:39.499Z,1714073199.499 [Default:CheckIn:E] Stopped 2024-04-25T19:26:39.499Z,1714073199.499 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-04-25T19:26:39.499Z,1714073199.499 [Default:CheckIn] Stopped 2024-04-25T19:26:39.499Z,1714073199.499 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-04-25T19:26:39.499Z,1714073199.499 [Default:CheckIn](INFO): Running loop #3 2024-04-25T19:26:39.499Z,1714073199.499 [Default:CheckIn] Running Loop=3 2024-04-25T19:26:39.499Z,1714073199.499 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-04-25T19:26:39.499Z,1714073199.499 [Default:CheckIn:Read_GPS] Running Loop=1 2024-04-25T19:29:03.331Z,1714073343.331 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 9 2024-04-25T19:29:03.331Z,1714073343.331 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-04-25T19:29:03.332Z,1714073343.332 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 9 2024-04-25T19:29:03.332Z,1714073343.332 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-04-25T19:29:03.343Z,1714073343.343 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-04-25T19:29:03.344Z,1714073343.344 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-04-25T19:29:03.724Z,1714073343.724 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-04-25T19:29:03.724Z,1714073343.724 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 9 2024-04-25T19:29:03.725Z,1714073343.725 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-04-25T19:29:03.725Z,1714073343.725 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 9 2024-04-25T19:29:04.297Z,1714073344.297 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-04-25T19:29:29.113Z,1714073369.113 [CommandExec](IMPORTANT): got command maintain control VerticalControl.buoyancyAction 100 cubic_centimeter 2024-04-25T19:31:07.809Z,1714073467.809 [CommandExec](IMPORTANT): got command get platform_buoyancy_position 2024-04-25T19:31:07.810Z,1714073467.810 [CommandExec](IMPORTANT): platform_buoyancy_position 109.320206 cc 2024-04-25T19:31:35.960Z,1714073495.960 [CommandExec](IMPORTANT): got command maintain control VerticalControl.buoyancyAction 1000 cubic_centimeter 2024-04-25T19:31:39.692Z,1714073499.692 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-04-25T19:26:39.5Z 2024-04-25T19:31:39.692Z,1714073499.692 [Default:CheckIn:Read_GPS] Stopped 2024-04-25T19:31:39.692Z,1714073499.692 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-04-25T19:31:51.118Z,1714073511.118 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240425T190143/Courier0010.lzma 2024-04-25T19:31:52.120Z,1714073512.120 [DataOverHttps](INFO): Moved sent file to Logs/20240425T190143/Courier0010.lzma.bak 2024-04-25T19:31:52.120Z,1714073512.120 [DataOverHttps](INFO): SBD MOMSN=19432738 2024-04-25T19:32:04.327Z,1714073524.327 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 10 2024-04-25T19:32:04.327Z,1714073524.327 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-04-25T19:32:04.328Z,1714073524.328 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 10 2024-04-25T19:32:04.328Z,1714073524.328 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-04-25T19:32:04.403Z,1714073524.403 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-04-25T19:32:04.403Z,1714073524.403 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-04-25T19:32:04.759Z,1714073524.759 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-04-25T19:32:04.759Z,1714073524.759 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 10 2024-04-25T19:32:04.760Z,1714073524.760 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-04-25T19:32:04.760Z,1714073524.760 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 10 2024-04-25T19:32:05.111Z,1714073525.111 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-04-25T19:32:09.850Z,1714073529.850 [DataOverHttps](INFO): Sending 286 bytes from file Logs/20240425T190143/Express0011.lzma 2024-04-25T19:32:10.852Z,1714073530.852 [DataOverHttps](INFO): Moved sent file to Logs/20240425T190143/Express0011.lzma.bak 2024-04-25T19:32:10.852Z,1714073530.852 [DataOverHttps](INFO): SBD MOMSN=19432740 2024-04-25T19:32:12.820Z,1714073532.820 [Default:CheckIn:Read_Iridium] Stopped 2024-04-25T19:32:12.820Z,1714073532.820 [Default:CheckIn:C.Wait] Running Loop=1 2024-04-25T19:32:12.821Z,1714073532.821 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-04-25T19:32:56.000Z,1714073576.000 [BPC1](INFO): Calculating totals. Valid battery stick count: 51. Valid reserve battery stick count: 5. 2024-04-25T19:32:56.003Z,1714073576.003 [BPC1](ERROR): Failed to receive data from all sticks prior to timeout. Will not retry this scan cycle. 2024-04-25T19:33:01.049Z,1714073581.049 [CommandExec](IMPORTANT): got command maintain control VerticalControl.buoyancyAction 100 cubic_centimeter 2024-04-25T19:34:03.875Z,1714073643.875 [NAL9602](FAULT): GPS failed to acquire within timeout. 2024-04-25T19:34:03.875Z,1714073643.875 [NAL9602] Data Fault, FailCount= 3 2024-04-25T19:34:03.875Z,1714073643.875 [NAL9602](ERROR): Data Fault 2024-04-25T19:34:03.971Z,1714073643.971 [CBIT](ERROR): Data Fault in component: NAL9602 2024-04-25T19:34:04.279Z,1714073644.279 [NAL9602](INFO): Powering down 2024-04-25T19:34:05.155Z,1714073645.155 [CBIT](INFO): Clearing failed state for component NAL9602 2024-04-25T19:34:05.155Z,1714073645.155 [NAL9602] No Fault, FailCount= 3 2024-04-25T19:34:23.527Z,1714073663.527 [CommandExec](IMPORTANT): got command maintain control VerticalControl.buoyancyAction 1000 cubic_centimeter 2024-04-25T19:34:34.583Z,1714073674.583 [NAL9602](INFO): Powering up NAL9602 2024-04-25T19:34:45.508Z,1714073685.508 [NAL9602](INFO): NAL9602 initialized 2024-04-25T19:35:05.342Z,1714073705.342 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 11 2024-04-25T19:35:05.342Z,1714073705.342 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-04-25T19:35:05.343Z,1714073705.343 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 11 2024-04-25T19:35:05.343Z,1714073705.343 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-04-25T19:35:05.411Z,1714073705.411 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-04-25T19:35:05.412Z,1714073705.412 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-04-25T19:35:05.771Z,1714073705.771 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-04-25T19:35:05.771Z,1714073705.771 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 11 2024-04-25T19:35:05.771Z,1714073705.771 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-04-25T19:35:05.771Z,1714073705.771 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 11 2024-04-25T19:35:06.143Z,1714073706.143 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-04-25T19:37:13.393Z,1714073833.393 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-04-25T19:37:13.393Z,1714073833.393 [Default:CheckIn:C.Wait] Stopped 2024-04-25T19:37:13.393Z,1714073833.393 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-04-25T19:37:13.393Z,1714073833.393 [Default:CheckIn:D] Running Loop=1 2024-04-25T19:37:13.790Z,1714073833.790 [Default:CheckIn:D] Stopped 2024-04-25T19:37:13.790Z,1714073833.790 [Default:CheckIn:E] Running Loop=1 2024-04-25T19:37:14.192Z,1714073834.192 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 31.978695 min 2024-04-25T19:37:14.192Z,1714073834.192 [Default:CheckIn:E] Stopped 2024-04-25T19:37:14.192Z,1714073834.192 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-04-25T19:37:14.192Z,1714073834.192 [Default:CheckIn] Stopped 2024-04-25T19:37:14.192Z,1714073834.192 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-04-25T19:37:14.193Z,1714073834.193 [Default:CheckIn](INFO): Running loop #4 2024-04-25T19:37:14.193Z,1714073834.193 [Default:CheckIn] Running Loop=4 2024-04-25T19:37:14.193Z,1714073834.193 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-04-25T19:37:14.193Z,1714073834.193 [Default:CheckIn:Read_GPS] Running Loop=1 2024-04-25T19:37:43.519Z,1714073863.519 [CommandExec](IMPORTANT): got command maintain control VerticalControl.buoyancyAction 100 cubic_centimeter 2024-04-25T19:38:06.327Z,1714073886.327 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 12 2024-04-25T19:38:06.327Z,1714073886.327 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-04-25T19:38:06.329Z,1714073886.329 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 12 2024-04-25T19:38:06.329Z,1714073886.329 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-04-25T19:38:06.371Z,1714073886.371 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-04-25T19:38:06.372Z,1714073886.372 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-04-25T19:38:06.752Z,1714073886.752 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-04-25T19:38:06.752Z,1714073886.752 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 12 2024-04-25T19:38:06.752Z,1714073886.752 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-04-25T19:38:06.752Z,1714073886.752 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 12 2024-04-25T19:38:07.114Z,1714073887.114 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-04-25T19:39:12.269Z,1714073952.269 [CommandExec](IMPORTANT): got command maintain control VerticalControl.buoyancyAction 1000 cubic_centimeter 2024-04-25T19:40:42.473Z,1714074042.473 [CommandExec](IMPORTANT): got command maintain control VerticalControl.buoyancyAction 100 cubic_centimeter 2024-04-25T19:41:07.323Z,1714074067.323 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 13 2024-04-25T19:41:07.323Z,1714074067.323 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-04-25T19:41:07.324Z,1714074067.324 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 13 2024-04-25T19:41:07.324Z,1714074067.324 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-04-25T19:41:07.403Z,1714074067.403 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-04-25T19:41:07.403Z,1714074067.403 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-04-25T19:41:07.783Z,1714074067.783 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-04-25T19:41:07.783Z,1714074067.783 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 13 2024-04-25T19:41:07.783Z,1714074067.783 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-04-25T19:41:07.783Z,1714074067.783 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 13 2024-04-25T19:41:08.153Z,1714074068.153 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-04-25T19:42:14.389Z,1714074134.389 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-04-25T19:37:14.2Z 2024-04-25T19:42:14.389Z,1714074134.389 [Default:CheckIn:Read_GPS] Stopped 2024-04-25T19:42:14.389Z,1714074134.389 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-04-25T19:42:20.639Z,1714074140.639 [CommandExec](IMPORTANT): got command maintain control VerticalControl.buoyancyAction 1000 cubic_centimeter 2024-04-25T19:42:22.813Z,1714074142.813 [DataOverHttps](INFO): Sending 169 bytes from file Logs/20240425T190143/Courier0013.lzma 2024-04-25T19:42:23.816Z,1714074143.816 [DataOverHttps](INFO): Moved sent file to Logs/20240425T190143/Courier0013.lzma.bak 2024-04-25T19:42:23.816Z,1714074143.816 [DataOverHttps](INFO): SBD MOMSN=19432848 2024-04-25T19:42:39.634Z,1714074159.634 [DataOverHttps](INFO): Sending 253 bytes from file Logs/20240425T190143/Express0014.lzma 2024-04-25T19:42:40.636Z,1714074160.636 [DataOverHttps](INFO): Moved sent file to Logs/20240425T190143/Express0014.lzma.bak 2024-04-25T19:42:40.637Z,1714074160.637 [DataOverHttps](INFO): SBD MOMSN=19432850 2024-04-25T19:42:42.665Z,1714074162.665 [Default:CheckIn:Read_Iridium] Stopped 2024-04-25T19:42:42.665Z,1714074162.665 [Default:CheckIn:C.Wait] Running Loop=1 2024-04-25T19:42:42.665Z,1714074162.665 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-04-25T19:43:45.750Z,1714074225.750 [CommandExec](IMPORTANT): got command maintain control VerticalControl.buoyancyAction 100 cubic_centimeter 2024-04-25T19:44:08.310Z,1714074248.310 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 14 2024-04-25T19:44:08.310Z,1714074248.310 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-04-25T19:44:08.311Z,1714074248.311 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 14 2024-04-25T19:44:08.311Z,1714074248.311 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-04-25T19:44:08.357Z,1714074248.357 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-04-25T19:44:08.357Z,1714074248.357 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-04-25T19:44:08.744Z,1714074248.744 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-04-25T19:44:08.744Z,1714074248.744 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 14 2024-04-25T19:44:08.744Z,1714074248.744 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-04-25T19:44:08.744Z,1714074248.744 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 14 2024-04-25T19:44:09.099Z,1714074249.099 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-04-25T19:44:46.660Z,1714074286.660 [NAL9602](FAULT): GPS failed to acquire within timeout. 2024-04-25T19:44:46.660Z,1714074286.660 [NAL9602] Data Fault, FailCount= 4 2024-04-25T19:44:46.660Z,1714074286.660 [NAL9602](ERROR): Data Fault 2024-04-25T19:44:46.716Z,1714074286.716 [CBIT](ERROR): Data Fault in component: NAL9602 2024-04-25T19:44:47.063Z,1714074287.063 [NAL9602](INFO): Powering down 2024-04-25T19:44:47.931Z,1714074287.931 [CBIT](INFO): Clearing failed state for component NAL9602 2024-04-25T19:44:47.931Z,1714074287.931 [NAL9602] No Fault, FailCount= 4 2024-04-25T19:45:09.584Z,1714074309.584 [CommandExec](IMPORTANT): got command maintain control VerticalControl.buoyancyAction 1000 cubic_centimeter 2024-04-25T19:45:17.379Z,1714074317.379 [NAL9602](INFO): Powering up NAL9602 2024-04-25T19:45:28.276Z,1714074328.276 [NAL9602](INFO): NAL9602 initialized 2024-04-25T19:46:36.200Z,1714074396.200 [CommandExec](IMPORTANT): got command maintain control VerticalControl.buoyancyAction 100 cubic_centimeter 2024-04-25T19:46:57.571Z,1714074417.571 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2024-04-25T19:46:57.571Z,1714074417.571 [DropWeight] Hardware Fault, FailCount= 1 2024-04-25T19:46:57.571Z,1714074417.571 [DropWeight](ERROR): Hardware Fault 2024-04-25T19:46:57.681Z,1714074417.681 [CBIT](INFO): Critical error at 20240425T194657 2024-04-25T19:46:57.683Z,1714074417.683 [CBIT](ERROR): Hardware Fault in component: DropWeight 2024-04-25T19:46:57.683Z,1714074417.683 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2024-04-25T19:46:58.025Z,1714074418.025 [CBIT](INFO): Critical error at 20240425T194657 2024-04-25T19:47:09.303Z,1714074429.303 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 15 2024-04-25T19:47:09.303Z,1714074429.303 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-04-25T19:47:09.304Z,1714074429.304 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 15 2024-04-25T19:47:09.304Z,1714074429.304 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-04-25T19:47:09.347Z,1714074429.347 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-04-25T19:47:09.347Z,1714074429.347 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-04-25T19:47:09.747Z,1714074429.747 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-04-25T19:47:09.747Z,1714074429.747 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 15 2024-04-25T19:47:09.747Z,1714074429.747 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-04-25T19:47:09.747Z,1714074429.747 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 15 2024-04-25T19:47:10.115Z,1714074430.115 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-04-25T19:47:43.220Z,1714074463.220 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-04-25T19:47:43.221Z,1714074463.221 [Default:CheckIn:C.Wait] Stopped 2024-04-25T19:47:43.221Z,1714074463.221 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-04-25T19:47:43.221Z,1714074463.221 [Default:CheckIn:D] Running Loop=1 2024-04-25T19:47:43.632Z,1714074463.632 [Default:CheckIn:D] Stopped 2024-04-25T19:47:43.632Z,1714074463.632 [Default:CheckIn:E] Running Loop=1 2024-04-25T19:47:44.140Z,1714074464.141 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 42.476074 min 2024-04-25T19:47:44.141Z,1714074464.141 [Default:CheckIn:E] Stopped 2024-04-25T19:47:44.141Z,1714074464.141 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-04-25T19:47:44.141Z,1714074464.141 [Default:CheckIn] Stopped 2024-04-25T19:47:44.141Z,1714074464.141 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-04-25T19:47:44.141Z,1714074464.141 [Default:CheckIn](INFO): Running loop #5 2024-04-25T19:47:44.141Z,1714074464.141 [Default:CheckIn] Running Loop=5 2024-04-25T19:47:44.141Z,1714074464.141 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-04-25T19:47:44.141Z,1714074464.141 [Default:CheckIn:Read_GPS] Running Loop=1 2024-04-25T19:48:00.150Z,1714074480.150 [CommandExec](IMPORTANT): got command maintain control VerticalControl.buoyancyAction 1000 cubic_centimeter 2024-04-25T19:50:10.309Z,1714074610.309 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 16 2024-04-25T19:50:10.309Z,1714074610.309 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-04-25T19:50:10.310Z,1714074610.310 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 16 2024-04-25T19:50:10.310Z,1714074610.310 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-04-25T19:50:10.322Z,1714074610.322 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-04-25T19:50:10.322Z,1714074610.322 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-04-25T19:50:10.710Z,1714074610.710 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-04-25T19:50:10.710Z,1714074610.710 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 16 2024-04-25T19:50:10.711Z,1714074610.711 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-04-25T19:50:10.711Z,1714074610.711 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 16 2024-04-25T19:50:11.107Z,1714074611.107 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-04-25T19:52:44.251Z,1714074764.251 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-04-25T19:47:44.1Z 2024-04-25T19:52:44.251Z,1714074764.251 [Default:CheckIn:Read_GPS] Stopped 2024-04-25T19:52:44.251Z,1714074764.251 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-04-25T19:52:51.913Z,1714074771.913 [DataOverHttps](INFO): Sending 115 bytes from file Logs/20240425T190143/Courier0016.lzma 2024-04-25T19:52:52.916Z,1714074772.916 [DataOverHttps](INFO): Moved sent file to Logs/20240425T190143/Courier0016.lzma.bak 2024-04-25T19:52:52.916Z,1714074772.916 [DataOverHttps](INFO): SBD MOMSN=19432934 2024-04-25T19:53:08.534Z,1714074788.534 [DataOverHttps](INFO): Sending 249 bytes from file Logs/20240425T190143/Express0017.lzma 2024-04-25T19:53:09.536Z,1714074789.536 [DataOverHttps](INFO): Moved sent file to Logs/20240425T190143/Express0017.lzma.bak 2024-04-25T19:53:09.536Z,1714074789.536 [DataOverHttps](INFO): SBD MOMSN=19432938 2024-04-25T19:53:11.277Z,1714074791.277 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 17 2024-04-25T19:53:11.277Z,1714074791.277 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-04-25T19:53:11.279Z,1714074791.279 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 17 2024-04-25T19:53:11.279Z,1714074791.279 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-04-25T19:53:11.280Z,1714074791.280 [Default:CheckIn:Read_Iridium] Stopped 2024-04-25T19:53:11.280Z,1714074791.280 [Default:CheckIn:C.Wait] Running Loop=1 2024-04-25T19:53:11.280Z,1714074791.280 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-04-25T19:53:11.322Z,1714074791.322 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-04-25T19:53:11.323Z,1714074791.323 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-04-25T19:53:11.684Z,1714074791.684 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-04-25T19:53:11.684Z,1714074791.684 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 17 2024-04-25T19:53:11.685Z,1714074791.685 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-04-25T19:53:11.685Z,1714074791.685 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 17 2024-04-25T19:53:12.083Z,1714074792.083 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-04-25T19:55:31.043Z,1714074931.043 [NAL9602](FAULT): GPS failed to acquire within timeout. 2024-04-25T19:55:31.043Z,1714074931.043 [NAL9602] Data Fault, FailCount= 5 2024-04-25T19:55:31.043Z,1714074931.043 [NAL9602](ERROR): Data Fault 2024-04-25T19:55:31.062Z,1714074931.062 [CBIT](ERROR): Data Fault in component: NAL9602 2024-04-25T19:55:31.063Z,1714074931.063 [CBIT](CRITICAL): Data Fault in component: NAL9602 2024-04-25T19:55:31.452Z,1714074931.452 [NAL9602](INFO): Powering down 2024-04-25T19:55:31.470Z,1714074931.470 [CBIT](INFO): Critical error at 20240425T195531 2024-04-25T19:56:12.270Z,1714074972.270 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 18 2024-04-25T19:56:12.270Z,1714074972.270 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-04-25T19:56:12.271Z,1714074972.271 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 18 2024-04-25T19:56:12.271Z,1714074972.271 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-04-25T19:56:12.291Z,1714074972.291 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-04-25T19:56:12.291Z,1714074972.291 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-04-25T19:56:12.708Z,1714074972.708 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-04-25T19:56:12.708Z,1714074972.708 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 18 2024-04-25T19:56:12.709Z,1714074972.709 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-04-25T19:56:12.709Z,1714074972.709 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 18 2024-04-25T19:56:13.063Z,1714074973.063 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-04-25T19:57:31.051Z,1714075051.051 [CBIT](INFO): Clearing failed state for component NAL9602 2024-04-25T19:57:31.051Z,1714075051.051 [NAL9602] No Fault, FailCount= 5 2024-04-25T19:57:31.435Z,1714075051.435 [NAL9602](INFO): Powering up NAL9602 2024-04-25T19:57:42.340Z,1714075062.340 [NAL9602](INFO): NAL9602 initialized 2024-04-25T19:58:11.838Z,1714075091.838 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-04-25T19:58:11.838Z,1714075091.838 [Default:CheckIn:C.Wait] Stopped 2024-04-25T19:58:11.838Z,1714075091.838 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-04-25T19:58:11.838Z,1714075091.838 [Default:CheckIn:D] Running Loop=1 2024-04-25T19:58:12.256Z,1714075092.256 [Default:CheckIn:D] Stopped 2024-04-25T19:58:12.257Z,1714075092.257 [Default:CheckIn:E] Running Loop=1 2024-04-25T19:58:12.666Z,1714075092.666 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 52.953145 min 2024-04-25T19:58:12.666Z,1714075092.666 [Default:CheckIn:E] Stopped 2024-04-25T19:58:12.666Z,1714075092.666 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-04-25T19:58:12.666Z,1714075092.666 [Default:CheckIn] Stopped 2024-04-25T19:58:12.666Z,1714075092.666 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-04-25T19:58:12.666Z,1714075092.666 [Default:CheckIn](INFO): Running loop #6 2024-04-25T19:58:12.666Z,1714075092.666 [Default:CheckIn] Running Loop=6 2024-04-25T19:58:12.667Z,1714075092.667 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-04-25T19:58:12.667Z,1714075092.667 [Default:CheckIn:Read_GPS] Running Loop=1 2024-04-25T19:59:13.264Z,1714075153.264 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 19 2024-04-25T19:59:13.264Z,1714075153.264 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-04-25T19:59:13.265Z,1714075153.265 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 19 2024-04-25T19:59:13.265Z,1714075153.265 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-04-25T19:59:13.277Z,1714075153.277 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-04-25T19:59:13.277Z,1714075153.277 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-04-25T19:59:13.665Z,1714075153.665 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-04-25T19:59:13.665Z,1714075153.665 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 19 2024-04-25T19:59:13.666Z,1714075153.666 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-04-25T19:59:13.666Z,1714075153.666 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 19 2024-04-25T19:59:14.075Z,1714075154.075 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-04-25T20:01:57.698Z,1714075317.698 [CBIT](INFO): Clearing failed state for component DropWeight 2024-04-25T20:01:57.698Z,1714075317.698 [DropWeight] No Fault, FailCount= 1 2024-04-25T20:02:14.242Z,1714075334.242 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 20 2024-04-25T20:02:14.243Z,1714075334.243 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-04-25T20:02:14.244Z,1714075334.244 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 20 2024-04-25T20:02:14.244Z,1714075334.244 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-04-25T20:02:14.275Z,1714075334.275 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-04-25T20:02:14.276Z,1714075334.276 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-04-25T20:02:14.651Z,1714075334.651 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-04-25T20:02:14.651Z,1714075334.651 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 20 2024-04-25T20:02:14.652Z,1714075334.652 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-04-25T20:02:14.652Z,1714075334.652 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 20 2024-04-25T20:02:15.054Z,1714075335.054 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-04-25T20:03:12.825Z,1714075392.825 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-04-25T19:58:12.7Z 2024-04-25T20:03:12.825Z,1714075392.825 [Default:CheckIn:Read_GPS] Stopped 2024-04-25T20:03:12.825Z,1714075392.825 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-04-25T20:03:19.805Z,1714075399.805 [DataOverHttps](INFO): Sending 81 bytes from file Logs/20240425T190143/Courier0019.lzma 2024-04-25T20:03:20.808Z,1714075400.808 [DataOverHttps](INFO): Moved sent file to Logs/20240425T190143/Courier0019.lzma.bak 2024-04-25T20:03:20.808Z,1714075400.808 [DataOverHttps](INFO): SBD MOMSN=19433006 2024-04-25T20:03:36.637Z,1714075416.637 [DataOverHttps](INFO): Sending 150 bytes from file Logs/20240425T190143/Express0020.lzma 2024-04-25T20:03:37.640Z,1714075417.640 [DataOverHttps](INFO): Moved sent file to Logs/20240425T190143/Express0020.lzma.bak 2024-04-25T20:03:37.640Z,1714075417.640 [DataOverHttps](INFO): SBD MOMSN=19433009 2024-04-25T20:03:39.528Z,1714075419.528 [Default:CheckIn:Read_Iridium] Stopped 2024-04-25T20:03:39.528Z,1714075419.528 [Default:CheckIn:C.Wait] Running Loop=1 2024-04-25T20:03:39.528Z,1714075419.528 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-04-25T20:05:15.246Z,1714075515.246 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 21 2024-04-25T20:05:15.246Z,1714075515.246 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-04-25T20:05:15.247Z,1714075515.247 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 21 2024-04-25T20:05:15.247Z,1714075515.247 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-04-25T20:05:15.283Z,1714075515.283 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-04-25T20:05:15.283Z,1714075515.283 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-04-25T20:05:15.662Z,1714075515.662 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-04-25T20:05:15.662Z,1714075515.662 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 21 2024-04-25T20:05:15.662Z,1714075515.662 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-04-25T20:05:15.662Z,1714075515.662 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 21 2024-04-25T20:05:16.058Z,1714075516.058 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-04-25T20:07:43.508Z,1714075663.508 [NAL9602](FAULT): GPS failed to acquire within timeout. 2024-04-25T20:07:43.508Z,1714075663.508 [NAL9602] Data Fault, FailCount= 1 2024-04-25T20:07:43.508Z,1714075663.508 [NAL9602](ERROR): Data Fault 2024-04-25T20:07:43.546Z,1714075663.546 [CBIT](ERROR): Data Fault in component: NAL9602 2024-04-25T20:07:43.911Z,1714075663.911 [NAL9602](INFO): Powering down 2024-04-25T20:07:44.734Z,1714075664.734 [CBIT](INFO): Clearing failed state for component NAL9602 2024-04-25T20:07:44.734Z,1714075664.734 [NAL9602] No Fault, FailCount= 1 2024-04-25T20:08:14.213Z,1714075694.213 [NAL9602](INFO): Powering up NAL9602 2024-04-25T20:08:16.248Z,1714075696.248 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 22 2024-04-25T20:08:16.248Z,1714075696.248 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-04-25T20:08:16.249Z,1714075696.249 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 22 2024-04-25T20:08:16.249Z,1714075696.249 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-04-25T20:08:16.260Z,1714075696.260 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-04-25T20:08:16.261Z,1714075696.261 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-04-25T20:08:16.673Z,1714075696.673 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-04-25T20:08:16.673Z,1714075696.673 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 22 2024-04-25T20:08:16.673Z,1714075696.673 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-04-25T20:08:16.673Z,1714075696.673 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 22 2024-04-25T20:08:17.046Z,1714075697.046 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-04-25T20:08:25.116Z,1714075705.116 [NAL9602](INFO): NAL9602 initialized 2024-04-25T20:08:40.077Z,1714075720.077 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-04-25T20:08:40.077Z,1714075720.077 [Default:CheckIn:C.Wait] Stopped 2024-04-25T20:08:40.077Z,1714075720.077 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-04-25T20:08:40.077Z,1714075720.077 [Default:CheckIn:D] Running Loop=1 2024-04-25T20:08:40.490Z,1714075720.490 [Default:CheckIn:D] Stopped 2024-04-25T20:08:40.490Z,1714075720.490 [Default:CheckIn:E] Running Loop=1 2024-04-25T20:08:40.908Z,1714075720.908 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 63.423694 min 2024-04-25T20:08:40.908Z,1714075720.908 [Default:CheckIn:E] Stopped 2024-04-25T20:08:40.908Z,1714075720.908 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-04-25T20:08:40.908Z,1714075720.908 [Default:CheckIn] Stopped 2024-04-25T20:08:40.908Z,1714075720.908 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-04-25T20:08:40.909Z,1714075720.909 [Default:CheckIn](INFO): Running loop #7 2024-04-25T20:08:40.909Z,1714075720.909 [Default:CheckIn] Running Loop=7 2024-04-25T20:08:40.909Z,1714075720.909 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-04-25T20:08:40.909Z,1714075720.909 [Default:CheckIn:Read_GPS] Running Loop=1 2024-04-25T20:11:17.243Z,1714075877.243 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 23 2024-04-25T20:11:17.243Z,1714075877.243 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-04-25T20:11:17.244Z,1714075877.244 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 23 2024-04-25T20:11:17.244Z,1714075877.244 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-04-25T20:11:17.284Z,1714075877.284 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-04-25T20:11:17.284Z,1714075877.284 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-04-25T20:11:17.657Z,1714075877.657 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-04-25T20:11:17.657Z,1714075877.657 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 23 2024-04-25T20:11:17.657Z,1714075877.657 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-04-25T20:11:17.657Z,1714075877.657 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 23 2024-04-25T20:11:18.074Z,1714075878.074 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-04-25T20:13:41.070Z,1714076021.070 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-04-25T20:08:40.9Z 2024-04-25T20:13:41.070Z,1714076021.070 [Default:CheckIn:Read_GPS] Stopped 2024-04-25T20:13:41.070Z,1714076021.070 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-04-25T20:13:47.809Z,1714076027.809 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240425T190143/Courier0022.lzma 2024-04-25T20:13:48.825Z,1714076028.825 [DataOverHttps](INFO): Moved sent file to Logs/20240425T190143/Courier0022.lzma.bak 2024-04-25T20:13:48.825Z,1714076028.825 [DataOverHttps](INFO): SBD MOMSN=19433085 2024-04-25T20:14:04.437Z,1714076044.437 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20240425T190143/Express0023.lzma 2024-04-25T20:14:05.440Z,1714076045.440 [DataOverHttps](INFO): Moved sent file to Logs/20240425T190143/Express0023.lzma.bak 2024-04-25T20:14:05.440Z,1714076045.440 [DataOverHttps](INFO): SBD MOMSN=19433087 2024-04-25T20:14:07.336Z,1714076047.336 [Default:CheckIn:Read_Iridium] Stopped 2024-04-25T20:14:07.336Z,1714076047.336 [Default:CheckIn:C.Wait] Running Loop=1 2024-04-25T20:14:07.337Z,1714076047.337 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-04-25T20:14:18.259Z,1714076058.259 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 24 2024-04-25T20:14:18.259Z,1714076058.259 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-04-25T20:14:18.260Z,1714076058.260 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 24 2024-04-25T20:14:18.260Z,1714076058.260 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-04-25T20:14:18.271Z,1714076058.271 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-04-25T20:14:18.272Z,1714076058.272 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-04-25T20:14:18.673Z,1714076058.673 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-04-25T20:14:18.673Z,1714076058.673 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 24 2024-04-25T20:14:18.674Z,1714076058.674 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-04-25T20:14:18.674Z,1714076058.674 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 24 2024-04-25T20:14:19.177Z,1714076059.177 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-04-25T20:17:19.259Z,1714076239.259 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 25 2024-04-25T20:17:19.259Z,1714076239.259 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-04-25T20:17:19.260Z,1714076239.260 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 25 2024-04-25T20:17:19.260Z,1714076239.260 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-04-25T20:17:19.300Z,1714076239.300 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-04-25T20:17:19.300Z,1714076239.300 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-04-25T20:17:19.668Z,1714076239.668 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-04-25T20:17:19.668Z,1714076239.668 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 25 2024-04-25T20:17:19.669Z,1714076239.669 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-04-25T20:17:19.669Z,1714076239.669 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 25 2024-04-25T20:17:20.087Z,1714076240.087 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-04-25T20:18:27.924Z,1714076307.924 [NAL9602](FAULT): GPS failed to acquire within timeout. 2024-04-25T20:18:27.924Z,1714076307.924 [NAL9602] Data Fault, FailCount= 2 2024-04-25T20:18:27.924Z,1714076307.924 [NAL9602](ERROR): Data Fault 2024-04-25T20:18:27.963Z,1714076307.963 [CBIT](ERROR): Data Fault in component: NAL9602 2024-04-25T20:18:28.332Z,1714076308.332 [NAL9602](INFO): Powering down 2024-04-25T20:18:29.166Z,1714076309.166 [CBIT](INFO): Clearing failed state for component NAL9602 2024-04-25T20:18:29.166Z,1714076309.166 [NAL9602] No Fault, FailCount= 2 2024-04-25T20:18:58.631Z,1714076338.631 [NAL9602](INFO): Powering up NAL9602 2024-04-25T20:19:07.933Z,1714076347.933 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-04-25T20:19:07.933Z,1714076347.933 [Default:CheckIn:C.Wait] Stopped 2024-04-25T20:19:07.933Z,1714076347.933 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-04-25T20:19:07.933Z,1714076347.933 [Default:CheckIn:D] Running Loop=1 2024-04-25T20:19:08.337Z,1714076348.337 [Default:CheckIn:D] Stopped 2024-04-25T20:19:08.337Z,1714076348.337 [Default:CheckIn:E] Running Loop=1 2024-04-25T20:19:08.752Z,1714076348.752 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 73.887817 min 2024-04-25T20:19:08.752Z,1714076348.752 [Default:CheckIn:E] Stopped 2024-04-25T20:19:08.752Z,1714076348.752 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-04-25T20:19:08.752Z,1714076348.752 [Default:CheckIn] Stopped 2024-04-25T20:19:08.753Z,1714076348.753 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-04-25T20:19:08.753Z,1714076348.753 [Default:CheckIn](INFO): Running loop #8 2024-04-25T20:19:08.753Z,1714076348.753 [Default:CheckIn] Running Loop=8 2024-04-25T20:19:08.753Z,1714076348.753 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-04-25T20:19:08.753Z,1714076348.753 [Default:CheckIn:Read_GPS] Running Loop=1 2024-04-25T20:19:09.539Z,1714076349.539 [NAL9602](INFO): NAL9602 initialized 2024-04-25T20:20:20.263Z,1714076420.263 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 26 2024-04-25T20:20:20.263Z,1714076420.263 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-04-25T20:20:20.264Z,1714076420.264 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 26 2024-04-25T20:20:20.264Z,1714076420.264 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-04-25T20:20:20.275Z,1714076420.275 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-04-25T20:20:20.276Z,1714076420.276 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-04-25T20:20:20.668Z,1714076420.668 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-04-25T20:20:20.668Z,1714076420.668 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 26 2024-04-25T20:20:20.669Z,1714076420.669 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-04-25T20:20:20.669Z,1714076420.669 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 26 2024-04-25T20:20:21.056Z,1714076421.056 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-04-25T20:23:21.248Z,1714076601.248 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 27 2024-04-25T20:23:21.248Z,1714076601.248 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-04-25T20:23:21.250Z,1714076601.250 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 27 2024-04-25T20:23:21.250Z,1714076601.250 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-04-25T20:23:21.261Z,1714076601.261 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-04-25T20:23:21.261Z,1714076601.261 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-04-25T20:23:21.669Z,1714076601.669 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-04-25T20:23:21.669Z,1714076601.669 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 27 2024-04-25T20:23:21.674Z,1714076601.674 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-04-25T20:23:21.674Z,1714076601.674 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 27 2024-04-25T20:23:22.047Z,1714076602.047 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-04-25T20:24:08.917Z,1714076648.917 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-04-25T20:19:08.8Z 2024-04-25T20:24:08.917Z,1714076648.917 [Default:CheckIn:Read_GPS] Stopped 2024-04-25T20:24:08.917Z,1714076648.917 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-04-25T20:24:16.065Z,1714076656.065 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240425T190143/Courier0025.lzma 2024-04-25T20:24:17.068Z,1714076657.068 [DataOverHttps](INFO): Moved sent file to Logs/20240425T190143/Courier0025.lzma.bak 2024-04-25T20:24:17.068Z,1714076657.068 [DataOverHttps](INFO): SBD MOMSN=19433174 2024-04-25T20:24:32.669Z,1714076672.669 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20240425T190143/Express0026.lzma 2024-04-25T20:24:33.674Z,1714076673.674 [DataOverHttps](INFO): Moved sent file to Logs/20240425T190143/Express0026.lzma.bak 2024-04-25T20:24:33.675Z,1714076673.675 [DataOverHttps](INFO): SBD MOMSN=19433177 2024-04-25T20:24:35.582Z,1714076675.582 [Default:CheckIn:Read_Iridium] Stopped 2024-04-25T20:24:35.582Z,1714076675.582 [Default:CheckIn:C.Wait] Running Loop=1 2024-04-25T20:24:35.582Z,1714076675.582 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-04-25T20:26:22.241Z,1714076782.241 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 28 2024-04-25T20:26:22.241Z,1714076782.241 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-04-25T20:26:22.243Z,1714076782.243 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 28 2024-04-25T20:26:22.243Z,1714076782.243 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-04-25T20:26:22.254Z,1714076782.254 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-04-25T20:26:22.254Z,1714076782.254 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-04-25T20:26:22.665Z,1714076782.665 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-04-25T20:26:22.665Z,1714076782.665 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 28 2024-04-25T20:26:22.665Z,1714076782.665 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-04-25T20:26:22.665Z,1714076782.665 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 28 2024-04-25T20:26:23.038Z,1714076783.038 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-04-25T20:29:10.688Z,1714076950.688 [NAL9602](FAULT): GPS failed to acquire within timeout. 2024-04-25T20:29:10.688Z,1714076950.688 [NAL9602] Data Fault, FailCount= 3 2024-04-25T20:29:10.688Z,1714076950.688 [NAL9602](ERROR): Data Fault 2024-04-25T20:29:10.707Z,1714076950.707 [CBIT](ERROR): Data Fault in component: NAL9602 2024-04-25T20:29:11.099Z,1714076951.099 [NAL9602](INFO): Powering down 2024-04-25T20:29:11.942Z,1714076951.942 [CBIT](INFO): Clearing failed state for component NAL9602 2024-04-25T20:29:11.942Z,1714076951.942 [NAL9602] No Fault, FailCount= 3 2024-04-25T20:29:23.219Z,1714076963.219 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 29 2024-04-25T20:29:23.219Z,1714076963.219 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-04-25T20:29:23.220Z,1714076963.220 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 29 2024-04-25T20:29:23.220Z,1714076963.220 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-04-25T20:29:23.264Z,1714076963.264 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-04-25T20:29:23.264Z,1714076963.264 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-04-25T20:29:23.670Z,1714076963.670 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-04-25T20:29:23.670Z,1714076963.670 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 29 2024-04-25T20:29:23.671Z,1714076963.671 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-04-25T20:29:23.671Z,1714076963.671 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 29 2024-04-25T20:29:24.037Z,1714076964.037 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-04-25T20:29:36.148Z,1714076976.148 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-04-25T20:29:36.149Z,1714076976.149 [Default:CheckIn:C.Wait] Stopped 2024-04-25T20:29:36.149Z,1714076976.149 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-04-25T20:29:36.149Z,1714076976.149 [Default:CheckIn:D] Running Loop=1 2024-04-25T20:29:36.552Z,1714076976.552 [Default:CheckIn:D] Stopped 2024-04-25T20:29:36.552Z,1714076976.552 [Default:CheckIn:E] Running Loop=1 2024-04-25T20:29:36.961Z,1714076976.961 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 84.358073 min 2024-04-25T20:29:36.961Z,1714076976.961 [Default:CheckIn:E] Stopped 2024-04-25T20:29:36.962Z,1714076976.962 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-04-25T20:29:36.962Z,1714076976.962 [Default:CheckIn] Stopped 2024-04-25T20:29:36.962Z,1714076976.962 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-04-25T20:29:36.962Z,1714076976.962 [Default:CheckIn](INFO): Running loop #9 2024-04-25T20:29:36.962Z,1714076976.962 [Default:CheckIn] Running Loop=9 2024-04-25T20:29:36.962Z,1714076976.962 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-04-25T20:29:36.962Z,1714076976.962 [Default:CheckIn:Read_GPS] Running Loop=1 2024-04-25T20:29:41.395Z,1714076981.395 [NAL9602](INFO): Powering up NAL9602 2024-04-25T20:29:52.300Z,1714076992.300 [NAL9602](INFO): NAL9602 initialized 2024-04-25T20:31:59.181Z,1714077119.181 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2024-04-25T20:31:59.181Z,1714077119.181 [DropWeight] Hardware Fault, FailCount= 1 2024-04-25T20:31:59.181Z,1714077119.181 [DropWeight](ERROR): Hardware Fault 2024-04-25T20:31:59.216Z,1714077119.216 [CBIT](INFO): Critical error at 20240425T203159 2024-04-25T20:31:59.219Z,1714077119.219 [CBIT](ERROR): Hardware Fault in component: DropWeight 2024-04-25T20:31:59.219Z,1714077119.219 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2024-04-25T20:31:59.626Z,1714077119.626 [CBIT](INFO): Critical error at 20240425T203159 2024-04-25T20:32:24.235Z,1714077144.235 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 30 2024-04-25T20:32:24.235Z,1714077144.235 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-04-25T20:32:24.236Z,1714077144.236 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 30 2024-04-25T20:32:24.236Z,1714077144.236 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-04-25T20:32:24.248Z,1714077144.248 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-04-25T20:32:24.248Z,1714077144.248 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-04-25T20:32:24.651Z,1714077144.651 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-04-25T20:32:24.651Z,1714077144.651 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 30 2024-04-25T20:32:24.651Z,1714077144.651 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-04-25T20:32:24.651Z,1714077144.651 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 30 2024-04-25T20:32:25.058Z,1714077145.058 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-04-25T20:34:37.149Z,1714077277.149 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-04-25T20:29:36.0Z 2024-04-25T20:34:37.149Z,1714077277.149 [Default:CheckIn:Read_GPS] Stopped 2024-04-25T20:34:37.149Z,1714077277.149 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-04-25T20:34:44.845Z,1714077284.845 [DataOverHttps](INFO): Sending 115 bytes from file Logs/20240425T190143/Courier0028.lzma 2024-04-25T20:34:45.848Z,1714077285.848 [DataOverHttps](INFO): Moved sent file to Logs/20240425T190143/Courier0028.lzma.bak 2024-04-25T20:34:45.848Z,1714077285.848 [DataOverHttps](INFO): SBD MOMSN=19433264 2024-04-25T20:35:01.757Z,1714077301.757 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20240425T190143/Express0029.lzma 2024-04-25T20:35:02.760Z,1714077302.760 [DataOverHttps](INFO): Moved sent file to Logs/20240425T190143/Express0029.lzma.bak 2024-04-25T20:35:02.760Z,1714077302.760 [DataOverHttps](INFO): SBD MOMSN=19433272 2024-04-25T20:35:04.632Z,1714077304.632 [Default:CheckIn:Read_Iridium] Stopped 2024-04-25T20:35:04.632Z,1714077304.632 [Default:CheckIn:C.Wait] Running Loop=1 2024-04-25T20:35:04.632Z,1714077304.632 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-04-25T20:35:25.237Z,1714077325.237 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 31 2024-04-25T20:35:25.237Z,1714077325.237 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-04-25T20:35:25.238Z,1714077325.238 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 31 2024-04-25T20:35:25.238Z,1714077325.238 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-04-25T20:35:25.250Z,1714077325.250 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-04-25T20:35:25.250Z,1714077325.250 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-04-25T20:35:25.657Z,1714077325.657 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-04-25T20:35:25.657Z,1714077325.657 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 31 2024-04-25T20:35:25.662Z,1714077325.662 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-04-25T20:35:25.662Z,1714077325.662 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 31 2024-04-25T20:35:26.051Z,1714077326.051 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-04-25T20:38:02.351Z,1714077482.351 [CommandExec](IMPORTANT): got command maintain control VerticalControl.buoyancyAction 100 cubic_centimeter 2024-04-25T20:38:26.281Z,1714077506.281 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 32 2024-04-25T20:38:26.282Z,1714077506.282 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-04-25T20:38:26.283Z,1714077506.283 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 32 2024-04-25T20:38:26.283Z,1714077506.283 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-04-25T20:38:26.340Z,1714077506.340 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-04-25T20:38:26.340Z,1714077506.340 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-04-25T20:38:26.667Z,1714077506.667 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-04-25T20:38:26.668Z,1714077506.668 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 32 2024-04-25T20:38:26.668Z,1714077506.668 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-04-25T20:38:26.668Z,1714077506.668 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 32 2024-04-25T20:38:27.059Z,1714077507.059 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-04-25T20:39:53.471Z,1714077593.471 [NAL9602](FAULT): GPS failed to acquire within timeout. 2024-04-25T20:39:53.471Z,1714077593.471 [NAL9602] Data Fault, FailCount= 4 2024-04-25T20:39:53.471Z,1714077593.471 [NAL9602](ERROR): Data Fault 2024-04-25T20:39:53.562Z,1714077593.562 [CBIT](ERROR): Data Fault in component: NAL9602 2024-04-25T20:39:53.887Z,1714077593.887 [NAL9602](INFO): Powering down 2024-04-25T20:39:54.723Z,1714077594.723 [CBIT](INFO): Clearing failed state for component NAL9602 2024-04-25T20:39:54.724Z,1714077594.724 [NAL9602] No Fault, FailCount= 4 2024-04-25T20:40:05.200Z,1714077605.200 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-04-25T20:40:05.200Z,1714077605.200 [Default:CheckIn:C.Wait] Stopped 2024-04-25T20:40:05.200Z,1714077605.200 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-04-25T20:40:05.200Z,1714077605.200 [Default:CheckIn:D] Running Loop=1 2024-04-25T20:40:05.612Z,1714077605.612 [Default:CheckIn:D] Stopped 2024-04-25T20:40:05.612Z,1714077605.612 [Default:CheckIn:E] Running Loop=1 2024-04-25T20:40:06.008Z,1714077606.008 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 94.842407 min 2024-04-25T20:40:06.008Z,1714077606.008 [Default:CheckIn:E] Stopped 2024-04-25T20:40:06.008Z,1714077606.008 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-04-25T20:40:06.008Z,1714077606.008 [Default:CheckIn] Stopped 2024-04-25T20:40:06.008Z,1714077606.008 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-04-25T20:40:06.008Z,1714077606.008 [Default:CheckIn](INFO): Running loop #10 2024-04-25T20:40:06.008Z,1714077606.008 [Default:CheckIn] Running Loop=10 2024-04-25T20:40:06.008Z,1714077606.008 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-04-25T20:40:06.008Z,1714077606.008 [Default:CheckIn:Read_GPS] Running Loop=1 2024-04-25T20:40:09.744Z,1714077609.744 [CommandExec](IMPORTANT): got command maintain control VerticalControl.buoyancyAction 100 cubic_centimeter 2024-04-25T20:40:24.195Z,1714077624.195 [NAL9602](INFO): Powering up NAL9602 2024-04-25T20:40:35.138Z,1714077635.138 [NAL9602](INFO): NAL9602 initialized 2024-04-25T20:40:55.955Z,1714077655.955 [CommandExec](IMPORTANT): got command maintain control VerticalControl.buoyancyAction 100 cubic_centimeter 2024-04-25T20:41:27.223Z,1714077687.223 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 33 2024-04-25T20:41:27.224Z,1714077687.224 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-04-25T20:41:27.228Z,1714077687.228 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 33 2024-04-25T20:41:27.228Z,1714077687.228 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-04-25T20:41:27.240Z,1714077687.240 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-04-25T20:41:27.240Z,1714077687.240 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-04-25T20:41:27.642Z,1714077687.642 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-04-25T20:41:27.642Z,1714077687.642 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 33 2024-04-25T20:41:27.643Z,1714077687.643 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-04-25T20:41:27.643Z,1714077687.643 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 33 2024-04-25T20:41:28.015Z,1714077688.015 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-04-25T20:42:27.679Z,1714077747.679 [CommandExec](IMPORTANT): got command maintain control VerticalControl.buoyancyAction 1000 cubic_centimeter 2024-04-25T20:44:28.203Z,1714077868.203 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 34 2024-04-25T20:44:28.203Z,1714077868.203 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-04-25T20:44:28.204Z,1714077868.204 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 34 2024-04-25T20:44:28.204Z,1714077868.204 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-04-25T20:44:28.252Z,1714077868.252 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-04-25T20:44:28.252Z,1714077868.252 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-04-25T20:44:28.617Z,1714077868.617 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-04-25T20:44:28.617Z,1714077868.617 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 34 2024-04-25T20:44:28.617Z,1714077868.617 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-04-25T20:44:28.618Z,1714077868.618 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 34 2024-04-25T20:44:29.015Z,1714077869.015 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-04-25T20:44:41.617Z,1714077881.617 [CommandExec](IMPORTANT): got command maintain control VerticalControl.elevatorAngleAction 15 degree 2024-04-25T20:45:03.462Z,1714077903.462 [CommandExec](IMPORTANT): got command maintain control VerticalControl.elevatorAngleAction -15 degree 2024-04-25T20:45:06.182Z,1714077906.182 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-04-25T20:40:06.0Z 2024-04-25T20:45:06.182Z,1714077906.182 [Default:CheckIn:Read_GPS] Stopped 2024-04-25T20:45:06.182Z,1714077906.182 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-04-25T20:45:13.021Z,1714077913.021 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240425T190143/Courier0031.lzma 2024-04-25T20:45:14.044Z,1714077914.044 [DataOverHttps](INFO): Moved sent file to Logs/20240425T190143/Courier0031.lzma.bak 2024-04-25T20:45:14.044Z,1714077914.044 [DataOverHttps](INFO): SBD MOMSN=19433340 2024-04-25T20:45:29.830Z,1714077929.830 [DataOverHttps](INFO): Sending 278 bytes from file Logs/20240425T190143/Express0032.lzma 2024-04-25T20:45:30.831Z,1714077930.831 [DataOverHttps](INFO): Moved sent file to Logs/20240425T190143/Express0032.lzma.bak 2024-04-25T20:45:30.832Z,1714077930.832 [DataOverHttps](INFO): SBD MOMSN=19433342 2024-04-25T20:45:32.988Z,1714077932.988 [CommandExec](IMPORTANT): got command maintain control VerticalControl.elevatorAngleAction 0 degree 2024-04-25T20:45:33.272Z,1714077933.272 [Default:CheckIn:Read_Iridium] Stopped 2024-04-25T20:45:33.272Z,1714077933.272 [Default:CheckIn:C.Wait] Running Loop=1 2024-04-25T20:45:33.272Z,1714077933.272 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-04-25T20:46:40.475Z,1714078000.475 [CommandExec](IMPORTANT): got command maintain clear 2024-04-25T20:46:40.748Z,1714078000.748 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,MultiRay,NAL9602,PowerOnly,Power24vConverter,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2024-04-25T20:46:59.306Z,1714078019.306 [CBIT](INFO): Clearing failed state for component DropWeight 2024-04-25T20:46:59.306Z,1714078019.306 [DropWeight] No Fault, FailCount= 1 2024-04-25T20:47:29.219Z,1714078049.219 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 35 2024-04-25T20:47:29.219Z,1714078049.219 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-04-25T20:47:29.220Z,1714078049.220 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 35 2024-04-25T20:47:29.220Z,1714078049.220 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-04-25T20:47:29.283Z,1714078049.283 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-04-25T20:47:29.283Z,1714078049.283 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-04-25T20:47:29.628Z,1714078049.628 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-04-25T20:47:29.628Z,1714078049.628 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 35 2024-04-25T20:47:29.628Z,1714078049.628 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-04-25T20:47:29.628Z,1714078049.628 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 35 2024-04-25T20:47:30.017Z,1714078050.017 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-04-25T20:50:30.187Z,1714078230.187 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 36 2024-04-25T20:50:30.187Z,1714078230.187 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-04-25T20:50:30.188Z,1714078230.188 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 36 2024-04-25T20:50:30.188Z,1714078230.188 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-04-25T20:50:30.231Z,1714078230.231 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-04-25T20:50:30.231Z,1714078230.231 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-04-25T20:50:30.601Z,1714078230.601 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-04-25T20:50:30.601Z,1714078230.601 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 36 2024-04-25T20:50:30.601Z,1714078230.601 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-04-25T20:50:30.601Z,1714078230.601 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 36 2024-04-25T20:50:31.015Z,1714078231.015 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-04-25T20:50:33.856Z,1714078233.856 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-04-25T20:50:33.857Z,1714078233.857 [Default:CheckIn:C.Wait] Stopped 2024-04-25T20:50:33.857Z,1714078233.857 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-04-25T20:50:33.857Z,1714078233.857 [Default:CheckIn:D] Running Loop=1 2024-04-25T20:50:34.253Z,1714078234.253 [Default:CheckIn:D] Stopped 2024-04-25T20:50:34.253Z,1714078234.253 [Default:CheckIn:E] Running Loop=1 2024-04-25T20:50:34.649Z,1714078234.649 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 105.319751 min 2024-04-25T20:50:34.649Z,1714078234.649 [Default:CheckIn:E] Stopped 2024-04-25T20:50:34.650Z,1714078234.650 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-04-25T20:50:34.650Z,1714078234.650 [Default:CheckIn] Stopped 2024-04-25T20:50:34.650Z,1714078234.650 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-04-25T20:50:34.650Z,1714078234.650 [Default:CheckIn](INFO): Running loop #11 2024-04-25T20:50:34.650Z,1714078234.650 [Default:CheckIn] Running Loop=11 2024-04-25T20:50:34.650Z,1714078234.650 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-04-25T20:50:34.650Z,1714078234.650 [Default:CheckIn:Read_GPS] Running Loop=1 2024-04-25T20:50:36.252Z,1714078236.252 [NAL9602](FAULT): GPS failed to acquire within timeout. 2024-04-25T20:50:36.252Z,1714078236.252 [NAL9602] Data Fault, FailCount= 5 2024-04-25T20:50:36.252Z,1714078236.252 [NAL9602](ERROR): Data Fault 2024-04-25T20:50:36.282Z,1714078236.282 [CBIT](ERROR): Data Fault in component: NAL9602 2024-04-25T20:50:36.283Z,1714078236.283 [CBIT](CRITICAL): Data Fault in component: NAL9602 2024-04-25T20:50:36.651Z,1714078236.651 [NAL9602](INFO): Powering down 2024-04-25T20:50:36.688Z,1714078236.688 [CBIT](INFO): Critical error at 20240425T205036 2024-04-25T20:52:14.991Z,1714078334.991 [CommandExec](IMPORTANT): got command quit 2024-04-25T20:52:15.994Z,1714078335.994 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2024-04-25T20:52:15.994Z,1714078335.994 [CommandExec](INFO): Uninitializing the command executive. 2024-04-25T20:52:15.994Z,1714078335.994 [CommandExec](INFO): Uninitializing the command scheduler. 2024-04-25T20:52:15.994Z,1714078335.994 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-04-25T20:52:16.018Z,1714078336.018 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2024-04-25T20:52:16.018Z,1714078336.018 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2024-04-25T20:52:16.018Z,1714078336.018 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-04-25T20:52:16.019Z,1714078336.019 [NavChartDb](INFO): Join timeout helper Thread ID is 727 2024-04-25T20:52:16.242Z,1714078336.242 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2024-04-25T20:52:16.242Z,1714078336.242 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-04-25T20:52:16.258Z,1714078336.258 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2024-04-25T20:52:16.258Z,1714078336.258 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-04-25T20:52:16.258Z,1714078336.258 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 728 2024-04-25T20:52:16.502Z,1714078336.502 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2024-04-25T20:52:16.502Z,1714078336.502 [WetLabsBB2FL](INFO): Powering down 2024-04-25T20:52:16.503Z,1714078336.503 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-04-25T20:52:16.506Z,1714078336.506 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2024-04-25T20:52:16.506Z,1714078336.506 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-04-25T20:52:16.506Z,1714078336.506 [CTD_Seabird](INFO): Join timeout helper Thread ID is 729 2024-04-25T20:52:16.814Z,1714078336.814 [CTD_Seabird](INFO): Powering down 2024-04-25T20:52:16.838Z,1714078336.838 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2024-04-25T20:52:16.838Z,1714078336.838 [CTD_Seabird](INFO): Powering down 2024-04-25T20:52:16.850Z,1714078336.850 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-04-25T20:52:16.858Z,1714078336.858 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler 2024-04-25T20:52:16.858Z,1714078336.858 [DAT ThreadHandler](INFO): Thread cancelled. 2024-04-25T20:52:16.858Z,1714078336.858 [DAT](INFO): Join timeout helper Thread ID is 730 2024-04-25T20:52:16.978Z,1714078336.978 [DAT](INFO): Powering down 2024-04-25T20:52:17.055Z,1714078337.055 [DAT ThreadHandler](INFO): Uninitializing protected caller thread. 2024-04-25T20:52:17.055Z,1714078337.055 [DAT](INFO): Powering down 2024-04-25T20:52:17.056Z,1714078337.056 [DAT ThreadHandler](INFO): Thread cancelled. 2024-04-25T20:52:17.058Z,1714078337.058 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2024-04-25T20:52:17.058Z,1714078337.058 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-04-25T20:52:17.058Z,1714078337.058 [Radio_Surface](INFO): Join timeout helper Thread ID is 731 2024-04-25T20:52:17.070Z,1714078337.070 [Radio_Surface](INFO): Powering down 2024-04-25T20:52:17.071Z,1714078337.071 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2024-04-25T20:52:17.071Z,1714078337.071 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-04-25T20:52:17.079Z,1714078337.079 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2024-04-25T20:52:17.079Z,1714078337.079 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-04-25T20:52:17.079Z,1714078337.079 [Onboard](INFO): Join timeout helper Thread ID is 732 2024-04-25T20:52:20.562Z,1714078340.562 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2024-04-25T20:52:20.562Z,1714078340.562 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-04-25T20:52:20.563Z,1714078340.563 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2024-04-25T20:52:20.564Z,1714078340.564 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-04-25T20:52:20.564Z,1714078340.564 [DataOverHttps](INFO): Join timeout helper Thread ID is 733 2024-04-25T20:52:21.226Z,1714078341.226 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2024-04-25T20:52:21.229Z,1714078341.229 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-04-25T20:52:21.250Z,1714078341.250 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2024-04-25T20:52:21.251Z,1714078341.251 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-04-25T20:52:21.251Z,1714078341.251 [BackseatComponent](INFO): Join timeout helper Thread ID is 734 2024-04-25T20:52:21.334Z,1714078341.334 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2024-04-25T20:52:21.334Z,1714078341.334 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-04-25T20:52:21.336Z,1714078341.336 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2024-04-25T20:52:21.336Z,1714078341.336 [logger ThreadHandler](INFO): Thread cancelled. 2024-04-25T20:52:21.336Z,1714078341.336 [logger](INFO): Join timeout helper Thread ID is 735 2024-04-25T20:52:21.343Z,1714078341.343 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2024-04-25T20:52:21.343Z,1714078341.343 [logger ThreadHandler](INFO): Thread cancelled. 2024-04-25T20:52:21.344Z,1714078341.344 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2024-04-25T20:52:21.344Z,1714078341.344 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-04-25T20:52:21.345Z,1714078341.345 [CommandLine](INFO): Join timeout helper Thread ID is 736 2024-04-25T20:52:21.394Z,1714078341.394 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2024-04-25T20:52:21.394Z,1714078341.394 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-04-25T20:52:21.402Z,1714078341.402 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2024-04-25T20:52:21.402Z,1714078341.402 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-04-25T20:52:21.403Z,1714078341.403 [CommandExec](INFO): Join timeout helper Thread ID is 737 2024-04-25T20:52:21.404Z,1714078341.404 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2024-04-25T20:52:21.404Z,1714078341.404 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-04-25T20:52:21.405Z,1714078341.405 [controlThread](INFO): Join timeout helper Thread ID is 738 2024-04-25T20:52:21.670Z,1714078341.670 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2024-04-25T20:52:21.670Z,1714078341.670 [controlThread](DEBUG): Uninitializing ControlThread 2024-04-25T20:52:21.671Z,1714078341.671 [AHRS_M2](INFO): Powering down 2024-04-25T20:52:21.743Z,1714078341.743 [MultiRay](INFO): Powering down. 2024-04-25T20:52:21.744Z,1714078341.744 [NAL9602](INFO): Powering down 2024-04-25T20:52:21.745Z,1714078341.745 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2024-04-25T20:52:21.746Z,1714078341.746 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2024-04-25T20:52:21.747Z,1714078341.747 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2024-04-25T20:52:21.747Z,1714078341.747 [MissionManager](INFO): Uninitializing Mission Default 2024-04-25T20:52:21.747Z,1714078341.747 [Default] Stopped 2024-04-25T20:52:21.748Z,1714078341.748 [Default](DEBUG): Aggregate::uninitialize Default 2024-04-25T20:52:21.748Z,1714078341.748 [Default:B.GoToSurface] Stopped 2024-04-25T20:52:21.748Z,1714078341.748 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2024-04-25T20:52:21.748Z,1714078341.748 [Default:CheckIn] Stopped 2024-04-25T20:52:21.748Z,1714078341.748 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-04-25T20:52:21.748Z,1714078341.748 [Default:CheckIn:Read_GPS] Stopped 2024-04-25T20:52:21.751Z,1714078341.751 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2024-04-25T20:52:21.751Z,1714078341.751 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2024-04-25T20:52:21.751Z,1714078341.751 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2024-04-25T20:52:21.752Z,1714078341.752 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2024-04-25T20:52:21.752Z,1714078341.752 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2024-04-25T20:52:21.752Z,1714078341.752 [BuoyancyServo](INFO): Powering down 2024-04-25T20:52:21.766Z,1714078341.766 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2024-04-25T20:52:21.766Z,1714078341.766 [ElevatorServo](INFO): Powering down 2024-04-25T20:52:21.767Z,1714078341.767 [MassServo](DEBUG): Uninitialize Mass Servo. 2024-04-25T20:52:21.767Z,1714078341.767 [MassServo](INFO): Powering down 2024-04-25T20:52:21.768Z,1714078341.768 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2024-04-25T20:52:21.768Z,1714078341.768 [RudderServo](INFO): Powering down 2024-04-25T20:52:21.769Z,1714078341.769 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2024-04-25T20:52:21.769Z,1714078341.769 [ThrusterHE](INFO): Powering down 2024-04-25T20:52:21.770Z,1714078341.770 [SBIT](DEBUG): Uninitialize SBIT Component. 2024-04-25T20:52:21.770Z,1714078341.770 [IBIT](DEBUG): Uninitialize IBIT Component. 2024-04-25T20:52:21.770Z,1714078341.770 [CBIT](DEBUG): Uninitialize CBIT Component. 2024-04-25T20:52:21.770Z,1714078341.770 [CBIT](DEBUG): Powering off loads. 2024-04-25T20:52:21.782Z,1714078341.782 [CBIT](DEBUG): Disabling WDT. 2024-04-25T20:52:21.794Z,1714078341.794 [CBIT](DEBUG): Opening all GF detection circuits. 2024-04-25T20:52:21.795Z,1714078341.795 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-04-25T20:52:21.815Z,1714078341.815 [DAT ThreadHandler](INFO): Thread cancelled. 2024-04-25T20:52:21.820Z,1714078341.820 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-04-25T20:52:21.823Z,1714078341.823 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-04-25T20:52:21.829Z,1714078341.829 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-04-25T20:52:21.872Z,1714078341.872 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-04-25T20:52:21.920Z,1714078341.920 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-04-25T20:52:21.924Z,1714078341.924 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-04-25T20:52:21.976Z,1714078341.976 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-04-25T20:52:22.024Z,1714078342.024 [logger ThreadHandler](INFO): Thread cancelled.