2023-03-31T21:36:34.966Z,1680298594.966 [Supervisor](DEBUG): Initializing supervisor. 2023-03-31T21:36:34.971Z,1680298594.971 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2023-03-31T21:36:34.971Z,1680298594.971 [SyncHandler](INFO): Protected caller Thread ID is 3338 2023-03-31T21:36:34.972Z,1680298594.972 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2023-03-31T21:36:34.973Z,1680298594.973 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2023-03-31T21:36:34.973Z,1680298594.973 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 3339 2023-03-31T21:36:34.977Z,1680298594.977 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2023-03-31T21:36:34.994Z,1680298594.994 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2023-03-31T21:36:34.995Z,1680298594.995 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2023-03-31T21:36:34.996Z,1680298594.996 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 3340 2023-03-31T21:36:34.000Z,1680298595.000 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2023-03-31T21:36:35.001Z,1680298595.001 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2023-03-31T21:36:35.001Z,1680298595.001 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 3341 2023-03-31T21:36:35.003Z,1680298595.003 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2023-03-31T21:36:35.004Z,1680298595.004 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2023-03-31T21:36:35.005Z,1680298595.005 [logger ThreadHandler](INFO): Protected caller Thread ID is 3342 2023-03-31T21:36:35.008Z,1680298595.008 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2023-03-31T21:36:35.009Z,1680298595.009 [Supervisor](INFO): Looking for Config files in directory: Config/ 2023-03-31T21:36:35.010Z,1680298595.010 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2023-03-31T21:36:35.215Z,1680298595.215 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2023-03-31T21:36:35.216Z,1680298595.216 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2023-03-31T21:36:35.320Z,1680298595.320 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2023-03-31T21:36:35.321Z,1680298595.321 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2023-03-31T21:36:35.413Z,1680298595.413 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2023-03-31T21:36:35.414Z,1680298595.414 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2023-03-31T21:36:35.852Z,1680298595.852 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2023-03-31T21:36:35.853Z,1680298595.853 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2023-03-31T21:36:36.184Z,1680298596.184 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2023-03-31T21:36:36.185Z,1680298596.185 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2023-03-31T21:36:36.503Z,1680298596.503 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2023-03-31T21:36:36.503Z,1680298596.503 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2023-03-31T21:36:36.679Z,1680298596.679 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2023-03-31T21:36:36.680Z,1680298596.680 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2023-03-31T21:36:36.758Z,1680298596.758 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2023-03-31T21:36:36.837Z,1680298596.837 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2023-03-31T21:36:37.214Z,1680298597.214 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2023-03-31T21:36:37.215Z,1680298597.215 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2023-03-31T21:36:37.487Z,1680298597.487 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2023-03-31T21:36:37.488Z,1680298597.488 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2023-03-31T21:36:37.968Z,1680298597.968 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2023-03-31T21:36:37.969Z,1680298597.969 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2023-03-31T21:36:38.175Z,1680298598.175 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2023-03-31T21:36:38.175Z,1680298598.175 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2023-03-31T21:36:38.407Z,1680298598.407 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2023-03-31T21:36:38.407Z,1680298598.407 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2023-03-31T21:36:38.542Z,1680298598.542 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2023-03-31T21:36:38.542Z,1680298598.542 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2023-03-31T21:36:39.359Z,1680298599.359 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2023-03-31T21:36:39.361Z,1680298599.361 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-galene/ 2023-03-31T21:36:39.361Z,1680298599.361 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/secure.cfg 2023-03-31T21:36:39.604Z,1680298599.604 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/vehicle.cfg 2023-03-31T21:36:39.990Z,1680298599.990 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Battery.cfg 2023-03-31T21:36:40.275Z,1680298600.275 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2023-03-31T21:36:40.276Z,1680298600.276 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Science.cfg 2023-03-31T21:36:40.394Z,1680298600.394 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Control.cfg 2023-03-31T21:36:40.545Z,1680298600.545 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/logger.cfg 2023-03-31T21:36:40.636Z,1680298600.636 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Servo.cfg 2023-03-31T21:36:40.741Z,1680298600.741 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Navigation.cfg 2023-03-31T21:36:40.833Z,1680298600.833 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Simulator.cfg 2023-03-31T21:36:40.917Z,1680298600.917 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/BIT.cfg 2023-03-31T21:36:41.014Z,1680298601.014 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Sensor.cfg 2023-03-31T21:36:41.167Z,1680298601.167 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-galene/root/ 2023-03-31T21:36:41.168Z,1680298601.168 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg 2023-03-31T21:36:41.177Z,1680298601.177 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2023-03-31T21:36:41.227Z,1680298601.227 [DepthRateCalculator] Loaded 2023-03-31T21:36:41.227Z,1680298601.227 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2023-03-31T21:36:41.233Z,1680298601.233 [PitchRateCalculator] Loaded 2023-03-31T21:36:41.233Z,1680298601.233 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2023-03-31T21:36:41.243Z,1680298601.243 [SpeedCalculator] Loaded 2023-03-31T21:36:41.243Z,1680298601.243 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2023-03-31T21:36:41.248Z,1680298601.248 [YawRateCalculator] Loaded 2023-03-31T21:36:41.248Z,1680298601.248 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2023-03-31T21:36:41.269Z,1680298601.269 [ElevatorOffsetCalculator] Loaded 2023-03-31T21:36:41.269Z,1680298601.269 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2023-03-31T21:36:41.270Z,1680298601.270 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2023-03-31T21:36:41.270Z,1680298601.270 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2023-03-31T21:36:41.296Z,1680298601.296 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2023-03-31T21:36:41.297Z,1680298601.297 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2023-03-31T21:36:41.307Z,1680298601.307 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2023-03-31T21:36:41.308Z,1680298601.308 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2023-03-31T21:36:41.745Z,1680298601.745 [AHRS_M2] Loaded 2023-03-31T21:36:41.746Z,1680298601.746 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2023-03-31T21:36:41.780Z,1680298601.780 [BackseatComponent] Loaded 2023-03-31T21:36:41.780Z,1680298601.780 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2023-03-31T21:36:41.781Z,1680298601.781 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 408474E0 2023-03-31T21:36:41.782Z,1680298601.782 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 3424 2023-03-31T21:36:41.784Z,1680298601.784 [LcmUniversalReporter] Loaded 2023-03-31T21:36:41.785Z,1680298601.785 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread. 2023-03-31T21:36:42.573Z,1680298602.573 [BPC1] Loaded 2023-03-31T21:36:42.573Z,1680298602.573 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2023-03-31T21:36:42.644Z,1680298602.644 [DataOverHttps] Loaded 2023-03-31T21:36:42.644Z,1680298602.644 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2023-03-31T21:36:42.645Z,1680298602.645 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 408774E0 2023-03-31T21:36:42.645Z,1680298602.645 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 3425 2023-03-31T21:36:42.665Z,1680298602.665 [Depth_Keller] Loaded 2023-03-31T21:36:42.666Z,1680298602.666 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2023-03-31T21:36:42.670Z,1680298602.670 [DropWeight] Loaded 2023-03-31T21:36:42.671Z,1680298602.671 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2023-03-31T21:36:42.689Z,1680298602.689 [MultiRay] Loaded 2023-03-31T21:36:42.690Z,1680298602.690 [ComponentRegistry](DEBUG): SyncComponent "MultiRay" handled in the control thread. 2023-03-31T21:36:42.750Z,1680298602.750 [NAL9602] Loaded 2023-03-31T21:36:42.750Z,1680298602.750 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2023-03-31T21:36:42.779Z,1680298602.779 [Onboard] Loaded 2023-03-31T21:36:42.779Z,1680298602.779 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2023-03-31T21:36:42.781Z,1680298602.781 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 408A74E0 2023-03-31T21:36:42.781Z,1680298602.781 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 3426 2023-03-31T21:36:42.787Z,1680298602.787 [PowerOnly](INFO): Adding load control power supply at /dev/loadC3 2023-03-31T21:36:42.797Z,1680298602.797 [PowerOnly] Loaded 2023-03-31T21:36:42.798Z,1680298602.798 [ComponentRegistry](DEBUG): SyncComponent "PowerOnly" handled in the control thread. 2023-03-31T21:36:42.809Z,1680298602.809 [Power24vConverter] Loaded 2023-03-31T21:36:42.809Z,1680298602.809 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2023-03-31T21:36:42.824Z,1680298602.824 [Radio_Surface] Loaded 2023-03-31T21:36:42.824Z,1680298602.824 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2023-03-31T21:36:42.825Z,1680298602.825 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 408D74E0 2023-03-31T21:36:42.825Z,1680298602.825 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 3427 2023-03-31T21:36:42.848Z,1680298602.848 [Waterlinked] Loaded 2023-03-31T21:36:42.848Z,1680298602.848 [ComponentRegistry](DEBUG): SyncComponent "Waterlinked" handled in the control thread. 2023-03-31T21:36:42.848Z,1680298602.848 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2023-03-31T21:36:42.849Z,1680298602.849 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2023-03-31T21:36:42.957Z,1680298602.957 [DeadReckonUsingMultipleVelocitySources] Loaded 2023-03-31T21:36:42.957Z,1680298602.957 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2023-03-31T21:36:42.999Z,1680298602.999 [DeadReckonUsingSpeedCalculator] Loaded 2023-03-31T21:36:42.999Z,1680298602.999 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread. 2023-03-31T21:36:43.012Z,1680298603.012 [NavChart] Loaded 2023-03-31T21:36:43.013Z,1680298603.013 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2023-03-31T21:36:43.018Z,1680298603.018 [UniversalFixResidualReporter] Loaded 2023-03-31T21:36:43.018Z,1680298603.018 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2023-03-31T21:36:43.019Z,1680298603.019 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2023-03-31T21:36:43.019Z,1680298603.019 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2023-03-31T21:36:43.158Z,1680298603.158 [SBIT](DEBUG): Construct Startup Built In Test. 2023-03-31T21:36:43.172Z,1680298603.172 [SBIT] Loaded 2023-03-31T21:36:43.173Z,1680298603.173 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2023-03-31T21:36:43.175Z,1680298603.175 [IBIT](DEBUG): Construct Initiated Built In Test. 2023-03-31T21:36:43.188Z,1680298603.188 [IBIT] Loaded 2023-03-31T21:36:43.188Z,1680298603.188 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2023-03-31T21:36:43.194Z,1680298603.194 [CBIT](DEBUG): Construct Continuous Built In Test. 2023-03-31T21:36:43.294Z,1680298603.294 [CBIT] Loaded 2023-03-31T21:36:43.294Z,1680298603.294 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2023-03-31T21:36:43.295Z,1680298603.295 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2023-03-31T21:36:43.295Z,1680298603.295 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2023-03-31T21:36:43.463Z,1680298603.463 [CTD_Seabird] Loaded 2023-03-31T21:36:43.463Z,1680298603.463 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2023-03-31T21:36:43.464Z,1680298603.464 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 409DB4E0 2023-03-31T21:36:43.465Z,1680298603.465 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 3428 2023-03-31T21:36:43.484Z,1680298603.484 [PAR_Licor] Loaded 2023-03-31T21:36:43.485Z,1680298603.485 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2023-03-31T21:36:43.515Z,1680298603.515 [WetLabsBB2FL] Loaded 2023-03-31T21:36:43.516Z,1680298603.516 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2023-03-31T21:36:43.517Z,1680298603.517 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40A0B4E0 2023-03-31T21:36:43.517Z,1680298603.517 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 3429 2023-03-31T21:36:43.518Z,1680298603.518 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2023-03-31T21:36:43.518Z,1680298603.518 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2023-03-31T21:36:43.653Z,1680298603.653 [BuoyancyServo] Loaded 2023-03-31T21:36:43.653Z,1680298603.653 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2023-03-31T21:36:43.674Z,1680298603.674 [ElevatorServo] Loaded 2023-03-31T21:36:43.675Z,1680298603.675 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2023-03-31T21:36:43.695Z,1680298603.695 [MassServo] Loaded 2023-03-31T21:36:43.695Z,1680298603.695 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2023-03-31T21:36:43.716Z,1680298603.716 [RudderServo] Loaded 2023-03-31T21:36:43.717Z,1680298603.717 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2023-03-31T21:36:43.733Z,1680298603.733 [ThrusterHE] Loaded 2023-03-31T21:36:43.733Z,1680298603.733 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread. 2023-03-31T21:36:43.733Z,1680298603.733 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2023-03-31T21:36:43.734Z,1680298603.734 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2023-03-31T21:36:43.785Z,1680298603.785 [VerticalControl](DEBUG): Construct VerticalControl. 2023-03-31T21:36:43.835Z,1680298603.835 [VerticalControl] Loaded 2023-03-31T21:36:43.835Z,1680298603.835 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2023-03-31T21:36:43.838Z,1680298603.838 [HorizontalControl](DEBUG): Construct HorizontalControl. 2023-03-31T21:36:43.875Z,1680298603.875 [HorizontalControl] Loaded 2023-03-31T21:36:43.875Z,1680298603.875 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2023-03-31T21:36:43.877Z,1680298603.877 [SpeedControl](DEBUG): Construct SpeedControl. 2023-03-31T21:36:43.879Z,1680298603.879 [SpeedControl] Loaded 2023-03-31T21:36:43.879Z,1680298603.879 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2023-03-31T21:36:43.882Z,1680298603.882 [LoopControl](DEBUG): Construct LoopControl. 2023-03-31T21:36:43.883Z,1680298603.883 [LoopControl] Loaded 2023-03-31T21:36:43.883Z,1680298603.883 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2023-03-31T21:36:43.883Z,1680298603.883 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2023-03-31T21:36:43.884Z,1680298603.884 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2023-03-31T21:36:43.981Z,1680298603.981 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2023-03-31T21:36:43.982Z,1680298603.982 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2023-03-31T21:36:44.134Z,1680298604.134 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2023-03-31T21:36:44.134Z,1680298604.134 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2023-03-31T21:36:44.438Z,1680298604.438 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2023-03-31T21:36:44.439Z,1680298604.439 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2023-03-31T21:36:44.770Z,1680298604.770 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2023-03-31T21:36:44.801Z,1680298604.801 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2023-03-31T21:36:44.803Z,1680298604.803 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2023-03-31T21:36:44.870Z,1680298604.870 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2023-03-31T21:36:44.871Z,1680298604.871 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40BAE4E0 2023-03-31T21:36:44.871Z,1680298604.871 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 3430 2023-03-31T21:36:44.875Z,1680298604.875 [Supervisor](INFO): Main Thread ID is 1756 2023-03-31T21:36:44.876Z,1680298604.876 [Supervisor](DEBUG): Running supervisor. 2023-03-31T21:36:44.886Z,1680298604.886 [CommandExec ThreadHandler](INFO): Handler Thread ID is 3431 2023-03-31T21:36:44.887Z,1680298604.887 [CommandExec](INFO): Initializing the command executive. 2023-03-31T21:36:44.888Z,1680298604.888 [CommandLine ThreadHandler](INFO): Handler Thread ID is 3432 2023-03-31T21:36:44.891Z,1680298604.891 [controlThread ThreadHandler](INFO): Handler Thread ID is 3433 2023-03-31T21:36:44.891Z,1680298604.891 [controlThread](DEBUG): Initializing ControlThread 2023-03-31T21:36:44.892Z,1680298604.892 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2023-03-31T21:36:44.893Z,1680298604.893 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2023-03-31T21:36:44.893Z,1680298604.893 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2023-03-31T21:36:44.893Z,1680298604.893 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2023-03-31T21:36:44.894Z,1680298604.894 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2023-03-31T21:36:44.899Z,1680298604.899 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2023-03-31T21:36:44.900Z,1680298604.900 [NavChart](DEBUG): Initialize NavChart Navigation. 2023-03-31T21:36:44.900Z,1680298604.900 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2023-03-31T21:36:44.901Z,1680298604.901 [SBIT](INFO): Initialize SBIT Component. 2023-03-31T21:36:44.901Z,1680298604.901 [SBIT](IMPORTANT): git: 2023-03-31 2023-03-31T21:36:44.901Z,1680298604.901 [SBIT](INFO): git hash: cfd8cc3d23ebacdd66b2fa8c1315bb22f1803aa4 2023-03-31T21:36:44.902Z,1680298604.902 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2023-03-31T21:36:44.903Z,1680298604.903 [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 2023-03-31T21:36:44.904Z,1680298604.904 [SBIT](INFO): Beginning SBIT in 91.000000 seconds. 2023-03-31T21:36:44.905Z,1680298604.905 [IBIT](INFO): Initialize IBIT Component. 2023-03-31T21:36:44.905Z,1680298604.905 [CBIT](DEBUG): Initialize CBIT Component. 2023-03-31T21:36:44.906Z,1680298604.906 [logger ThreadHandler](INFO): Handler Thread ID is 3434 2023-03-31T21:36:44.916Z,1680298604.916 [CBIT](DEBUG): Initialized mux pins. 2023-03-31T21:36:44.916Z,1680298604.916 [CBIT](DEBUG): Initializing the watchdog timer. 2023-03-31T21:36:44.924Z,1680298604.924 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 3435 2023-03-31T21:36:44.936Z,1680298604.936 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 3436 2023-03-31T21:36:44.937Z,1680298604.937 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2023-03-31T21:36:44.940Z,1680298604.940 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2023-03-31T21:36:44.941Z,1680298604.941 [CBIT](DEBUG): Initializing heartbeat. 2023-03-31T21:36:44.945Z,1680298604.945 [Onboard ThreadHandler](INFO): Handler Thread ID is 3437 2023-03-31T21:36:44.974Z,1680298604.974 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 3438 2023-03-31T21:36:44.976Z,1680298604.976 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 3439 2023-03-31T21:36:44.977Z,1680298604.977 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2023-03-31T21:36:44.979Z,1680298604.979 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 3441 2023-03-31T21:36:44.981Z,1680298604.981 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 3442 2023-03-31T21:36:44.983Z,1680298604.983 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2023-03-31T21:36:44.984Z,1680298604.984 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2023-03-31T21:36:44.984Z,1680298604.984 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2023-03-31T21:36:44.984Z,1680298604.984 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2023-03-31T21:36:44.984Z,1680298604.984 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2023-03-31T21:36:44.985Z,1680298604.985 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2023-03-31T21:36:44.985Z,1680298604.985 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2023-03-31T21:36:44.985Z,1680298604.985 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2023-03-31T21:36:45.008Z,1680298605.008 [WetLabsBB2FL](INFO): Powering up 2023-03-31T21:36:45.012Z,1680298605.012 [CBIT](DEBUG): Deactivating GF circuits. 2023-03-31T21:36:45.012Z,1680298605.012 [CBIT](DEBUG): Deactivating emergency mode. 2023-03-31T21:36:45.052Z,1680298605.052 [CBIT](DEBUG): Backplane powered. 2023-03-31T21:36:45.057Z,1680298605.057 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2023-03-31T21:36:45.059Z,1680298605.059 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2023-03-31T21:36:45.060Z,1680298605.060 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2023-03-31T21:36:45.061Z,1680298605.061 [LoopControl](DEBUG): Initialize LoopControlComponent. 2023-03-31T21:36:45.062Z,1680298605.062 [MissionManager](INFO): Loading Mission from file: Missions/Startup.xml 2023-03-31T21:36:45.082Z,1680298605.082 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2023-03-31T21:36:45.106Z,1680298605.106 [MissionManager](DEBUG): 2023-03-31T21:36:45.107Z,1680298605.107 [MissionManager](INFO): Loading Mission from file: Missions/Default.xml 2023-03-31T21:36:45.170Z,1680298605.170 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2023-03-31T21:36:45.171Z,1680298605.171 [Default:A.Wait](DEBUG): Construct Wait. 2023-03-31T21:36:45.174Z,1680298605.174 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2023-03-31T21:36:45.205Z,1680298605.205 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2023-03-31T21:36:45.220Z,1680298605.220 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2023-03-31T21:36:45.226Z,1680298605.226 [Default:E.Execute](DEBUG): Construct Execute. 2023-03-31T21:36:45.237Z,1680298605.237 [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 2023-03-31T21:36:45.242Z,1680298605.242 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,MultiRay,NAL9602,PowerOnly,Power24vConverter,Waterlinked,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, 2023-03-31T21:36:45.260Z,1680298605.260 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2023-03-31T21:36:45.322Z,1680298605.322 [MultiRay](INFO): Powering up MultiRay Lights 2023-03-31T21:36:45.357Z,1680298605.357 [Power24vConverter](INFO): Powering up. 2023-03-31T21:36:45.376Z,1680298605.376 [Radio_Surface](INFO): Powering up 2023-03-31T21:36:45.393Z,1680298605.393 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2023-03-31T21:36:45.400Z,1680298605.400 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2023-03-31T21:36:45.401Z,1680298605.401 [ElevatorServo](DEBUG): Initializing EZServoServo. 2023-03-31T21:36:45.408Z,1680298605.408 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2023-03-31T21:36:45.409Z,1680298605.409 [MassServo](DEBUG): Initializing EZServoServo. 2023-03-31T21:36:45.416Z,1680298605.416 [MassServo](DEBUG): Initializing MassServo. 2023-03-31T21:36:45.417Z,1680298605.417 [RudderServo](DEBUG): Initializing EZServoServo. 2023-03-31T21:36:45.424Z,1680298605.424 [RudderServo](DEBUG): Initializing RudderServo. 2023-03-31T21:36:45.425Z,1680298605.425 [ThrusterHE](DEBUG): Initializing EZServoServo. 2023-03-31T21:36:45.432Z,1680298605.432 [ThrusterHE](DEBUG): Initializing ThrusterHE. 2023-03-31T21:36:47.592Z,1680298607.592 [WetLabsBB2FL](INFO): Powering down 2023-03-31T21:36:51.158Z,1680298611.158 [ThrusterHE](ERROR): Zero Speed Commanded. 2023-03-31T21:36:53.015Z,1680298613.015 [CTD_Seabird](ERROR): Device message queue exceeded the allowed limit. 2023-03-31T21:37:13.139Z,1680298633.139 [NAL9602](INFO): Powering up NAL9602 2023-03-31T21:37:13.538Z,1680298633.538 [Waterlinked](FAULT): Could not initialize. 2023-03-31T21:37:13.538Z,1680298633.538 [Waterlinked] Communications Fault, FailCount= 1 2023-03-31T21:37:13.539Z,1680298633.539 [Waterlinked](ERROR): Communications Fault 2023-03-31T21:37:13.617Z,1680298633.617 [CBIT](ERROR): Communications Fault in component: Waterlinked 2023-03-31T21:37:14.004Z,1680298634.004 [Waterlinked](INFO): Powering down 2023-03-31T21:37:14.792Z,1680298634.792 [CBIT](INFO): Clearing failed state for component Waterlinked 2023-03-31T21:37:14.792Z,1680298634.792 [Waterlinked] No Fault, FailCount= 1 2023-03-31T21:37:24.042Z,1680298644.042 [NAL9602](INFO): NAL9602 initialized 2023-03-31T21:37:49.180Z,1680298669.180 [Waterlinked](INFO): Powering down 2023-03-31T21:38:16.575Z,1680298696.575 [SBIT](IMPORTANT): Beginning Startup BIT 2023-03-31T21:38:16.579Z,1680298696.579 [CBIT](IMPORTANT): Beginning ground fault scan 2023-03-31T21:38:27.533Z,1680298707.533 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): 0.003268 CHAN A1 (24V): 0.000690 CHAN A2 (12V): -0.005163 CHAN A3 (5V): -0.002845 CHAN B0 (3.3V): -0.001089 CHAN B1 (3.15aV): -0.001196 CHAN B2 (3.15bV): -0.001191 CHAN B3 (GND): -0.000395 OPEN: 0.005308 Full Scale: +/- 1 mA 2023-03-31T21:39:10.728Z,1680298750.728 [SBIT](IMPORTANT): SBIT PASSED 2023-03-31T21:39:10.729Z,1680298750.729 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2023-03-31T21:39:10.729Z,1680298750.729 [SBIT](IMPORTANT): DAT.loadAtStartup=0 bool; 2023-03-31T21:39:10.729Z,1680298750.729 [SBIT](IMPORTANT): ESPComponent.sampleTimeout=2 minute; 2023-03-31T21:39:10.730Z,1680298750.730 [SBIT](IMPORTANT): Express linearApproximation _.ayeris_disk_space 100.000000 gigabyte; 2023-03-31T21:39:10.730Z,1680298750.730 [SBIT](IMPORTANT): Express linearApproximation _.ayeris_particle_counts 300.000000 count_per_second; 2023-03-31T21:39:10.730Z,1680298750.730 [SBIT](IMPORTANT): Express linearApproximation _.ayeris_particle_shape 10.000000 count_per_second; 2023-03-31T21:39:10.730Z,1680298750.730 [SBIT](IMPORTANT): Express linearApproximation _.ayeris_particle_slope 0.200000 count_per_millimeter; 2023-03-31T21:39:10.730Z,1680298750.730 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=236.612869 cubic_centimeter; 2023-03-31T21:39:10.730Z,1680298750.730 [SBIT](IMPORTANT): VerticalControl.massDefault=17.883769 millimeter; 2023-03-31T21:39:11.115Z,1680298751.115 [MissionManager](IMPORTANT): Started mission Startup 2023-03-31T21:39:11.116Z,1680298751.116 [Startup] Running Loop=1 2023-03-31T21:39:11.116Z,1680298751.116 [Startup](DEBUG): Aggregate::initialize Startup 2023-03-31T21:39:11.116Z,1680298751.116 [Startup:A.GoToSurface] Running Loop=1 2023-03-31T21:39:11.116Z,1680298751.116 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2023-03-31T21:39:11.117Z,1680298751.117 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2023-03-31T21:39:11.117Z,1680298751.117 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2023-03-31T21:39:11.117Z,1680298751.117 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2023-03-31T21:39:11.118Z,1680298751.118 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2023-03-31T21:39:11.118Z,1680298751.118 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2023-03-31T21:39:11.119Z,1680298751.119 [Startup:StartupSatComms] Running Loop=1 2023-03-31T21:39:11.120Z,1680298751.120 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2023-03-31T21:39:11.120Z,1680298751.120 [Startup:StartupSatComms:A] Running Loop=1 2023-03-31T21:39:11.516Z,1680298751.516 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2023-03-31T21:39:11.726Z,1680298751.726 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004882 2023-03-31T21:39:45.045Z,1680298785.045 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2023-03-31T21:39:45.045Z,1680298785.045 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-03-31T21:39:45.046Z,1680298785.046 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1 2023-03-31T21:39:45.046Z,1680298785.046 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2023-03-31T21:39:45.065Z,1680298785.065 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-03-31T21:39:45.065Z,1680298785.065 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2023-03-31T21:39:45.490Z,1680298785.490 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-03-31T21:39:45.490Z,1680298785.490 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2023-03-31T21:39:45.491Z,1680298785.491 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2023-03-31T21:39:45.491Z,1680298785.491 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1 2023-03-31T21:39:45.853Z,1680298785.853 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2023-03-31T21:40:11.306Z,1680298811.306 [Startup:StartupSatComms:A](INFO): Timed out from 2023-03-31T21:39:11.1Z 2023-03-31T21:40:11.307Z,1680298811.307 [Startup:StartupSatComms:A] Stopped 2023-03-31T21:40:11.307Z,1680298811.307 [Startup:StartupSatComms:B] Running Loop=1 2023-03-31T21:40:11.711Z,1680298811.711 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2023-03-31T21:40:18.472Z,1680298818.472 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230331T204502/Courier0019.lzma 2023-03-31T21:40:19.474Z,1680298819.474 [DataOverHttps](INFO): Moved sent file to Logs/20230331T204502/Courier0019.lzma.bak 2023-03-31T21:40:19.474Z,1680298819.474 [DataOverHttps](INFO): SBD MOMSN=17885905 2023-03-31T21:40:35.020Z,1680298835.020 [DataOverHttps](INFO): Sending 150 bytes from file Logs/20230331T213442/Courier0000.lzma 2023-03-31T21:40:36.022Z,1680298836.022 [DataOverHttps](INFO): Moved sent file to Logs/20230331T213442/Courier0000.lzma.bak 2023-03-31T21:40:36.022Z,1680298836.022 [DataOverHttps](INFO): SBD MOMSN=17885907 2023-03-31T21:40:51.748Z,1680298851.748 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20230331T213634/Courier0000.lzma 2023-03-31T21:40:52.750Z,1680298852.750 [DataOverHttps](INFO): Moved sent file to Logs/20230331T213634/Courier0000.lzma.bak 2023-03-31T21:40:52.750Z,1680298852.750 [DataOverHttps](INFO): SBD MOMSN=17885914 2023-03-31T21:41:08.273Z,1680298868.273 [DataOverHttps](INFO): Sending 928 bytes from file Logs/20230331T204502/Express0020.lzma 2023-03-31T21:41:09.274Z,1680298869.274 [DataOverHttps](INFO): Moved sent file to Logs/20230331T204502/Express0020.lzma.bak 2023-03-31T21:41:09.274Z,1680298869.274 [DataOverHttps](INFO): SBD MOMSN=17885917 2023-03-31T21:41:11.503Z,1680298871.503 [Startup:StartupSatComms:B](INFO): Timed out from 2023-03-31T21:40:11.3Z 2023-03-31T21:41:11.503Z,1680298871.503 [Startup:StartupSatComms:B] Stopped 2023-03-31T21:41:11.503Z,1680298871.503 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2023-03-31T21:41:11.503Z,1680298871.503 [Startup:StartupSatComms] Stopped 2023-03-31T21:41:11.503Z,1680298871.503 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2023-03-31T21:41:11.504Z,1680298871.504 [Startup](INFO): Completed Startup 2023-03-31T21:41:11.504Z,1680298871.504 [MissionManager](INFO): Startup is completed. 2023-03-31T21:41:11.504Z,1680298871.504 [MissionManager](INFO): Uninitializing Mission Startup 2023-03-31T21:41:11.504Z,1680298871.504 [Startup] Stopped 2023-03-31T21:41:11.504Z,1680298871.504 [Startup](DEBUG): Aggregate::uninitialize Startup 2023-03-31T21:41:11.504Z,1680298871.504 [Startup:A.GoToSurface] Stopped 2023-03-31T21:41:11.504Z,1680298871.504 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2023-03-31T21:41:11.923Z,1680298871.923 [MissionManager](IMPORTANT): Started mission Default 2023-03-31T21:41:11.923Z,1680298871.923 [Default] Running Loop=1 2023-03-31T21:41:11.923Z,1680298871.923 [Default](DEBUG): Aggregate::initialize Default 2023-03-31T21:41:11.923Z,1680298871.923 [Default:B.GoToSurface] Running Loop=1 2023-03-31T21:41:11.923Z,1680298871.923 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2023-03-31T21:41:11.923Z,1680298871.923 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2023-03-31T21:41:11.924Z,1680298871.924 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2023-03-31T21:41:11.924Z,1680298871.924 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2023-03-31T21:41:11.925Z,1680298871.925 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2023-03-31T21:41:11.925Z,1680298871.925 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2023-03-31T21:41:11.925Z,1680298871.925 [Default:A.Wait] Running Loop=1 2023-03-31T21:41:11.925Z,1680298871.925 [Default:A.Wait](DEBUG): Initialize Wait Component. 2023-03-31T21:41:24.939Z,1680298884.939 [Default:A.Wait](INFO): Done Waiting. 2023-03-31T21:41:24.939Z,1680298884.939 [Default:A.Wait] Stopped 2023-03-31T21:41:24.940Z,1680298884.940 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2023-03-31T21:41:25.336Z,1680298885.336 [Default:CheckIn] Running Loop=1 2023-03-31T21:41:25.336Z,1680298885.336 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-03-31T21:41:25.337Z,1680298885.337 [Default:CheckIn:Read_GPS] Running Loop=1 2023-03-31T21:41:25.711Z,1680298885.711 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2023-03-31T21:41:26.525Z,1680298886.525 [DataOverHttps](INFO): Sending 708 bytes from file Logs/20230331T213442/Express0001.lzma 2023-03-31T21:41:27.526Z,1680298887.526 [DataOverHttps](INFO): Moved sent file to Logs/20230331T213442/Express0001.lzma.bak 2023-03-31T21:41:27.526Z,1680298887.526 [DataOverHttps](INFO): SBD MOMSN=17885974 2023-03-31T21:42:27.498Z,1680298947.498 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2023-03-31T21:42:46.100Z,1680298966.100 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2023-03-31T21:42:46.101Z,1680298966.101 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-03-31T21:42:46.102Z,1680298966.102 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 2 2023-03-31T21:42:46.102Z,1680298966.102 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2023-03-31T21:42:46.113Z,1680298966.113 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-03-31T21:42:46.113Z,1680298966.113 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2023-03-31T21:42:46.521Z,1680298966.521 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-03-31T21:42:46.522Z,1680298966.522 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2023-03-31T21:42:46.522Z,1680298966.522 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2023-03-31T21:42:46.522Z,1680298966.522 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 2 2023-03-31T21:42:46.897Z,1680298966.897 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2023-03-31T21:44:47.769Z,1680299087.769 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6. 2023-03-31T21:44:47.772Z,1680299087.772 [BPC1](INFO): Received data from all battery sticks. 2023-03-31T21:45:47.081Z,1680299147.081 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3 2023-03-31T21:45:47.081Z,1680299147.081 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-03-31T21:45:47.082Z,1680299147.082 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 3 2023-03-31T21:45:47.082Z,1680299147.082 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2023-03-31T21:45:47.133Z,1680299147.133 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-03-31T21:45:47.133Z,1680299147.133 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2023-03-31T21:45:47.494Z,1680299147.494 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-03-31T21:45:47.494Z,1680299147.494 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3 2023-03-31T21:45:47.494Z,1680299147.494 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2023-03-31T21:45:47.495Z,1680299147.495 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 3 2023-03-31T21:45:47.897Z,1680299147.897 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2023-03-31T21:46:25.476Z,1680299185.476 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-03-31T21:41:25.3Z 2023-03-31T21:46:25.476Z,1680299185.476 [Default:CheckIn:Read_GPS] Stopped 2023-03-31T21:46:25.476Z,1680299185.476 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-03-31T21:46:25.872Z,1680299185.872 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications 2023-03-31T21:46:32.252Z,1680299192.252 [DataOverHttps](INFO): Sending 168 bytes from file Logs/20230331T213634/Courier0004.lzma 2023-03-31T21:46:33.254Z,1680299193.254 [DataOverHttps](INFO): Moved sent file to Logs/20230331T213634/Courier0004.lzma.bak 2023-03-31T21:46:33.254Z,1680299193.254 [DataOverHttps](INFO): SBD MOMSN=17886355 2023-03-31T21:46:48.649Z,1680299208.649 [DataOverHttps](INFO): Sending 857 bytes from file Logs/20230331T213634/Express0001.lzma 2023-03-31T21:46:49.650Z,1680299209.650 [DataOverHttps](INFO): Moved sent file to Logs/20230331T213634/Express0001.lzma.bak 2023-03-31T21:46:49.650Z,1680299209.650 [DataOverHttps](INFO): SBD MOMSN=17886363 2023-03-31T21:47:05.024Z,1680299225.024 [DataOverHttps](INFO): Sending 187 bytes from file Logs/20230331T213634/Express0005.lzma 2023-03-31T21:47:06.026Z,1680299226.026 [DataOverHttps](INFO): Moved sent file to Logs/20230331T213634/Express0005.lzma.bak 2023-03-31T21:47:06.026Z,1680299226.026 [DataOverHttps](INFO): SBD MOMSN=17886400 2023-03-31T21:47:07.074Z,1680299227.074 [Default:CheckIn:Read_Iridium] Stopped 2023-03-31T21:47:07.074Z,1680299227.074 [Default:CheckIn:C.Wait] Running Loop=1 2023-03-31T21:47:07.074Z,1680299227.074 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-03-31T21:47:15.161Z,1680299235.161 [Power24vConverter](INFO): Powering down. 2023-03-31T21:47:26.462Z,1680299246.462 [NAL9602](FAULT): GPS failed to acquire within timeout. 2023-03-31T21:47:26.462Z,1680299246.462 [NAL9602] Data Fault, FailCount= 1 2023-03-31T21:47:26.462Z,1680299246.462 [NAL9602](ERROR): Data Fault 2023-03-31T21:47:26.480Z,1680299246.480 [CBIT](ERROR): Data Fault in component: NAL9602 2023-03-31T21:47:26.858Z,1680299246.858 [NAL9602](INFO): Powering down 2023-03-31T21:47:27.687Z,1680299247.687 [CBIT](INFO): Clearing failed state for component NAL9602 2023-03-31T21:47:27.687Z,1680299247.687 [NAL9602] No Fault, FailCount= 1 2023-03-31T21:47:57.162Z,1680299277.162 [NAL9602](INFO): Powering up NAL9602 2023-03-31T21:48:08.070Z,1680299288.070 [NAL9602](INFO): NAL9602 initialized 2023-03-31T21:48:48.093Z,1680299328.093 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4 2023-03-31T21:48:48.093Z,1680299328.093 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-03-31T21:48:48.094Z,1680299328.094 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 4 2023-03-31T21:48:48.094Z,1680299328.094 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2023-03-31T21:48:48.146Z,1680299328.146 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-03-31T21:48:48.146Z,1680299328.146 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2023-03-31T21:48:48.506Z,1680299328.506 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-03-31T21:48:48.506Z,1680299328.506 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4 2023-03-31T21:48:48.507Z,1680299328.507 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2023-03-31T21:48:48.507Z,1680299328.507 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 4 2023-03-31T21:48:48.893Z,1680299328.893 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2023-03-31T21:51:49.088Z,1680299509.088 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5 2023-03-31T21:51:49.088Z,1680299509.088 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-03-31T21:51:49.089Z,1680299509.089 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 5 2023-03-31T21:51:49.089Z,1680299509.089 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2023-03-31T21:51:49.100Z,1680299509.100 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-03-31T21:51:49.100Z,1680299509.100 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2023-03-31T21:51:49.514Z,1680299509.514 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-03-31T21:51:49.514Z,1680299509.514 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5 2023-03-31T21:51:49.514Z,1680299509.514 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2023-03-31T21:51:49.515Z,1680299509.515 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 5 2023-03-31T21:51:49.875Z,1680299509.875 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2023-03-31T21:52:07.650Z,1680299527.650 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-03-31T21:52:07.650Z,1680299527.650 [Default:CheckIn:C.Wait] Stopped 2023-03-31T21:52:07.650Z,1680299527.650 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-03-31T21:52:07.651Z,1680299527.651 [Default:CheckIn:D] Running Loop=1 2023-03-31T21:52:08.063Z,1680299528.063 [Default:CheckIn:D] Stopped 2023-03-31T21:52:08.063Z,1680299528.063 [Default:CheckIn:E] Running Loop=1 2023-03-31T21:52:08.470Z,1680299528.470 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 10.935664 min 2023-03-31T21:52:08.470Z,1680299528.470 [Default:CheckIn:E] Stopped 2023-03-31T21:52:08.471Z,1680299528.471 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-03-31T21:52:08.471Z,1680299528.471 [Default:CheckIn] Stopped 2023-03-31T21:52:08.471Z,1680299528.471 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-03-31T21:52:08.471Z,1680299528.471 [Default:CheckIn](INFO): Running loop #2 2023-03-31T21:52:08.471Z,1680299528.471 [Default:CheckIn] Running Loop=2 2023-03-31T21:52:08.471Z,1680299528.471 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-03-31T21:52:08.471Z,1680299528.471 [Default:CheckIn:Read_GPS] Running Loop=1 2023-03-31T21:54:50.065Z,1680299690.065 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6 2023-03-31T21:54:50.066Z,1680299690.066 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-03-31T21:54:50.067Z,1680299690.067 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 6 2023-03-31T21:54:50.067Z,1680299690.067 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2023-03-31T21:54:50.144Z,1680299690.144 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-03-31T21:54:50.144Z,1680299690.144 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2023-03-31T21:54:50.505Z,1680299690.505 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-03-31T21:54:50.506Z,1680299690.506 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6 2023-03-31T21:54:50.506Z,1680299690.506 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2023-03-31T21:54:50.506Z,1680299690.506 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 6 2023-03-31T21:54:50.897Z,1680299690.897 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2023-03-31T21:57:08.636Z,1680299828.636 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-03-31T21:52:08.5Z 2023-03-31T21:57:08.637Z,1680299828.637 [Default:CheckIn:Read_GPS] Stopped 2023-03-31T21:57:08.637Z,1680299828.637 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-03-31T21:57:13.564Z,1680299833.564 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230331T213634/Courier0007.lzma 2023-03-31T21:57:14.566Z,1680299834.566 [DataOverHttps](INFO): Moved sent file to Logs/20230331T213634/Courier0007.lzma.bak 2023-03-31T21:57:14.566Z,1680299834.566 [DataOverHttps](INFO): SBD MOMSN=17886760 2023-03-31T21:57:29.900Z,1680299849.900 [DataOverHttps](INFO): Sending 182 bytes from file Logs/20230331T213634/Express0008.lzma 2023-03-31T21:57:30.902Z,1680299850.902 [DataOverHttps](INFO): Moved sent file to Logs/20230331T213634/Express0008.lzma.bak 2023-03-31T21:57:30.902Z,1680299850.902 [DataOverHttps](INFO): SBD MOMSN=17886771 2023-03-31T21:57:32.062Z,1680299852.062 [Default:CheckIn:Read_Iridium] Stopped 2023-03-31T21:57:32.062Z,1680299852.062 [Default:CheckIn:C.Wait] Running Loop=1 2023-03-31T21:57:32.062Z,1680299852.062 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-03-31T21:57:51.048Z,1680299871.048 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7 2023-03-31T21:57:51.048Z,1680299871.048 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-03-31T21:57:51.049Z,1680299871.049 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 7 2023-03-31T21:57:51.049Z,1680299871.049 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2023-03-31T21:57:51.060Z,1680299871.060 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-03-31T21:57:51.060Z,1680299871.060 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2023-03-31T21:57:51.473Z,1680299871.473 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-03-31T21:57:51.473Z,1680299871.473 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7 2023-03-31T21:57:51.473Z,1680299871.473 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2023-03-31T21:57:51.474Z,1680299871.474 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 7 2023-03-31T21:57:51.870Z,1680299871.870 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2023-03-31T21:58:11.646Z,1680299891.646 [NAL9602](FAULT): GPS failed to acquire within timeout. 2023-03-31T21:58:11.646Z,1680299891.646 [NAL9602] Data Fault, FailCount= 2 2023-03-31T21:58:11.646Z,1680299891.646 [NAL9602](ERROR): Data Fault 2023-03-31T21:58:11.721Z,1680299891.721 [CBIT](ERROR): Data Fault in component: NAL9602 2023-03-31T21:58:12.058Z,1680299892.058 [NAL9602](INFO): Powering down 2023-03-31T21:58:12.874Z,1680299892.874 [CBIT](INFO): Clearing failed state for component NAL9602 2023-03-31T21:58:12.874Z,1680299892.874 [NAL9602] No Fault, FailCount= 2 2023-03-31T21:58:42.358Z,1680299922.358 [NAL9602](INFO): Powering up NAL9602 2023-03-31T21:58:53.258Z,1680299933.258 [NAL9602](INFO): NAL9602 initialized 2023-03-31T22:00:52.041Z,1680300052.041 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8 2023-03-31T22:00:52.041Z,1680300052.041 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-03-31T22:00:52.043Z,1680300052.043 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 8 2023-03-31T22:00:52.043Z,1680300052.043 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2023-03-31T22:00:52.098Z,1680300052.098 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-03-31T22:00:52.098Z,1680300052.098 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2023-03-31T22:00:52.451Z,1680300052.451 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-03-31T22:00:52.451Z,1680300052.451 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8 2023-03-31T22:00:52.451Z,1680300052.451 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2023-03-31T22:00:52.451Z,1680300052.451 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 8 2023-03-31T22:00:52.869Z,1680300052.869 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2023-03-31T22:02:32.652Z,1680300152.652 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-03-31T22:02:32.652Z,1680300152.652 [Default:CheckIn:C.Wait] Stopped 2023-03-31T22:02:32.652Z,1680300152.652 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-03-31T22:02:32.652Z,1680300152.652 [Default:CheckIn:D] Running Loop=1 2023-03-31T22:02:33.065Z,1680300153.065 [Default:CheckIn:D] Stopped 2023-03-31T22:02:33.065Z,1680300153.065 [Default:CheckIn:E] Running Loop=1 2023-03-31T22:02:33.456Z,1680300153.456 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 21.352370 min 2023-03-31T22:02:33.456Z,1680300153.456 [Default:CheckIn:E] Stopped 2023-03-31T22:02:33.456Z,1680300153.456 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-03-31T22:02:33.456Z,1680300153.456 [Default:CheckIn] Stopped 2023-03-31T22:02:33.457Z,1680300153.457 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-03-31T22:02:33.457Z,1680300153.457 [Default:CheckIn](INFO): Running loop #3 2023-03-31T22:02:33.457Z,1680300153.457 [Default:CheckIn] Running Loop=3 2023-03-31T22:02:33.457Z,1680300153.457 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-03-31T22:02:33.457Z,1680300153.457 [Default:CheckIn:Read_GPS] Running Loop=1 2023-03-31T22:03:53.053Z,1680300233.053 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 9 2023-03-31T22:03:53.053Z,1680300233.053 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-03-31T22:03:53.054Z,1680300233.054 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 9 2023-03-31T22:03:53.054Z,1680300233.054 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2023-03-31T22:03:53.125Z,1680300233.125 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-03-31T22:03:53.125Z,1680300233.125 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2023-03-31T22:03:53.467Z,1680300233.467 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-03-31T22:03:53.467Z,1680300233.467 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 9 2023-03-31T22:03:53.467Z,1680300233.467 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2023-03-31T22:03:53.467Z,1680300233.467 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 9 2023-03-31T22:03:53.840Z,1680300233.840 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2023-03-31T22:06:54.028Z,1680300414.028 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 10 2023-03-31T22:06:54.029Z,1680300414.029 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-03-31T22:06:54.030Z,1680300414.030 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 10 2023-03-31T22:06:54.030Z,1680300414.030 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2023-03-31T22:06:54.041Z,1680300414.041 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-03-31T22:06:54.041Z,1680300414.041 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2023-03-31T22:06:54.450Z,1680300414.450 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-03-31T22:06:54.450Z,1680300414.450 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 10 2023-03-31T22:06:54.450Z,1680300414.450 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2023-03-31T22:06:54.450Z,1680300414.450 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 10 2023-03-31T22:06:54.837Z,1680300414.837 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2023-03-31T22:07:33.646Z,1680300453.646 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-03-31T22:02:33.5Z 2023-03-31T22:07:33.647Z,1680300453.647 [Default:CheckIn:Read_GPS] Stopped 2023-03-31T22:07:33.647Z,1680300453.647 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-03-31T22:07:38.795Z,1680300458.795 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230331T213634/Courier0010.lzma 2023-03-31T22:07:39.798Z,1680300459.798 [DataOverHttps](INFO): Moved sent file to Logs/20230331T213634/Courier0010.lzma.bak 2023-03-31T22:07:39.798Z,1680300459.798 [DataOverHttps](INFO): SBD MOMSN=17887141 2023-03-31T22:07:55.152Z,1680300475.152 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20230331T213634/Express0011.lzma 2023-03-31T22:07:56.154Z,1680300476.154 [DataOverHttps](INFO): Moved sent file to Logs/20230331T213634/Express0011.lzma.bak 2023-03-31T22:07:56.154Z,1680300476.154 [DataOverHttps](INFO): SBD MOMSN=17887152 2023-03-31T22:07:57.460Z,1680300477.460 [Default:CheckIn:Read_Iridium] Stopped 2023-03-31T22:07:57.461Z,1680300477.461 [Default:CheckIn:C.Wait] Running Loop=1 2023-03-31T22:07:57.461Z,1680300477.461 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-03-31T22:08:55.624Z,1680300535.624 [NAL9602](FAULT): GPS failed to acquire within timeout. 2023-03-31T22:08:55.624Z,1680300535.624 [NAL9602] Data Fault, FailCount= 3 2023-03-31T22:08:55.625Z,1680300535.625 [NAL9602](ERROR): Data Fault 2023-03-31T22:08:55.642Z,1680300535.642 [CBIT](ERROR): Data Fault in component: NAL9602 2023-03-31T22:08:56.026Z,1680300536.026 [NAL9602](INFO): Powering down 2023-03-31T22:08:56.847Z,1680300536.847 [CBIT](INFO): Clearing failed state for component NAL9602 2023-03-31T22:08:56.847Z,1680300536.847 [NAL9602] No Fault, FailCount= 3 2023-03-31T22:09:26.338Z,1680300566.338 [NAL9602](INFO): Powering up NAL9602 2023-03-31T22:09:37.238Z,1680300577.238 [NAL9602](INFO): NAL9602 initialized 2023-03-31T22:09:55.041Z,1680300595.041 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 11 2023-03-31T22:09:55.041Z,1680300595.041 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-03-31T22:09:55.042Z,1680300595.042 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 11 2023-03-31T22:09:55.042Z,1680300595.042 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2023-03-31T22:09:55.053Z,1680300595.053 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-03-31T22:09:55.053Z,1680300595.053 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2023-03-31T22:09:55.459Z,1680300595.459 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-03-31T22:09:55.459Z,1680300595.459 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 11 2023-03-31T22:09:55.460Z,1680300595.460 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2023-03-31T22:09:55.460Z,1680300595.460 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 11 2023-03-31T22:09:55.828Z,1680300595.828 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2023-03-31T22:12:56.060Z,1680300776.060 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 12 2023-03-31T22:12:56.060Z,1680300776.060 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-03-31T22:12:56.062Z,1680300776.062 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 12 2023-03-31T22:12:56.062Z,1680300776.062 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2023-03-31T22:12:56.113Z,1680300776.113 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-03-31T22:12:56.113Z,1680300776.113 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2023-03-31T22:12:56.474Z,1680300776.474 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-03-31T22:12:56.474Z,1680300776.474 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 12 2023-03-31T22:12:56.475Z,1680300776.475 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2023-03-31T22:12:56.475Z,1680300776.475 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 12 2023-03-31T22:12:56.869Z,1680300776.869 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2023-03-31T22:12:58.110Z,1680300778.110 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-03-31T22:12:58.110Z,1680300778.110 [Default:CheckIn:C.Wait] Stopped 2023-03-31T22:12:58.110Z,1680300778.110 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-03-31T22:12:58.111Z,1680300778.111 [Default:CheckIn:D] Running Loop=1 2023-03-31T22:12:58.507Z,1680300778.507 [Default:CheckIn:D] Stopped 2023-03-31T22:12:58.507Z,1680300778.507 [Default:CheckIn:E] Running Loop=1 2023-03-31T22:12:58.895Z,1680300778.895 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 31.776400 min 2023-03-31T22:12:58.896Z,1680300778.896 [Default:CheckIn:E] Stopped 2023-03-31T22:12:58.896Z,1680300778.896 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-03-31T22:12:58.896Z,1680300778.896 [Default:CheckIn] Stopped 2023-03-31T22:12:58.896Z,1680300778.896 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-03-31T22:12:58.896Z,1680300778.896 [Default:CheckIn](INFO): Running loop #4 2023-03-31T22:12:58.896Z,1680300778.896 [Default:CheckIn] Running Loop=4 2023-03-31T22:12:58.896Z,1680300778.896 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-03-31T22:12:58.896Z,1680300778.896 [Default:CheckIn:Read_GPS] Running Loop=1 2023-03-31T22:15:57.056Z,1680300957.056 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 13 2023-03-31T22:15:57.056Z,1680300957.056 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-03-31T22:15:57.058Z,1680300957.058 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 13 2023-03-31T22:15:57.058Z,1680300957.058 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2023-03-31T22:15:57.068Z,1680300957.068 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-03-31T22:15:57.068Z,1680300957.068 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2023-03-31T22:15:57.471Z,1680300957.471 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-03-31T22:15:57.471Z,1680300957.471 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 13 2023-03-31T22:15:57.472Z,1680300957.472 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2023-03-31T22:15:57.476Z,1680300957.476 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 13 2023-03-31T22:15:57.861Z,1680300957.861 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2023-03-31T22:17:59.063Z,1680301079.063 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-03-31T22:12:58.9Z 2023-03-31T22:17:59.063Z,1680301079.063 [Default:CheckIn:Read_GPS] Stopped 2023-03-31T22:17:59.063Z,1680301079.063 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-03-31T22:18:02.790Z,1680301082.790 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230331T213634/Courier0013.lzma 2023-03-31T22:18:03.782Z,1680301083.782 [DataOverHttps](INFO): Moved sent file to Logs/20230331T213634/Courier0013.lzma.bak 2023-03-31T22:18:03.782Z,1680301083.782 [DataOverHttps](INFO): SBD MOMSN=17887530 2023-03-31T22:18:19.124Z,1680301099.124 [DataOverHttps](INFO): Sending 149 bytes from file Logs/20230331T213634/Express0014.lzma 2023-03-31T22:18:20.126Z,1680301100.126 [DataOverHttps](INFO): Moved sent file to Logs/20230331T213634/Express0014.lzma.bak 2023-03-31T22:18:20.126Z,1680301100.126 [DataOverHttps](INFO): SBD MOMSN=17887537 2023-03-31T22:18:21.282Z,1680301101.282 [Default:CheckIn:Read_Iridium] Stopped 2023-03-31T22:18:21.283Z,1680301101.283 [Default:CheckIn:C.Wait] Running Loop=1 2023-03-31T22:18:21.283Z,1680301101.283 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-03-31T22:18:58.059Z,1680301138.059 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 14 2023-03-31T22:18:58.059Z,1680301138.059 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-03-31T22:18:58.061Z,1680301138.061 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 14 2023-03-31T22:18:58.061Z,1680301138.061 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2023-03-31T22:18:58.071Z,1680301138.071 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-03-31T22:18:58.072Z,1680301138.072 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2023-03-31T22:18:58.501Z,1680301138.501 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-03-31T22:18:58.501Z,1680301138.501 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 14 2023-03-31T22:18:58.502Z,1680301138.502 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2023-03-31T22:18:58.502Z,1680301138.502 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 14 2023-03-31T22:18:58.872Z,1680301138.872 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2023-03-31T22:19:38.838Z,1680301178.838 [NAL9602](FAULT): GPS failed to acquire within timeout. 2023-03-31T22:19:38.838Z,1680301178.838 [NAL9602] Data Fault, FailCount= 4 2023-03-31T22:19:38.838Z,1680301178.838 [NAL9602](ERROR): Data Fault 2023-03-31T22:19:38.896Z,1680301178.896 [CBIT](ERROR): Data Fault in component: NAL9602 2023-03-31T22:19:39.246Z,1680301179.246 [NAL9602](INFO): Powering down 2023-03-31T22:19:40.082Z,1680301180.082 [CBIT](INFO): Clearing failed state for component NAL9602 2023-03-31T22:19:40.082Z,1680301180.082 [NAL9602] No Fault, FailCount= 4 2023-03-31T22:20:09.542Z,1680301209.542 [NAL9602](INFO): Powering up NAL9602 2023-03-31T22:20:20.454Z,1680301220.454 [NAL9602](INFO): NAL9602 initialized 2023-03-31T22:21:59.053Z,1680301319.053 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 15 2023-03-31T22:21:59.053Z,1680301319.053 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-03-31T22:21:59.054Z,1680301319.054 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 15 2023-03-31T22:21:59.054Z,1680301319.054 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2023-03-31T22:21:59.095Z,1680301319.095 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-03-31T22:21:59.095Z,1680301319.095 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2023-03-31T22:21:59.474Z,1680301319.474 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-03-31T22:21:59.474Z,1680301319.474 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 15 2023-03-31T22:21:59.475Z,1680301319.475 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2023-03-31T22:21:59.475Z,1680301319.475 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 15 2023-03-31T22:21:59.862Z,1680301319.862 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2023-03-31T22:23:21.871Z,1680301401.871 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-03-31T22:23:21.871Z,1680301401.871 [Default:CheckIn:C.Wait] Stopped 2023-03-31T22:23:21.871Z,1680301401.871 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-03-31T22:23:21.871Z,1680301401.871 [Default:CheckIn:D] Running Loop=1 2023-03-31T22:23:22.307Z,1680301402.307 [Default:CheckIn:D] Stopped 2023-03-31T22:23:22.307Z,1680301402.307 [Default:CheckIn:E] Running Loop=1 2023-03-31T22:23:22.684Z,1680301402.684 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 42.173067 min 2023-03-31T22:23:22.684Z,1680301402.684 [Default:CheckIn:E] Stopped 2023-03-31T22:23:22.684Z,1680301402.684 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-03-31T22:23:22.684Z,1680301402.684 [Default:CheckIn] Stopped 2023-03-31T22:23:22.684Z,1680301402.684 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-03-31T22:23:22.684Z,1680301402.684 [Default:CheckIn](INFO): Running loop #5 2023-03-31T22:23:22.685Z,1680301402.685 [Default:CheckIn] Running Loop=5 2023-03-31T22:23:22.685Z,1680301402.685 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-03-31T22:23:22.685Z,1680301402.685 [Default:CheckIn:Read_GPS] Running Loop=1 2023-03-31T22:24:44.668Z,1680301484.668 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-03-31T22:24:46.676Z,1680301486.676 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.239342 2023-03-31T22:25:00.028Z,1680301500.028 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 16 2023-03-31T22:25:00.029Z,1680301500.029 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-03-31T22:25:00.030Z,1680301500.030 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 16 2023-03-31T22:25:00.030Z,1680301500.030 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2023-03-31T22:25:00.040Z,1680301500.040 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-03-31T22:25:00.041Z,1680301500.041 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2023-03-31T22:25:00.449Z,1680301500.449 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-03-31T22:25:00.449Z,1680301500.449 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 16 2023-03-31T22:25:00.450Z,1680301500.450 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2023-03-31T22:25:00.450Z,1680301500.450 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 16 2023-03-31T22:25:00.836Z,1680301500.836 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2023-03-31T22:25:19.812Z,1680301519.812 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-03-31T22:25:54.956Z,1680301554.956 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-03-31T22:26:30.096Z,1680301590.096 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-03-31T22:27:05.236Z,1680301625.236 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-03-31T22:27:40.397Z,1680301660.397 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-03-31T22:28:01.028Z,1680301681.028 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 17 2023-03-31T22:28:01.028Z,1680301681.028 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-03-31T22:28:01.030Z,1680301681.030 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 17 2023-03-31T22:28:01.030Z,1680301681.030 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2023-03-31T22:28:01.040Z,1680301681.040 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-03-31T22:28:01.040Z,1680301681.040 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2023-03-31T22:28:01.434Z,1680301681.434 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-03-31T22:28:01.434Z,1680301681.434 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 17 2023-03-31T22:28:01.435Z,1680301681.435 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2023-03-31T22:28:01.435Z,1680301681.435 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 17 2023-03-31T22:28:01.829Z,1680301681.829 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2023-03-31T22:28:15.536Z,1680301695.536 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-03-31T22:28:22.843Z,1680301702.843 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-03-31T22:23:22.7Z 2023-03-31T22:28:22.843Z,1680301702.843 [Default:CheckIn:Read_GPS] Stopped 2023-03-31T22:28:22.843Z,1680301702.843 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-03-31T22:28:50.688Z,1680301730.688 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-03-31T22:29:25.828Z,1680301765.828 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-03-31T22:30:00.980Z,1680301800.980 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-03-31T22:30:24.430Z,1680301824.430 [NAL9602](FAULT): GPS failed to acquire within timeout. 2023-03-31T22:30:24.430Z,1680301824.430 [NAL9602] Data Fault, FailCount= 5 2023-03-31T22:30:24.430Z,1680301824.430 [NAL9602](ERROR): Data Fault 2023-03-31T22:30:24.449Z,1680301824.449 [CBIT](ERROR): Data Fault in component: NAL9602 2023-03-31T22:30:24.449Z,1680301824.449 [CBIT](CRITICAL): Data Fault in component: NAL9602 2023-03-31T22:30:24.842Z,1680301824.842 [NAL9602](INFO): Powering down 2023-03-31T22:30:24.876Z,1680301824.876 [CommandExec](FAULT): Scheduling is paused 2023-03-31T22:30:24.877Z,1680301824.877 [CBIT](INFO): Critical error at 20230331T223024 2023-03-31T22:30:24.877Z,1680301824.877 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2023-03-31T22:30:36.120Z,1680301836.120 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-03-31T22:31:02.012Z,1680301862.012 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 18 2023-03-31T22:31:02.012Z,1680301862.012 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-03-31T22:31:02.013Z,1680301862.013 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 18 2023-03-31T22:31:02.013Z,1680301862.013 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2023-03-31T22:31:02.024Z,1680301862.024 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-03-31T22:31:02.025Z,1680301862.025 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2023-03-31T22:31:02.429Z,1680301862.429 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-03-31T22:31:02.429Z,1680301862.429 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 18 2023-03-31T22:31:02.430Z,1680301862.430 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2023-03-31T22:31:02.430Z,1680301862.430 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 18 2023-03-31T22:31:02.817Z,1680301862.817 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2023-03-31T22:31:11.260Z,1680301871.260 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-03-31T22:31:46.408Z,1680301906.408 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-03-31T22:32:21.548Z,1680301941.548 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-03-31T22:32:24.439Z,1680301944.439 [CBIT](INFO): Clearing failed state for component NAL9602 2023-03-31T22:32:24.440Z,1680301944.440 [NAL9602] No Fault, FailCount= 5 2023-03-31T22:32:24.831Z,1680301944.831 [NAL9602](INFO): Powering up NAL9602 2023-03-31T22:32:35.734Z,1680301955.734 [NAL9602](INFO): NAL9602 initialized 2023-03-31T22:32:56.696Z,1680301976.696 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-03-31T22:33:31.845Z,1680302011.845 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-03-31T22:34:03.041Z,1680302043.041 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 19 2023-03-31T22:34:03.041Z,1680302043.041 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-03-31T22:34:03.042Z,1680302043.042 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 19 2023-03-31T22:34:03.042Z,1680302043.042 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2023-03-31T22:34:03.053Z,1680302043.053 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-03-31T22:34:03.053Z,1680302043.053 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2023-03-31T22:34:03.421Z,1680302043.421 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-03-31T22:34:03.421Z,1680302043.421 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 19 2023-03-31T22:34:03.422Z,1680302043.422 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2023-03-31T22:34:03.422Z,1680302043.422 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 19 2023-03-31T22:34:03.833Z,1680302043.833 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2023-03-31T22:34:06.984Z,1680302046.984 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-03-31T22:34:42.124Z,1680302082.124 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-03-31T22:35:17.264Z,1680302117.264 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-03-31T22:35:52.412Z,1680302152.412 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-03-31T22:36:27.556Z,1680302187.556 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-03-31T22:37:02.696Z,1680302222.696 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-03-31T22:37:04.022Z,1680302224.022 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 20 2023-03-31T22:37:04.022Z,1680302224.022 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-03-31T22:37:04.023Z,1680302224.023 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 20 2023-03-31T22:37:04.023Z,1680302224.023 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2023-03-31T22:37:04.073Z,1680302224.073 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-03-31T22:37:04.073Z,1680302224.073 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2023-03-31T22:37:04.424Z,1680302224.424 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-03-31T22:37:04.424Z,1680302224.424 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 20 2023-03-31T22:37:04.425Z,1680302224.425 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2023-03-31T22:37:04.425Z,1680302224.425 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 20 2023-03-31T22:37:04.833Z,1680302224.833 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2023-03-31T22:37:37.840Z,1680302257.840 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-03-31T22:38:12.996Z,1680302292.996 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-03-31T22:38:48.160Z,1680302328.160 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-03-31T22:39:23.300Z,1680302363.300 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-03-31T22:39:58.452Z,1680302398.452 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-03-31T22:40:05.025Z,1680302405.025 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 21 2023-03-31T22:40:05.025Z,1680302405.025 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-03-31T22:40:05.026Z,1680302405.026 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 21 2023-03-31T22:40:05.026Z,1680302405.026 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2023-03-31T22:40:05.037Z,1680302405.037 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-03-31T22:40:05.037Z,1680302405.037 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2023-03-31T22:40:05.403Z,1680302405.403 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-03-31T22:40:05.403Z,1680302405.403 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 21 2023-03-31T22:40:05.404Z,1680302405.404 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2023-03-31T22:40:05.404Z,1680302405.404 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 21 2023-03-31T22:40:05.821Z,1680302405.821 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2023-03-31T22:40:33.604Z,1680302433.604 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-03-31T22:41:08.752Z,1680302468.752 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-03-31T22:41:43.904Z,1680302503.904 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-03-31T22:42:19.056Z,1680302539.056 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-03-31T22:42:37.698Z,1680302557.698 [NAL9602](FAULT): GPS failed to acquire within timeout. 2023-03-31T22:42:37.698Z,1680302557.698 [NAL9602] Data Fault, FailCount= 1 2023-03-31T22:42:37.698Z,1680302557.698 [NAL9602](ERROR): Data Fault 2023-03-31T22:42:37.716Z,1680302557.716 [CBIT](ERROR): Data Fault in component: NAL9602 2023-03-31T22:42:38.103Z,1680302558.103 [NAL9602](INFO): Powering down 2023-03-31T22:42:38.927Z,1680302558.927 [CBIT](INFO): Clearing failed state for component NAL9602 2023-03-31T22:42:38.927Z,1680302558.927 [NAL9602] No Fault, FailCount= 1 2023-03-31T22:42:54.196Z,1680302574.196 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-03-31T22:43:05.991Z,1680302585.991 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 22 2023-03-31T22:43:05.991Z,1680302585.991 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-03-31T22:43:05.993Z,1680302585.993 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 22 2023-03-31T22:43:05.993Z,1680302585.993 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2023-03-31T22:43:06.003Z,1680302586.003 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-03-31T22:43:06.003Z,1680302586.003 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2023-03-31T22:43:06.390Z,1680302586.390 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-03-31T22:43:06.390Z,1680302586.390 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 22 2023-03-31T22:43:06.390Z,1680302586.390 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2023-03-31T22:43:06.390Z,1680302586.390 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 22 2023-03-31T22:43:06.788Z,1680302586.788 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2023-03-31T22:43:08.402Z,1680302588.402 [NAL9602](INFO): Powering up NAL9602 2023-03-31T22:43:19.314Z,1680302599.314 [NAL9602](INFO): NAL9602 initialized 2023-03-31T22:43:29.337Z,1680302609.337 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-03-31T22:44:04.476Z,1680302644.476 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-03-31T22:44:39.620Z,1680302679.620 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-03-31T22:45:14.780Z,1680302714.780 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-03-31T22:45:49.920Z,1680302749.920 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-03-31T22:46:06.985Z,1680302766.985 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 23 2023-03-31T22:46:06.985Z,1680302766.985 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-03-31T22:46:06.986Z,1680302766.986 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 23 2023-03-31T22:46:06.986Z,1680302766.986 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2023-03-31T22:46:06.998Z,1680302766.998 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-03-31T22:46:06.998Z,1680302766.998 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2023-03-31T22:46:07.426Z,1680302767.426 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-03-31T22:46:07.426Z,1680302767.426 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 23 2023-03-31T22:46:07.427Z,1680302767.427 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2023-03-31T22:46:07.427Z,1680302767.427 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 23 2023-03-31T22:46:07.784Z,1680302767.784 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2023-03-31T22:46:25.064Z,1680302785.064 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-03-31T22:47:00.208Z,1680302820.208 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-03-31T22:47:35.360Z,1680302855.360 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2023-03-31T22:47:56.672Z,1680302876.672 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.002918 2023-03-31T22:48:03.827Z,1680302883.827 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230331T213634/Courier0016.lzma 2023-03-31T22:48:04.830Z,1680302884.830 [DataOverHttps](INFO): Moved sent file to Logs/20230331T213634/Courier0016.lzma.bak 2023-03-31T22:48:04.830Z,1680302884.830 [DataOverHttps](INFO): SBD MOMSN=17888328 2023-03-31T22:48:20.596Z,1680302900.596 [DataOverHttps](INFO): Sending 150 bytes from file Logs/20230331T213634/Express0017.lzma 2023-03-31T22:48:21.598Z,1680302901.598 [DataOverHttps](INFO): Moved sent file to Logs/20230331T213634/Express0017.lzma.bak 2023-03-31T22:48:21.598Z,1680302901.598 [DataOverHttps](INFO): SBD MOMSN=17888331 2023-03-31T22:48:22.734Z,1680302902.734 [Default:CheckIn:Read_Iridium] Stopped 2023-03-31T22:48:22.734Z,1680302902.734 [Default:CheckIn:C.Wait] Running Loop=1 2023-03-31T22:48:22.734Z,1680302902.734 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-03-31T22:49:07.981Z,1680302947.981 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 24 2023-03-31T22:49:07.981Z,1680302947.981 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-03-31T22:49:07.982Z,1680302947.982 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 24 2023-03-31T22:49:07.982Z,1680302947.982 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2023-03-31T22:49:07.993Z,1680302947.993 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-03-31T22:49:07.993Z,1680302947.993 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2023-03-31T22:49:08.382Z,1680302948.382 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-03-31T22:49:08.382Z,1680302948.382 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 24 2023-03-31T22:49:08.382Z,1680302948.382 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2023-03-31T22:49:08.382Z,1680302948.382 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 24 2023-03-31T22:49:08.777Z,1680302948.777 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2023-03-31T22:51:12.599Z,1680303072.599 [CommandExec](IMPORTANT): got command maintain control VerticalControl.buoyancyAction 200 cubic_centimeter 2023-03-31T22:51:12.603Z,1680303072.603 [ComponentRegistry](DEBUG): SyncComponent "Maintain_VerticalControl.buoyancyAction" handled in the control thread. 2023-03-31T22:51:12.842Z,1680303072.842 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,MultiRay,NAL9602,PowerOnly,Power24vConverter,Waterlinked,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, 2023-03-31T22:51:29.327Z,1680303089.327 [CommandExec](IMPORTANT): got command report mod platform_buoyancy_position 2023-03-31T22:51:29.520Z,1680303089.520 [Reporter](INFO): platform_buoyancy_position 829.140991 cc 2023-03-31T22:51:29.839Z,1680303089.839 [Reporter](INFO): platform_buoyancy_position 824.574829 cc 2023-03-31T22:51:30.254Z,1680303090.254 [Reporter](INFO): platform_buoyancy_position 818.396973 cc 2023-03-31T22:51:30.669Z,1680303090.669 [Reporter](INFO): platform_buoyancy_position 813.965088 cc 2023-03-31T22:51:31.046Z,1680303091.046 [Reporter](INFO): platform_buoyancy_position 807.787292 cc 2023-03-31T22:51:31.462Z,1680303091.462 [Reporter](INFO): platform_buoyancy_position 803.355347 cc 2023-03-31T22:51:31.931Z,1680303091.931 [Reporter](INFO): platform_buoyancy_position 796.908997 cc 2023-03-31T22:51:32.287Z,1680303092.287 [Reporter](INFO): platform_buoyancy_position 792.611389 cc 2023-03-31T22:51:32.678Z,1680303092.678 [Reporter](INFO): platform_buoyancy_position 786.299255 cc 2023-03-31T22:51:33.074Z,1680303093.074 [Reporter](INFO): platform_buoyancy_position 782.001648 cc 2023-03-31T22:51:33.477Z,1680303093.477 [Reporter](INFO): platform_buoyancy_position 777.032593 cc 2023-03-31T22:51:33.874Z,1680303093.874 [Reporter](INFO): platform_buoyancy_position 771.123352 cc 2023-03-31T22:51:34.308Z,1680303094.308 [Reporter](INFO): platform_buoyancy_position 766.422852 cc 2023-03-31T22:51:34.706Z,1680303094.706 [Reporter](INFO): platform_buoyancy_position 760.513672 cc 2023-03-31T22:51:35.118Z,1680303095.118 [Reporter](INFO): platform_buoyancy_position 756.216064 cc 2023-03-31T22:51:35.492Z,1680303095.492 [Reporter](INFO): platform_buoyancy_position 749.769653 cc 2023-03-31T22:51:35.898Z,1680303095.898 [Reporter](INFO): platform_buoyancy_position 745.337769 cc 2023-03-31T22:51:36.294Z,1680303096.294 [Reporter](INFO): platform_buoyancy_position 739.025696 cc 2023-03-31T22:51:36.710Z,1680303096.710 [Reporter](INFO): platform_buoyancy_position 734.593750 cc 2023-03-31T22:51:37.098Z,1680303097.098 [Reporter](INFO): platform_buoyancy_position 728.281677 cc 2023-03-31T22:51:37.535Z,1680303097.535 [Reporter](INFO): platform_buoyancy_position 723.312561 cc 2023-03-31T22:51:37.930Z,1680303097.930 [Reporter](INFO): platform_buoyancy_position 717.403381 cc 2023-03-31T22:51:38.342Z,1680303098.342 [Reporter](INFO): platform_buoyancy_position 712.702881 cc 2023-03-31T22:51:38.722Z,1680303098.722 [Reporter](INFO): platform_buoyancy_position 706.927979 cc 2023-03-31T22:51:39.140Z,1680303099.140 [Reporter](INFO): platform_buoyancy_position 702.093140 cc 2023-03-31T22:51:39.526Z,1680303099.526 [Reporter](INFO): platform_buoyancy_position 695.915344 cc 2023-03-31T22:51:39.932Z,1680303099.932 [Reporter](INFO): platform_buoyancy_position 691.752075 cc 2023-03-31T22:51:40.358Z,1680303100.358 [Reporter](INFO): platform_buoyancy_position 685.439941 cc 2023-03-31T22:51:40.758Z,1680303100.758 [Reporter](INFO): platform_buoyancy_position 680.873779 cc 2023-03-31T22:51:41.154Z,1680303101.154 [Reporter](INFO): platform_buoyancy_position 674.561646 cc 2023-03-31T22:51:41.538Z,1680303101.538 [Reporter](INFO): platform_buoyancy_position 670.129761 cc 2023-03-31T22:51:41.964Z,1680303101.964 [Reporter](INFO): platform_buoyancy_position 665.160645 cc 2023-03-31T22:51:42.358Z,1680303102.358 [Reporter](INFO): platform_buoyancy_position 659.385742 cc 2023-03-31T22:51:42.822Z,1680303102.822 [Reporter](INFO): platform_buoyancy_position 653.073669 cc 2023-03-31T22:51:43.215Z,1680303103.215 [Reporter](INFO): platform_buoyancy_position 648.641785 cc 2023-03-31T22:51:43.602Z,1680303103.602 [Reporter](INFO): platform_buoyancy_position 643.538391 cc 2023-03-31T22:51:44.043Z,1680303104.043 [Reporter](INFO): platform_buoyancy_position 637.897766 cc 2023-03-31T22:51:44.383Z,1680303104.383 [Reporter](INFO): platform_buoyancy_position 633.600159 cc 2023-03-31T22:51:44.782Z,1680303104.782 [Reporter](INFO): platform_buoyancy_position 627.959534 cc 2023-03-31T22:51:45.287Z,1680303105.287 [Reporter](INFO): platform_buoyancy_position 620.975952 cc 2023-03-31T22:51:45.639Z,1680303105.639 [Reporter](INFO): platform_buoyancy_position 616.544067 cc 2023-03-31T22:51:46.016Z,1680303106.016 [Reporter](INFO): platform_buoyancy_position 612.246460 cc 2023-03-31T22:51:46.440Z,1680303106.440 [Reporter](INFO): platform_buoyancy_position 605.800049 cc 2023-03-31T22:51:46.822Z,1680303106.822 [Reporter](INFO): platform_buoyancy_position 601.636780 cc 2023-03-31T22:51:47.227Z,1680303107.227 [Reporter](INFO): platform_buoyancy_position 596.936279 cc 2023-03-31T22:51:47.631Z,1680303107.631 [Reporter](INFO): platform_buoyancy_position 590.758484 cc 2023-03-31T22:51:48.051Z,1680303108.051 [Reporter](INFO): platform_buoyancy_position 584.983582 cc 2023-03-31T22:51:48.435Z,1680303108.435 [Reporter](INFO): platform_buoyancy_position 580.014465 cc 2023-03-31T22:51:48.861Z,1680303108.861 [Reporter](INFO): platform_buoyancy_position 573.433777 cc 2023-03-31T22:51:49.237Z,1680303109.237 [Reporter](INFO): platform_buoyancy_position 569.136169 cc 2023-03-31T22:51:49.652Z,1680303109.652 [Reporter](INFO): platform_buoyancy_position 564.838562 cc 2023-03-31T22:51:50.063Z,1680303110.063 [Reporter](INFO): platform_buoyancy_position 558.392151 cc 2023-03-31T22:51:50.446Z,1680303110.446 [Reporter](INFO): platform_buoyancy_position 554.094543 cc 2023-03-31T22:51:50.854Z,1680303110.854 [Reporter](INFO): platform_buoyancy_position 548.051025 cc 2023-03-31T22:51:51.267Z,1680303111.267 [Reporter](INFO): platform_buoyancy_position 543.484863 cc 2023-03-31T22:51:51.666Z,1680303111.666 [Reporter](INFO): platform_buoyancy_position 537.172729 cc 2023-03-31T22:51:52.054Z,1680303112.054 [Reporter](INFO): platform_buoyancy_position 532.740845 cc 2023-03-31T22:51:52.466Z,1680303112.466 [Reporter](INFO): platform_buoyancy_position 526.428772 cc 2023-03-31T22:51:52.882Z,1680303112.882 [Reporter](INFO): platform_buoyancy_position 521.862549 cc 2023-03-31T22:51:53.278Z,1680303113.278 [Reporter](INFO): platform_buoyancy_position 515.550476 cc 2023-03-31T22:51:53.654Z,1680303113.654 [Reporter](INFO): platform_buoyancy_position 511.118500 cc 2023-03-31T22:51:54.074Z,1680303114.074 [Reporter](INFO): platform_buoyancy_position 506.418060 cc 2023-03-31T22:51:54.490Z,1680303114.490 [Reporter](INFO): platform_buoyancy_position 500.508881 cc 2023-03-31T22:51:54.899Z,1680303114.899 [Reporter](INFO): platform_buoyancy_position 496.076935 cc 2023-03-31T22:51:55.290Z,1680303115.290 [Reporter](INFO): platform_buoyancy_position 489.630554 cc 2023-03-31T22:51:55.727Z,1680303115.727 [Reporter](INFO): platform_buoyancy_position 485.467224 cc 2023-03-31T22:51:56.174Z,1680303116.174 [Reporter](INFO): platform_buoyancy_position 478.886536 cc 2023-03-31T22:51:56.535Z,1680303116.535 [Reporter](INFO): platform_buoyancy_position 474.454651 cc 2023-03-31T22:51:56.930Z,1680303116.930 [Reporter](INFO): platform_buoyancy_position 468.679749 cc 2023-03-31T22:51:57.321Z,1680303117.321 [Reporter](INFO): platform_buoyancy_position 463.844971 cc 2023-03-31T22:51:57.706Z,1680303117.706 [Reporter](INFO): platform_buoyancy_position 459.547363 cc 2023-03-31T22:51:58.122Z,1680303118.122 [Reporter](INFO): platform_buoyancy_position 453.235229 cc 2023-03-31T22:51:58.593Z,1680303118.593 [Reporter](INFO): platform_buoyancy_position 446.788818 cc 2023-03-31T22:51:58.967Z,1680303118.967 [Reporter](INFO): platform_buoyancy_position 442.356934 cc 2023-03-31T22:51:59.374Z,1680303119.374 [Reporter](INFO): platform_buoyancy_position 436.044861 cc 2023-03-31T22:51:59.741Z,1680303119.741 [Reporter](INFO): platform_buoyancy_position 431.612976 cc 2023-03-31T22:52:00.131Z,1680303120.131 [Reporter](INFO): platform_buoyancy_position 426.509521 cc 2023-03-31T22:52:00.530Z,1680303120.530 [Reporter](INFO): platform_buoyancy_position 421.137573 cc 2023-03-31T22:52:00.982Z,1680303120.982 [Reporter](INFO): platform_buoyancy_position 415.228333 cc 2023-03-31T22:52:01.392Z,1680303121.392 [Reporter](INFO): platform_buoyancy_position 410.124939 cc 2023-03-31T22:52:01.778Z,1680303121.778 [Reporter](INFO): platform_buoyancy_position 403.812866 cc 2023-03-31T22:52:02.185Z,1680303122.185 [Reporter](INFO): platform_buoyancy_position 399.380920 cc 2023-03-31T22:52:02.578Z,1680303122.578 [Reporter](INFO): platform_buoyancy_position 394.949036 cc 2023-03-31T22:52:02.969Z,1680303122.969 [Reporter](INFO): platform_buoyancy_position 388.771240 cc 2023-03-31T22:52:03.385Z,1680303123.385 [Reporter](INFO): platform_buoyancy_position 384.339355 cc 2023-03-31T22:52:03.821Z,1680303123.821 [Reporter](INFO): platform_buoyancy_position 378.027222 cc 2023-03-31T22:52:04.171Z,1680303124.171 [Reporter](INFO): platform_buoyancy_position 373.729614 cc 2023-03-31T22:52:04.610Z,1680303124.610 [Reporter](INFO): platform_buoyancy_position 367.148926 cc 2023-03-31T22:52:04.998Z,1680303124.998 [Reporter](INFO): platform_buoyancy_position 362.851318 cc 2023-03-31T22:52:05.411Z,1680303125.411 [Reporter](INFO): platform_buoyancy_position 356.539246 cc 2023-03-31T22:52:05.791Z,1680303125.791 [Reporter](INFO): platform_buoyancy_position 352.107361 cc 2023-03-31T22:52:06.198Z,1680303126.198 [Reporter](INFO): platform_buoyancy_position 347.809753 cc 2023-03-31T22:52:06.610Z,1680303126.610 [Reporter](INFO): platform_buoyancy_position 341.363342 cc 2023-03-31T22:52:06.990Z,1680303126.990 [Reporter](INFO): platform_buoyancy_position 334.916931 cc 2023-03-31T22:52:07.426Z,1680303127.426 [Reporter](INFO): platform_buoyancy_position 330.753662 cc 2023-03-31T22:52:07.818Z,1680303127.818 [Reporter](INFO): platform_buoyancy_position 326.321716 cc 2023-03-31T22:52:08.229Z,1680303128.229 [Reporter](INFO): platform_buoyancy_position 319.875366 cc 2023-03-31T22:52:08.622Z,1680303128.622 [Reporter](INFO): platform_buoyancy_position 315.309143 cc 2023-03-31T22:52:09.025Z,1680303129.025 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 25 2023-03-31T22:52:09.025Z,1680303129.025 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-03-31T22:52:09.026Z,1680303129.026 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 25 2023-03-31T22:52:09.026Z,1680303129.026 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2023-03-31T22:52:09.083Z,1680303129.083 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-03-31T22:52:09.083Z,1680303129.083 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2023-03-31T22:52:09.089Z,1680303129.089 [Reporter](INFO): platform_buoyancy_position 309.131348 cc 2023-03-31T22:52:09.434Z,1680303129.434 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-03-31T22:52:09.434Z,1680303129.434 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 25 2023-03-31T22:52:09.434Z,1680303129.434 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2023-03-31T22:52:09.434Z,1680303129.434 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 25 2023-03-31T22:52:09.436Z,1680303129.436 [Reporter](INFO): platform_buoyancy_position 304.833740 cc 2023-03-31T22:52:09.797Z,1680303129.797 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2023-03-31T22:52:09.834Z,1680303129.834 [Reporter](INFO): platform_buoyancy_position 298.521637 cc 2023-03-31T22:52:10.267Z,1680303130.267 [Reporter](INFO): platform_buoyancy_position 294.089722 cc 2023-03-31T22:52:10.642Z,1680303130.642 [Reporter](INFO): platform_buoyancy_position 287.777649 cc 2023-03-31T22:52:11.053Z,1680303131.053 [Reporter](INFO): platform_buoyancy_position 283.345734 cc 2023-03-31T22:52:11.446Z,1680303131.446 [Reporter](INFO): platform_buoyancy_position 277.167938 cc 2023-03-31T22:52:11.841Z,1680303131.841 [Reporter](INFO): platform_buoyancy_position 272.601746 cc 2023-03-31T22:52:12.247Z,1680303132.247 [Reporter](INFO): platform_buoyancy_position 266.423920 cc 2023-03-31T22:52:12.662Z,1680303132.662 [Reporter](INFO): platform_buoyancy_position 261.857727 cc 2023-03-31T22:52:13.074Z,1680303133.074 [Reporter](INFO): platform_buoyancy_position 256.888641 cc 2023-03-31T22:52:13.491Z,1680303133.491 [Reporter](INFO): platform_buoyancy_position 251.248047 cc 2023-03-31T22:52:13.890Z,1680303133.890 [Reporter](INFO): platform_buoyancy_position 244.801636 cc 2023-03-31T22:52:14.278Z,1680303134.278 [Reporter](INFO): platform_buoyancy_position 240.369720 cc 2023-03-31T22:52:14.686Z,1680303134.686 [Reporter](INFO): platform_buoyancy_position 236.072144 cc 2023-03-31T22:52:15.086Z,1680303135.086 [Reporter](INFO): platform_buoyancy_position 229.760040 cc 2023-03-31T22:52:15.482Z,1680303135.482 [Reporter](INFO): platform_buoyancy_position 225.462433 cc 2023-03-31T22:52:15.898Z,1680303135.898 [Reporter](INFO): platform_buoyancy_position 219.016022 cc 2023-03-31T22:52:16.236Z,1680303136.236 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6. 2023-03-31T22:52:16.250Z,1680303136.250 [BPC1](INFO): Received data from all battery sticks. 2023-03-31T22:52:16.342Z,1680303136.342 [Reporter](INFO): platform_buoyancy_position 212.569641 cc 2023-03-31T22:52:16.732Z,1680303136.732 [Reporter](INFO): platform_buoyancy_position 210.286530 cc 2023-03-31T22:52:17.150Z,1680303137.150 [Reporter](INFO): platform_buoyancy_position 205.988922 cc 2023-03-31T22:52:57.470Z,1680303177.470 [CommandExec](IMPORTANT): got command maintain control VerticalControl.buoyancyAction 100 cubic_centimeter 2023-03-31T22:52:59.150Z,1680303179.150 [Reporter](INFO): platform_buoyancy_position 197.528015 cc 2023-03-31T22:52:59.522Z,1680303179.522 [Reporter](INFO): platform_buoyancy_position 197.393738 cc 2023-03-31T22:52:59.919Z,1680303179.919 [Reporter](INFO): platform_buoyancy_position 195.379242 cc 2023-03-31T22:53:00.330Z,1680303180.330 [Reporter](INFO): platform_buoyancy_position 190.947327 cc 2023-03-31T22:53:00.734Z,1680303180.734 [Reporter](INFO): platform_buoyancy_position 186.649719 cc 2023-03-31T22:53:01.156Z,1680303181.156 [Reporter](INFO): platform_buoyancy_position 182.352142 cc 2023-03-31T22:53:01.575Z,1680303181.575 [Reporter](INFO): platform_buoyancy_position 178.054535 cc 2023-03-31T22:53:01.970Z,1680303181.970 [Reporter](INFO): platform_buoyancy_position 171.742432 cc 2023-03-31T22:53:02.358Z,1680303182.358 [Reporter](INFO): platform_buoyancy_position 167.310516 cc 2023-03-31T22:53:02.768Z,1680303182.768 [Reporter](INFO): platform_buoyancy_position 161.267029 cc 2023-03-31T22:53:03.166Z,1680303183.166 [Reporter](INFO): platform_buoyancy_position 156.835114 cc 2023-03-31T22:53:03.555Z,1680303183.555 [Reporter](INFO): platform_buoyancy_position 150.120117 cc 2023-03-31T22:53:03.977Z,1680303183.977 [Reporter](INFO): platform_buoyancy_position 145.956818 cc 2023-03-31T22:53:04.458Z,1680303184.458 [Reporter](INFO): platform_buoyancy_position 139.510437 cc 2023-03-31T22:53:04.790Z,1680303184.790 [Reporter](INFO): platform_buoyancy_position 135.078522 cc 2023-03-31T22:53:05.185Z,1680303185.185 [Reporter](INFO): platform_buoyancy_position 130.109436 cc 2023-03-31T22:53:05.593Z,1680303185.593 [Reporter](INFO): platform_buoyancy_position 124.468819 cc 2023-03-31T22:53:05.990Z,1680303185.990 [Reporter](INFO): platform_buoyancy_position 120.171234 cc 2023-03-31T22:53:06.384Z,1680303186.384 [Reporter](INFO): platform_buoyancy_position 115.739319 cc 2023-03-31T22:53:06.814Z,1680303186.814 [Reporter](INFO): platform_buoyancy_position 109.292908 cc 2023-03-31T22:53:22.487Z,1680303202.487 [NAL9602](FAULT): GPS failed to acquire within timeout. 2023-03-31T22:53:22.487Z,1680303202.487 [NAL9602] Data Fault, FailCount= 2 2023-03-31T22:53:22.487Z,1680303202.487 [NAL9602](ERROR): Data Fault 2023-03-31T22:53:22.547Z,1680303202.547 [CBIT](ERROR): Data Fault in component: NAL9602 2023-03-31T22:53:22.898Z,1680303202.898 [NAL9602](INFO): Powering down 2023-03-31T22:53:23.302Z,1680303203.302 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-03-31T22:53:23.302Z,1680303203.302 [Default:CheckIn:C.Wait] Stopped 2023-03-31T22:53:23.302Z,1680303203.302 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-03-31T22:53:23.303Z,1680303203.303 [Default:CheckIn:D] Running Loop=1 2023-03-31T22:53:23.714Z,1680303203.714 [Default:CheckIn:D] Stopped 2023-03-31T22:53:23.714Z,1680303203.714 [Default:CheckIn:E] Running Loop=1 2023-03-31T22:53:23.724Z,1680303203.724 [CBIT](INFO): Clearing failed state for component NAL9602 2023-03-31T22:53:23.724Z,1680303203.724 [NAL9602] No Fault, FailCount= 2 2023-03-31T22:53:24.130Z,1680303204.130 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 72.196525 min 2023-03-31T22:53:24.130Z,1680303204.130 [Default:CheckIn:E] Stopped 2023-03-31T22:53:24.130Z,1680303204.130 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-03-31T22:53:24.130Z,1680303204.130 [Default:CheckIn] Stopped 2023-03-31T22:53:24.130Z,1680303204.130 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-03-31T22:53:24.131Z,1680303204.131 [Default:CheckIn](INFO): Running loop #6 2023-03-31T22:53:24.131Z,1680303204.131 [Default:CheckIn] Running Loop=6 2023-03-31T22:53:24.131Z,1680303204.131 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-03-31T22:53:24.131Z,1680303204.131 [Default:CheckIn:Read_GPS] Running Loop=1 2023-03-31T22:53:53.250Z,1680303233.250 [NAL9602](INFO): Powering up NAL9602 2023-03-31T22:53:57.004Z,1680303237.004 [CommandExec](IMPORTANT): got command maintain control VerticalControl.buoyancyAction 250 cubic_centimeter 2023-03-31T22:53:59.394Z,1680303239.394 [Reporter](INFO): platform_buoyancy_position 100.697723 cc 2023-03-31T22:54:00.204Z,1680303240.204 [Reporter](INFO): platform_buoyancy_position 100.832031 cc 2023-03-31T22:54:00.237Z,1680303240.237 [CommandExec](IMPORTANT): got command gfscan 2023-03-31T22:54:00.581Z,1680303240.581 [CBIT](IMPORTANT): Beginning ground fault scan 2023-03-31T22:54:00.583Z,1680303240.583 [Reporter](INFO): platform_buoyancy_position 103.115112 cc 2023-03-31T22:54:01.001Z,1680303241.001 [Reporter](INFO): platform_buoyancy_position 109.292908 cc 2023-03-31T22:54:01.391Z,1680303241.391 [Reporter](INFO): platform_buoyancy_position 113.590515 cc 2023-03-31T22:54:01.784Z,1680303241.784 [Reporter](INFO): platform_buoyancy_position 118.022430 cc 2023-03-31T22:54:02.278Z,1680303242.278 [Reporter](INFO): platform_buoyancy_position 124.334534 cc 2023-03-31T22:54:02.611Z,1680303242.611 [Reporter](INFO): platform_buoyancy_position 128.766418 cc 2023-03-31T22:54:03.002Z,1680303243.002 [Reporter](INFO): platform_buoyancy_position 135.212830 cc 2023-03-31T22:54:03.393Z,1680303243.393 [CBIT](ERROR): Error reading 24V bus power status. Assuming off for scan purposes. 2023-03-31T22:54:03.395Z,1680303243.395 [Reporter](INFO): platform_buoyancy_position 139.376129 cc 2023-03-31T22:54:03.835Z,1680303243.835 [Reporter](INFO): platform_buoyancy_position 145.956818 cc 2023-03-31T22:54:04.166Z,1680303244.166 [NAL9602](INFO): NAL9602 initialized 2023-03-31T22:54:04.236Z,1680303244.236 [Reporter](INFO): platform_buoyancy_position 150.254425 cc 2023-03-31T22:54:04.705Z,1680303244.705 [Reporter](INFO): platform_buoyancy_position 156.566528 cc 2023-03-31T22:54:05.051Z,1680303245.051 [Reporter](INFO): platform_buoyancy_position 160.998413 cc 2023-03-31T22:54:05.446Z,1680303245.446 [Reporter](INFO): platform_buoyancy_position 167.310516 cc 2023-03-31T22:54:05.937Z,1680303245.937 [Reporter](INFO): platform_buoyancy_position 171.742432 cc 2023-03-31T22:54:06.248Z,1680303246.248 [Reporter](INFO): platform_buoyancy_position 178.054535 cc 2023-03-31T22:54:06.642Z,1680303246.642 [Reporter](INFO): platform_buoyancy_position 182.352142 cc 2023-03-31T22:54:07.059Z,1680303247.059 [Reporter](INFO): platform_buoyancy_position 188.932831 cc 2023-03-31T22:54:07.537Z,1680303247.537 [Reporter](INFO): platform_buoyancy_position 193.230438 cc 2023-03-31T22:54:07.874Z,1680303247.874 [Reporter](INFO): platform_buoyancy_position 199.542542 cc 2023-03-31T22:54:08.267Z,1680303248.267 [Reporter](INFO): platform_buoyancy_position 203.974426 cc 2023-03-31T22:54:08.770Z,1680303248.770 [Reporter](INFO): platform_buoyancy_position 210.420837 cc 2023-03-31T22:54:09.083Z,1680303249.083 [Reporter](INFO): platform_buoyancy_position 214.449829 cc 2023-03-31T22:54:09.477Z,1680303249.477 [Reporter](INFO): platform_buoyancy_position 219.016022 cc 2023-03-31T22:54:09.969Z,1680303249.969 [Reporter](INFO): platform_buoyancy_position 225.328125 cc 2023-03-31T22:54:10.282Z,1680303250.282 [Reporter](INFO): platform_buoyancy_position 229.760040 cc 2023-03-31T22:54:10.698Z,1680303250.698 [Reporter](INFO): platform_buoyancy_position 236.072144 cc 2023-03-31T22:54:11.229Z,1680303251.229 [Reporter](INFO): platform_buoyancy_position 240.504028 cc 2023-03-31T22:54:11.502Z,1680303251.502 [CBIT](IMPORTANT): Ground fault detected mA: CHAN A0 (Batt): 0.149658 CHAN A1 (24V) N/A reporting off CHAN A2 (12V): 0.101155 CHAN A3 (5V): 0.032023 CHAN B0 (3.3V): 0.020039 CHAN B1 (3.15aV): 0.019661 CHAN B2 (3.15bV): 0.019370 CHAN B3 (GND): -0.000363 OPEN: 0.011603 Full Scale: +/- 1 mA 2023-03-31T22:54:43.533Z,1680303283.533 [CommandExec](IMPORTANT): got command ! echo 1 > /dev/loadB2 2023-03-31T22:54:46.037Z,1680303286.037 [CommandExec](IMPORTANT): got command gfscan 2023-03-31T22:54:46.222Z,1680303286.222 [CBIT](IMPORTANT): Beginning ground fault scan 2023-03-31T22:54:49.027Z,1680303289.027 [CBIT](ERROR): Error reading 24V bus power status. Assuming off for scan purposes. 2023-03-31T22:54:57.149Z,1680303297.149 [CBIT](IMPORTANT): Ground fault detected mA: CHAN A0 (Batt): 0.147885 CHAN A1 (24V) N/A reporting off CHAN A2 (12V): 0.096088 CHAN A3 (5V): 0.029887 CHAN B0 (3.3V): 0.018801 CHAN B1 (3.15aV): 0.017975 CHAN B2 (3.15bV): 0.018123 CHAN B3 (GND): 0.000068 OPEN: 0.011613 Full Scale: +/- 1 mA 2023-03-31T22:55:10.028Z,1680303310.028 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 26 2023-03-31T22:55:10.028Z,1680303310.028 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-03-31T22:55:10.029Z,1680303310.029 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 26 2023-03-31T22:55:10.029Z,1680303310.029 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2023-03-31T22:55:10.040Z,1680303310.040 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-03-31T22:55:10.040Z,1680303310.040 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2023-03-31T22:55:10.459Z,1680303310.459 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-03-31T22:55:10.459Z,1680303310.459 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 26 2023-03-31T22:55:10.459Z,1680303310.459 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2023-03-31T22:55:10.459Z,1680303310.459 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 26 2023-03-31T22:55:10.849Z,1680303310.849 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2023-03-31T22:55:19.350Z,1680303319.350 [CommandExec](IMPORTANT): got command ! echo i > /dev/loadC3 2023-03-31T22:55:20.918Z,1680303320.918 [CommandExec](IMPORTANT): got command ! echo i > /dev/loadC4 2023-03-31T22:55:22.165Z,1680303322.165 [CommandExec](IMPORTANT): got command gfscan 2023-03-31T22:55:22.178Z,1680303322.178 [CBIT](IMPORTANT): Beginning ground fault scan 2023-03-31T22:55:24.981Z,1680303324.981 [CBIT](ERROR): Error reading 24V bus power status. Assuming off for scan purposes. 2023-03-31T22:55:33.102Z,1680303333.102 [CBIT](IMPORTANT): Ground fault detected mA: CHAN A0 (Batt): 0.135198 CHAN A1 (24V) N/A reporting off CHAN A2 (12V): 0.087702 CHAN A3 (5V): 0.026443 CHAN B0 (3.3V): 0.015890 CHAN B1 (3.15aV): 0.015746 CHAN B2 (3.15bV): 0.015810 CHAN B3 (GND): -0.000304 OPEN: 0.010735 Full Scale: +/- 1 mA 2023-03-31T22:55:40.169Z,1680303340.169 [CommandExec](IMPORTANT): got command ! echo i > /dev/loadB2 2023-03-31T22:55:50.702Z,1680303350.702 [CommandExec](IMPORTANT): got command ! echo i > /dev/loadC6 2023-03-31T22:55:54.046Z,1680303354.046 [CommandExec](IMPORTANT): got command ! echo i > /dev/loadC7 2023-03-31T22:55:56.149Z,1680303356.149 [CommandExec](IMPORTANT): got command gfscan 2023-03-31T22:55:56.532Z,1680303356.532 [CBIT](IMPORTANT): Beginning ground fault scan 2023-03-31T22:55:59.349Z,1680303359.349 [CBIT](ERROR): Error reading 24V bus power status. Assuming off for scan purposes. 2023-03-31T22:56:07.470Z,1680303367.470 [CBIT](IMPORTANT): Ground fault detected mA: CHAN A0 (Batt): 0.121864 CHAN A1 (24V) N/A reporting off CHAN A2 (12V): 0.083717 CHAN A3 (5V): 0.025999 CHAN B0 (3.3V): 0.015763 CHAN B1 (3.15aV): 0.015131 CHAN B2 (3.15bV): 0.014913 CHAN B3 (GND): -0.000469 OPEN: 0.010417 Full Scale: +/- 1 mA 2023-03-31T22:56:17.486Z,1680303377.486 [CommandExec](IMPORTANT): got command ! echo i > /dev/loadC1 2023-03-31T22:56:21.126Z,1680303381.126 [CommandExec](IMPORTANT): got command ! echo i > /dev/loadA6 2023-03-31T22:56:22.997Z,1680303382.997 [CommandExec](IMPORTANT): got command gfscan 2023-03-31T22:56:23.196Z,1680303383.196 [CBIT](IMPORTANT): Beginning ground fault scan 2023-03-31T22:56:26.005Z,1680303386.005 [CBIT](ERROR): Error reading 24V bus power status. Assuming off for scan purposes. 2023-03-31T22:56:34.075Z,1680303394.075 [CBIT](IMPORTANT): Ground fault detected mA: CHAN A0 (Batt): 0.120951 CHAN A1 (24V) N/A reporting off CHAN A2 (12V): 0.080865 CHAN A3 (5V): 0.025004 CHAN B0 (3.3V): 0.014934 CHAN B1 (3.15aV): 0.014357 CHAN B2 (3.15bV): 0.013964 CHAN B3 (GND): -0.000575 OPEN: 0.009902 Full Scale: +/- 1 mA 2023-03-31T22:56:45.589Z,1680303405.589 [CommandExec](IMPORTANT): got command ! echo i > /dev/loadB3 2023-03-31T22:56:47.978Z,1680303407.978 [CommandExec](IMPORTANT): got command gfscan 2023-03-31T22:56:48.202Z,1680303408.202 [CBIT](IMPORTANT): Beginning ground fault scan 2023-03-31T22:56:51.043Z,1680303411.043 [CBIT](ERROR): Error reading 24V bus power status. Assuming off for scan purposes. 2023-03-31T22:56:53.036Z,1680303413.036 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,225651.00,A,3648.16433,N,12147.27637,W,0.447,28.85,310323,,,A*47 2023-03-31T22:56:53.039Z,1680303413.039 [NAL9602](INFO): GPS fix at 20230331T225651: (36.802739, -121.787939) 2023-03-31T22:56:53.093Z,1680303413.093 [Default:CheckIn:Read_GPS] Stopped 2023-03-31T22:56:53.093Z,1680303413.093 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-03-31T22:56:59.195Z,1680303419.195 [CBIT](IMPORTANT): Ground fault detected mA: CHAN A0 (Batt): 0.116085 CHAN A1 (24V) N/A reporting off CHAN A2 (12V): 0.080689 CHAN A3 (5V): 0.024534 CHAN B0 (3.3V): 0.014919 CHAN B1 (3.15aV): 0.014500 CHAN B2 (3.15bV): 0.014068 CHAN B3 (GND): -0.000100 OPEN: 0.009725 Full Scale: +/- 1 mA 2023-03-31T22:57:00.052Z,1680303420.052 [DataOverHttps](INFO): Sending 291 bytes from file Logs/20230331T213634/Courier0019.lzma 2023-03-31T22:57:01.054Z,1680303421.054 [DataOverHttps](INFO): Moved sent file to Logs/20230331T213634/Courier0019.lzma.bak 2023-03-31T22:57:01.054Z,1680303421.054 [DataOverHttps](INFO): SBD MOMSN=17888709 2023-03-31T22:57:09.574Z,1680303429.574 [CommandExec](IMPORTANT): got command ! echo i > /dev/loadC2 2023-03-31T22:57:11.757Z,1680303431.757 [CommandExec](IMPORTANT): got command gfscan 2023-03-31T22:57:12.145Z,1680303432.145 [CBIT](IMPORTANT): Beginning ground fault scan 2023-03-31T22:57:14.951Z,1680303434.951 [CBIT](ERROR): Error reading 24V bus power status. Assuming off for scan purposes. 2023-03-31T22:57:16.977Z,1680303436.977 [DataOverHttps](INFO): Sending 919 bytes from file Logs/20230331T213634/Express0020.lzma 2023-03-31T22:57:17.978Z,1680303437.978 [DataOverHttps](INFO): Moved sent file to Logs/20230331T213634/Express0020.lzma.bak 2023-03-31T22:57:17.978Z,1680303437.978 [DataOverHttps](INFO): SBD MOMSN=17888713 2023-03-31T22:57:19.387Z,1680303439.387 [Default:CheckIn:Read_Iridium] Stopped 2023-03-31T22:57:19.388Z,1680303439.388 [Default:CheckIn:C.Wait] Running Loop=1 2023-03-31T22:57:19.388Z,1680303439.388 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-03-31T22:57:23.101Z,1680303443.101 [CBIT](IMPORTANT): Ground fault detected mA: CHAN A0 (Batt): 0.116535 CHAN A1 (24V) N/A reporting off CHAN A2 (12V): 0.081277 CHAN A3 (5V): 0.024719 CHAN B0 (3.3V): 0.015449 CHAN B1 (3.15aV): 0.014450 CHAN B2 (3.15bV): 0.014371 CHAN B3 (GND): -0.000715 OPEN: 0.009767 Full Scale: +/- 1 mA 2023-03-31T22:57:25.431Z,1680303445.431 [NAL9602](INFO): Not Powering down - fast GPS 2023-03-31T22:57:37.946Z,1680303457.946 [CommandExec](IMPORTANT): got command ! echo i > /dev/loadB4 2023-03-31T22:57:39.401Z,1680303459.401 [CommandExec](IMPORTANT): got command gfscan 2023-03-31T22:57:39.593Z,1680303459.593 [CBIT](IMPORTANT): Beginning ground fault scan 2023-03-31T22:57:42.442Z,1680303462.442 [CBIT](ERROR): Error reading 24V bus power status. Assuming off for scan purposes. 2023-03-31T22:57:50.539Z,1680303470.539 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): -0.006949 CHAN A1 (24V) N/A reporting off CHAN A2 (12V): -0.005375 CHAN A3 (5V): -0.002711 CHAN B0 (3.3V): -0.001678 CHAN B1 (3.15aV): -0.001494 CHAN B2 (3.15bV): -0.001708 CHAN B3 (GND): -0.000744 OPEN: 0.003387 Full Scale: +/- 1 mA 2023-03-31T22:58:07.372Z,1680303487.372 [CommandExec](IMPORTANT): got command ! echo d > /dev/loadB4 2023-03-31T22:58:09.241Z,1680303489.241 [CommandExec](IMPORTANT): got command gfscan 2023-03-31T22:58:09.481Z,1680303489.481 [CBIT](IMPORTANT): Beginning ground fault scan 2023-03-31T22:58:12.329Z,1680303492.329 [CBIT](ERROR): Error reading 24V bus power status. Assuming off for scan purposes. 2023-03-31T22:58:20.412Z,1680303500.412 [CBIT](IMPORTANT): Ground fault detected mA: CHAN A0 (Batt): 0.116865 CHAN A1 (24V) N/A reporting off CHAN A2 (12V): 0.080812 CHAN A3 (5V): 0.025366 CHAN B0 (3.3V): 0.015754 CHAN B1 (3.15aV): 0.015224 CHAN B2 (3.15bV): 0.014968 CHAN B3 (GND): -0.000660 OPEN: 0.010299 Full Scale: +/- 1 mA 2023-03-31T22:58:26.549Z,1680303506.549 [CommandExec](IMPORTANT): got command ! echo i > /dev/loadB4 2023-03-31T22:58:30.305Z,1680303510.305 [CommandExec](IMPORTANT): got command gfscan 2023-03-31T22:58:30.502Z,1680303510.502 [CBIT](IMPORTANT): Beginning ground fault scan 2023-03-31T22:58:33.367Z,1680303513.367 [CBIT](ERROR): Error reading 24V bus power status. Assuming off for scan purposes. 2023-03-31T22:58:41.421Z,1680303521.421 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): -0.006508 CHAN A1 (24V) N/A reporting off CHAN A2 (12V): -0.005310 CHAN A3 (5V): -0.002577 CHAN B0 (3.3V): -0.001249 CHAN B1 (3.15aV): -0.001656 CHAN B2 (3.15bV): -0.001493 CHAN B3 (GND): -0.000506 OPEN: 0.003167 Full Scale: +/- 1 mA 2023-03-31T22:58:45.114Z,1680303525.114 [CommandExec](IMPORTANT): got command maintain clear 2023-03-31T22:58:45.476Z,1680303525.476 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,MultiRay,NAL9602,PowerOnly,Power24vConverter,Waterlinked,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, 2023-03-31T22:58:47.514Z,1680303527.514 [Reporter](INFO): platform_buoyancy_position 246.950424 cc 2023-03-31T22:58:48.320Z,1680303528.320 [Reporter](INFO): platform_buoyancy_position 248.964935 cc 2023-03-31T22:58:48.702Z,1680303528.702 [Reporter](INFO): platform_buoyancy_position 251.113724 cc 2023-03-31T22:58:49.137Z,1680303529.137 [Reporter](INFO): platform_buoyancy_position 255.411346 cc 2023-03-31T22:58:49.538Z,1680303529.538 [Reporter](INFO): platform_buoyancy_position 259.843231 cc 2023-03-31T22:58:49.928Z,1680303529.928 [Reporter](INFO): platform_buoyancy_position 266.155334 cc 2023-03-31T22:58:50.322Z,1680303530.322 [Reporter](INFO): platform_buoyancy_position 270.452942 cc 2023-03-31T22:58:50.741Z,1680303530.741 [Reporter](INFO): platform_buoyancy_position 276.899323 cc 2023-03-31T22:58:51.142Z,1680303531.142 [Reporter](INFO): platform_buoyancy_position 281.331238 cc 2023-03-31T22:58:51.550Z,1680303531.550 [Reporter](INFO): platform_buoyancy_position 286.703247 cc 2023-03-31T22:58:51.942Z,1680303531.942 [Reporter](INFO): platform_buoyancy_position 291.940948 cc 2023-03-31T22:58:52.337Z,1680303532.337 [Reporter](INFO): platform_buoyancy_position 296.372833 cc 2023-03-31T22:58:52.758Z,1680303532.758 [Reporter](INFO): platform_buoyancy_position 302.550629 cc 2023-03-31T22:58:53.180Z,1680303533.180 [Reporter](INFO): platform_buoyancy_position 307.116852 cc 2023-03-31T22:58:53.546Z,1680303533.546 [Reporter](INFO): platform_buoyancy_position 313.428955 cc 2023-03-31T22:58:53.981Z,1680303533.981 [Reporter](INFO): platform_buoyancy_position 317.860840 cc 2023-03-31T22:58:54.393Z,1680303534.393 [Reporter](INFO): platform_buoyancy_position 324.172913 cc 2023-03-31T22:58:54.758Z,1680303534.758 [Reporter](INFO): platform_buoyancy_position 328.604858 cc 2023-03-31T22:58:55.178Z,1680303535.178 [Reporter](INFO): platform_buoyancy_position 334.916931 cc 2023-03-31T22:58:55.604Z,1680303535.604 [Reporter](INFO): platform_buoyancy_position 339.214539 cc 2023-03-31T22:58:55.974Z,1680303535.974 [Reporter](INFO): platform_buoyancy_position 344.452209 cc 2023-03-31T22:58:56.387Z,1680303536.387 [Reporter](INFO): platform_buoyancy_position 349.958557 cc 2023-03-31T22:58:56.814Z,1680303536.814 [Reporter](INFO): platform_buoyancy_position 356.404968 cc 2023-03-31T22:58:57.186Z,1680303537.186 [Reporter](INFO): platform_buoyancy_position 360.702515 cc 2023-03-31T22:58:57.606Z,1680303537.606 [Reporter](INFO): platform_buoyancy_position 365.537354 cc 2023-03-31T22:58:58.019Z,1680303538.019 [Reporter](INFO): platform_buoyancy_position 371.580872 cc 2023-03-31T22:58:58.403Z,1680303538.403 [Reporter](INFO): platform_buoyancy_position 375.878418 cc 2023-03-31T22:58:58.807Z,1680303538.807 [Reporter](INFO): platform_buoyancy_position 382.190552 cc 2023-03-31T22:58:59.222Z,1680303539.222 [Reporter](INFO): platform_buoyancy_position 386.622437 cc 2023-03-31T22:58:59.630Z,1680303539.630 [Reporter](INFO): platform_buoyancy_position 392.934570 cc 2023-03-31T22:59:00.018Z,1680303540.018 [Reporter](INFO): platform_buoyancy_position 397.366455 cc 2023-03-31T22:59:00.434Z,1680303540.434 [Reporter](INFO): platform_buoyancy_position 403.812866 cc 2023-03-31T22:59:00.834Z,1680303540.834 [Reporter](INFO): platform_buoyancy_position 408.110474 cc 2023-03-31T22:59:01.250Z,1680303541.250 [Reporter](INFO): platform_buoyancy_position 414.422546 cc 2023-03-31T22:59:01.658Z,1680303541.658 [Reporter](INFO): platform_buoyancy_position 418.988770 cc 2023-03-31T22:59:02.030Z,1680303542.030 [Reporter](INFO): platform_buoyancy_position 423.152039 cc 2023-03-31T22:59:02.458Z,1680303542.458 [Reporter](INFO): platform_buoyancy_position 429.598450 cc 2023-03-31T22:59:02.871Z,1680303542.871 [Reporter](INFO): platform_buoyancy_position 435.910522 cc 2023-03-31T22:59:03.238Z,1680303543.238 [Reporter](INFO): platform_buoyancy_position 440.208130 cc 2023-03-31T22:59:03.657Z,1680303543.657 [Reporter](INFO): platform_buoyancy_position 446.654541 cc 2023-03-31T22:59:04.082Z,1680303544.082 [Reporter](INFO): platform_buoyancy_position 451.086426 cc 2023-03-31T22:59:04.475Z,1680303544.475 [Reporter](INFO): platform_buoyancy_position 455.384033 cc 2023-03-31T22:59:04.854Z,1680303544.854 [Reporter](INFO): platform_buoyancy_position 461.696167 cc 2023-03-31T22:59:05.278Z,1680303545.278 [Reporter](INFO): platform_buoyancy_position 466.128052 cc 2023-03-31T22:59:05.682Z,1680303545.682 [Reporter](INFO): platform_buoyancy_position 470.425659 cc 2023-03-31T22:59:06.098Z,1680303546.098 [Reporter](INFO): platform_buoyancy_position 476.872070 cc 2023-03-31T22:59:06.506Z,1680303546.506 [Reporter](INFO): platform_buoyancy_position 483.318420 cc 2023-03-31T22:59:06.883Z,1680303546.883 [Reporter](INFO): platform_buoyancy_position 487.481750 cc 2023-03-31T22:59:07.298Z,1680303547.298 [Reporter](INFO): platform_buoyancy_position 491.779358 cc 2023-03-31T22:59:07.772Z,1680303547.772 [Reporter](INFO): platform_buoyancy_position 498.225800 cc 2023-03-31T22:59:08.134Z,1680303548.134 [Reporter](INFO): platform_buoyancy_position 503.060516 cc 2023-03-31T22:59:08.549Z,1680303548.549 [Reporter](INFO): platform_buoyancy_position 508.969696 cc 2023-03-31T22:59:08.979Z,1680303548.979 [Reporter](INFO): platform_buoyancy_position 515.550476 cc 2023-03-31T22:59:09.354Z,1680303549.354 [Reporter](INFO): platform_buoyancy_position 519.713745 cc 2023-03-31T22:59:09.777Z,1680303549.777 [Reporter](INFO): platform_buoyancy_position 526.160156 cc 2023-03-31T22:59:10.157Z,1680303550.157 [Reporter](INFO): platform_buoyancy_position 530.457764 cc 2023-03-31T22:59:10.575Z,1680303550.575 [Reporter](INFO): platform_buoyancy_position 537.038452 cc 2023-03-31T22:59:11.002Z,1680303551.002 [Reporter](INFO): platform_buoyancy_position 541.336060 cc 2023-03-31T22:59:11.376Z,1680303551.376 [Reporter](INFO): platform_buoyancy_position 545.633667 cc 2023-03-31T22:59:11.774Z,1680303551.774 [Reporter](INFO): platform_buoyancy_position 551.945740 cc 2023-03-31T22:59:12.162Z,1680303552.162 [Reporter](INFO): platform_buoyancy_position 556.377686 cc 2023-03-31T22:59:12.576Z,1680303552.576 [Reporter](INFO): platform_buoyancy_position 562.689758 cc 2023-03-31T22:59:12.978Z,1680303552.978 [Reporter](INFO): platform_buoyancy_position 567.121643 cc 2023-03-31T22:59:13.391Z,1680303553.391 [Reporter](INFO): platform_buoyancy_position 573.433777 cc 2023-03-31T22:59:13.782Z,1680303553.782 [Reporter](INFO): platform_buoyancy_position 577.865662 cc 2023-03-31T22:59:14.218Z,1680303554.218 [Reporter](INFO): platform_buoyancy_position 584.177734 cc 2023-03-31T22:59:14.599Z,1680303554.599 [Reporter](INFO): platform_buoyancy_position 588.475342 cc 2023-03-31T22:59:15.010Z,1680303555.010 [Reporter](INFO): platform_buoyancy_position 593.310181 cc 2023-03-31T22:59:15.386Z,1680303555.386 [Reporter](INFO): platform_buoyancy_position 599.219360 cc 2023-03-31T22:59:15.810Z,1680303555.810 [Reporter](INFO): platform_buoyancy_position 603.516968 cc 2023-03-31T22:59:16.218Z,1680303556.218 [Reporter](INFO): platform_buoyancy_position 609.963379 cc 2023-03-31T22:59:16.602Z,1680303556.602 [Reporter](INFO): platform_buoyancy_position 614.395264 cc 2023-03-31T22:59:17.010Z,1680303557.010 [Reporter](INFO): platform_buoyancy_position 620.707336 cc 2023-03-31T22:59:17.422Z,1680303557.422 [Reporter](INFO): platform_buoyancy_position 625.139282 cc 2023-03-31T22:59:17.831Z,1680303557.831 [Reporter](INFO): platform_buoyancy_position 631.317078 cc 2023-03-31T22:59:18.222Z,1680303558.222 [Reporter](INFO): platform_buoyancy_position 635.748962 cc 2023-03-31T22:59:18.641Z,1680303558.641 [Reporter](INFO): platform_buoyancy_position 642.195374 cc 2023-03-31T22:59:19.045Z,1680303559.045 [Reporter](INFO): platform_buoyancy_position 646.492981 cc 2023-03-31T22:59:19.458Z,1680303559.458 [Reporter](INFO): platform_buoyancy_position 652.805054 cc 2023-03-31T22:59:19.834Z,1680303559.834 [Reporter](INFO): platform_buoyancy_position 657.371277 cc 2023-03-31T22:59:20.251Z,1680303560.251 [Reporter](INFO): platform_buoyancy_position 663.683350 cc 2023-03-31T22:59:20.670Z,1680303560.670 [Reporter](INFO): platform_buoyancy_position 668.115234 cc 2023-03-31T22:59:21.076Z,1680303561.076 [Reporter](INFO): platform_buoyancy_position 674.427368 cc 2023-03-31T22:59:21.446Z,1680303561.446 [Reporter](INFO): platform_buoyancy_position 678.724976 cc 2023-03-31T22:59:21.870Z,1680303561.870 [Reporter](INFO): platform_buoyancy_position 685.171387 cc 2023-03-31T22:59:22.283Z,1680303562.283 [Reporter](INFO): platform_buoyancy_position 689.603271 cc 2023-03-31T22:59:22.659Z,1680303562.659 [Reporter](INFO): platform_buoyancy_position 693.900879 cc 2023-03-31T22:59:23.080Z,1680303563.080 [Reporter](INFO): platform_buoyancy_position 700.347290 cc 2023-03-31T22:59:23.501Z,1680303563.501 [Reporter](INFO): platform_buoyancy_position 704.644836 cc 2023-03-31T22:59:23.866Z,1680303563.866 [Reporter](INFO): platform_buoyancy_position 710.956970 cc 2023-03-31T22:59:24.297Z,1680303564.297 [Reporter](INFO): platform_buoyancy_position 715.388855 cc 2023-03-31T22:59:24.698Z,1680303564.698 [Reporter](INFO): platform_buoyancy_position 721.835266 cc 2023-03-31T22:59:25.089Z,1680303565.089 [Reporter](INFO): platform_buoyancy_position 726.132874 cc 2023-03-31T22:59:25.502Z,1680303565.502 [Reporter](INFO): platform_buoyancy_position 732.444946 cc 2023-03-31T22:59:25.929Z,1680303565.929 [Reporter](INFO): platform_buoyancy_position 736.742554 cc 2023-03-31T22:59:26.298Z,1680303566.298 [Reporter](INFO): platform_buoyancy_position 741.174500 cc 2023-03-31T22:59:26.706Z,1680303566.706 [Reporter](INFO): platform_buoyancy_position 747.620850 cc 2023-03-31T22:59:27.131Z,1680303567.131 [Reporter](INFO): platform_buoyancy_position 753.664368 cc 2023-03-31T22:59:27.538Z,1680303567.538 [Reporter](INFO): platform_buoyancy_position 758.230591 cc 2023-03-31T22:59:27.918Z,1680303567.918 [Reporter](INFO): platform_buoyancy_position 762.528198 cc 2023-03-31T22:59:28.333Z,1680303568.333 [Reporter](INFO): platform_buoyancy_position 766.960083 cc 2023-03-31T22:59:28.738Z,1680303568.738 [Reporter](INFO): platform_buoyancy_position 773.406494 cc 2023-03-31T22:59:29.177Z,1680303569.177 [Reporter](INFO): platform_buoyancy_position 779.584290 cc 2023-03-31T22:59:29.526Z,1680303569.526 [Reporter](INFO): platform_buoyancy_position 784.016174 cc 2023-03-31T22:59:29.934Z,1680303569.934 [Reporter](INFO): platform_buoyancy_position 790.462585 cc 2023-03-31T22:59:30.354Z,1680303570.354 [Reporter](INFO): platform_buoyancy_position 794.894470 cc 2023-03-31T22:59:30.762Z,1680303570.762 [Reporter](INFO): platform_buoyancy_position 801.340881 cc 2023-03-31T22:59:31.146Z,1680303571.146 [Reporter](INFO): platform_buoyancy_position 805.638489 cc 2023-03-31T22:59:31.550Z,1680303571.550 [Reporter](INFO): platform_buoyancy_position 810.070374 cc 2023-03-31T22:59:31.970Z,1680303571.970 [Reporter](INFO): platform_buoyancy_position 816.382446 cc 2023-03-31T22:59:32.375Z,1680303572.375 [Reporter](INFO): platform_buoyancy_position 822.560303 cc 2023-03-31T22:59:32.766Z,1680303572.766 [Reporter](INFO): platform_buoyancy_position 826.992188 cc 2023-03-31T22:59:33.174Z,1680303573.174 [Reporter](INFO): platform_buoyancy_position 831.424072 cc 2023-03-31T22:59:33.582Z,1680303573.582 [Reporter](INFO): platform_buoyancy_position 837.736206 cc 2023-03-31T22:59:33.998Z,1680303573.998 [Reporter](INFO): platform_buoyancy_position 842.302368 cc 2023-03-31T22:59:34.406Z,1680303574.406 [Reporter](INFO): platform_buoyancy_position 848.614502 cc 2023-03-31T22:59:34.779Z,1680303574.779 [Reporter](INFO): platform_buoyancy_position 853.314941 cc 2023-03-31T22:59:35.203Z,1680303575.203 [Reporter](INFO): platform_buoyancy_position 859.224121 cc 2023-03-31T22:59:35.620Z,1680303575.620 [Reporter](INFO): platform_buoyancy_position 863.656128 cc 2023-03-31T22:59:35.995Z,1680303575.995 [Reporter](INFO): platform_buoyancy_position 869.833862 cc 2023-03-31T22:59:36.414Z,1680303576.414 [Reporter](INFO): platform_buoyancy_position 874.265747 cc 2023-03-31T22:59:36.833Z,1680303576.833 [Reporter](INFO): platform_buoyancy_position 880.846436 cc 2023-03-31T22:59:37.202Z,1680303577.202 [Reporter](INFO): platform_buoyancy_position 885.144043 cc 2023-03-31T22:59:37.606Z,1680303577.606 [Reporter](INFO): platform_buoyancy_position 890.918945 cc 2023-03-31T22:59:38.038Z,1680303578.038 [Reporter](INFO): platform_buoyancy_position 895.753784 cc 2023-03-31T22:59:38.431Z,1680303578.431 [Reporter](INFO): platform_buoyancy_position 902.200195 cc 2023-03-31T22:59:38.826Z,1680303578.826 [Reporter](INFO): platform_buoyancy_position 906.632080 cc 2023-03-31T22:59:39.238Z,1680303579.238 [Reporter](INFO): platform_buoyancy_position 912.809937 cc 2023-03-31T22:59:39.654Z,1680303579.654 [Reporter](INFO): platform_buoyancy_position 917.241821 cc 2023-03-31T22:59:40.062Z,1680303580.062 [Reporter](INFO): platform_buoyancy_position 921.673706 cc 2023-03-31T22:59:40.446Z,1680303580.446 [Reporter](INFO): platform_buoyancy_position 926.239868 cc 2023-03-31T22:59:40.861Z,1680303580.861 [Reporter](INFO): platform_buoyancy_position 932.417725 cc 2023-03-31T22:59:41.274Z,1680303581.274 [Reporter](INFO): platform_buoyancy_position 936.715332 cc 2023-03-31T22:59:41.702Z,1680303581.702 [Reporter](INFO): platform_buoyancy_position 943.027344 cc 2023-03-31T22:59:42.078Z,1680303582.078 [Reporter](INFO): platform_buoyancy_position 947.459229 cc 2023-03-31T23:02:20.037Z,1680303740.037 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-03-31T23:02:20.037Z,1680303740.037 [Default:CheckIn:C.Wait] Stopped 2023-03-31T23:02:20.037Z,1680303740.037 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-03-31T23:02:20.037Z,1680303740.037 [Default:CheckIn:D] Running Loop=1 2023-03-31T23:02:20.447Z,1680303740.447 [Default:CheckIn:D] Stopped 2023-03-31T23:02:20.447Z,1680303740.447 [Default:CheckIn:E] Running Loop=1 2023-03-31T23:02:20.839Z,1680303740.839 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 81.142074 min 2023-03-31T23:02:20.839Z,1680303740.839 [Default:CheckIn:E] Stopped 2023-03-31T23:02:20.840Z,1680303740.840 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-03-31T23:02:20.840Z,1680303740.840 [Default:CheckIn] Stopped 2023-03-31T23:02:20.840Z,1680303740.840 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-03-31T23:02:20.840Z,1680303740.840 [Default:CheckIn](INFO): Running loop #7 2023-03-31T23:02:20.840Z,1680303740.840 [Default:CheckIn] Running Loop=7 2023-03-31T23:02:20.840Z,1680303740.840 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-03-31T23:02:20.840Z,1680303740.840 [Default:CheckIn:Read_GPS] Running Loop=1 2023-03-31T23:02:22.855Z,1680303742.855 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,230221.00,A,3648.16772,N,12147.28544,W,0.233,34.77,310323,,,A*4B 2023-03-31T23:02:22.857Z,1680303742.857 [NAL9602](INFO): GPS fix at 20230331T230221: (36.802795, -121.788091) 2023-03-31T23:02:22.869Z,1680303742.869 [Default:CheckIn:Read_GPS] Stopped 2023-03-31T23:02:22.869Z,1680303742.869 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-03-31T23:02:30.583Z,1680303750.583 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20230331T213634/Courier0022.lzma 2023-03-31T23:02:31.586Z,1680303751.586 [DataOverHttps](INFO): Moved sent file to Logs/20230331T213634/Courier0022.lzma.bak 2023-03-31T23:02:31.586Z,1680303751.586 [DataOverHttps](INFO): SBD MOMSN=17889137 2023-03-31T23:03:05.384Z,1680303785.384 [DataOverHttps](INFO): Sending 602 bytes from file Logs/20230331T213634/Express0023.lzma 2023-03-31T23:03:09.398Z,1680303789.398 [DataOverHttps](INFO): Moved sent file to Logs/20230331T213634/Express0023.lzma.bak 2023-03-31T23:03:09.398Z,1680303789.398 [DataOverHttps](INFO): SBD MOMSN=17889140 2023-03-31T23:03:10.545Z,1680303790.545 [Default:CheckIn:Read_Iridium] Stopped 2023-03-31T23:03:10.545Z,1680303790.545 [Default:CheckIn:C.Wait] Running Loop=1 2023-03-31T23:03:10.546Z,1680303790.546 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-03-31T23:07:25.490Z,1680304045.490 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2023-03-31T23:07:56.189Z,1680304076.189 [NAL9602](INFO): Not Powering down - fast GPS 2023-03-31T23:08:11.160Z,1680304091.160 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-03-31T23:08:11.160Z,1680304091.160 [Default:CheckIn:C.Wait] Stopped 2023-03-31T23:08:11.160Z,1680304091.160 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-03-31T23:08:11.160Z,1680304091.160 [Default:CheckIn:D] Running Loop=1 2023-03-31T23:08:11.558Z,1680304091.558 [Default:CheckIn:D] Stopped 2023-03-31T23:08:11.558Z,1680304091.558 [Default:CheckIn:E] Running Loop=1 2023-03-31T23:08:11.955Z,1680304091.955 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 86.993913 min 2023-03-31T23:08:11.956Z,1680304091.956 [Default:CheckIn:E] Stopped 2023-03-31T23:08:11.956Z,1680304091.956 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-03-31T23:08:11.956Z,1680304091.956 [Default:CheckIn] Stopped 2023-03-31T23:08:11.956Z,1680304091.956 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-03-31T23:08:11.956Z,1680304091.956 [Default:CheckIn](INFO): Running loop #8 2023-03-31T23:08:11.956Z,1680304091.956 [Default:CheckIn] Running Loop=8 2023-03-31T23:08:11.956Z,1680304091.956 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-03-31T23:08:11.956Z,1680304091.956 [Default:CheckIn:Read_GPS] Running Loop=1 2023-03-31T23:08:13.967Z,1680304093.967 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,230812.00,A,3648.16730,N,12147.29418,W,1.438,0.00,310323,,,A*75 2023-03-31T23:08:13.969Z,1680304093.969 [NAL9602](INFO): GPS fix at 20230331T230812: (36.802788, -121.788236) 2023-03-31T23:08:14.003Z,1680304094.003 [Default:CheckIn:Read_GPS] Stopped 2023-03-31T23:08:14.003Z,1680304094.003 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-03-31T23:08:21.787Z,1680304101.787 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20230331T213634/Courier0025.lzma 2023-03-31T23:08:22.790Z,1680304102.790 [DataOverHttps](INFO): Moved sent file to Logs/20230331T213634/Courier0025.lzma.bak 2023-03-31T23:08:22.790Z,1680304102.790 [DataOverHttps](INFO): SBD MOMSN=17889163 2023-03-31T23:08:41.453Z,1680304121.453 [DataOverHttps](INFO): Sending 207 bytes from file Logs/20230331T213634/Express0026.lzma 2023-03-31T23:08:42.454Z,1680304122.454 [DataOverHttps](INFO): Moved sent file to Logs/20230331T213634/Express0026.lzma.bak 2023-03-31T23:08:42.454Z,1680304122.454 [DataOverHttps](INFO): SBD MOMSN=17889166 2023-03-31T23:08:43.493Z,1680304123.493 [Default:CheckIn:Read_Iridium] Stopped 2023-03-31T23:08:43.493Z,1680304123.493 [Default:CheckIn:C.Wait] Running Loop=1 2023-03-31T23:08:43.494Z,1680304123.494 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-03-31T23:08:44.668Z,1680304124.668 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2023-03-31T23:08:44.744Z,1680304124.744 [NAL9602](ERROR): received: +CSQ:0 OK 2023-03-31T23:13:16.201Z,1680304396.201 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2023-03-31T23:13:44.086Z,1680304424.086 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-03-31T23:13:44.086Z,1680304424.086 [Default:CheckIn:C.Wait] Stopped 2023-03-31T23:13:44.086Z,1680304424.086 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-03-31T23:13:44.086Z,1680304424.086 [Default:CheckIn:D] Running Loop=1 2023-03-31T23:13:44.506Z,1680304424.506 [Default:CheckIn:D] Stopped 2023-03-31T23:13:44.506Z,1680304424.506 [Default:CheckIn:E] Running Loop=1 2023-03-31T23:13:44.923Z,1680304424.923 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 92.543050 min 2023-03-31T23:13:44.923Z,1680304424.923 [Default:CheckIn:E] Stopped 2023-03-31T23:13:44.923Z,1680304424.923 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-03-31T23:13:44.923Z,1680304424.923 [Default:CheckIn] Stopped 2023-03-31T23:13:44.923Z,1680304424.923 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-03-31T23:13:44.923Z,1680304424.923 [Default:CheckIn](INFO): Running loop #9 2023-03-31T23:13:44.923Z,1680304424.923 [Default:CheckIn] Running Loop=9 2023-03-31T23:13:44.923Z,1680304424.923 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-03-31T23:13:44.923Z,1680304424.923 [Default:CheckIn:Read_GPS] Running Loop=1 2023-03-31T23:18:45.147Z,1680304725.147 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-03-31T23:13:44.9Z 2023-03-31T23:18:45.147Z,1680304725.147 [Default:CheckIn:Read_GPS] Stopped 2023-03-31T23:18:45.147Z,1680304725.147 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-03-31T23:18:52.411Z,1680304732.411 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230331T213634/Courier0028.lzma 2023-03-31T23:18:53.414Z,1680304733.414 [DataOverHttps](INFO): Moved sent file to Logs/20230331T213634/Courier0028.lzma.bak 2023-03-31T23:18:53.414Z,1680304733.414 [DataOverHttps](INFO): SBD MOMSN=17889551 2023-03-31T23:19:09.264Z,1680304749.264 [DataOverHttps](INFO): Sending 205 bytes from file Logs/20230331T213634/Express0029.lzma 2023-03-31T23:19:10.266Z,1680304750.266 [DataOverHttps](INFO): Moved sent file to Logs/20230331T213634/Express0029.lzma.bak 2023-03-31T23:19:10.266Z,1680304750.266 [DataOverHttps](INFO): SBD MOMSN=17889553 2023-03-31T23:19:11.382Z,1680304751.382 [Default:CheckIn:Read_Iridium] Stopped 2023-03-31T23:19:11.382Z,1680304751.382 [Default:CheckIn:C.Wait] Running Loop=1 2023-03-31T23:19:11.382Z,1680304751.382 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-03-31T23:19:16.205Z,1680304756.205 [NAL9602](INFO): Not Powering down - fast GPS 2023-03-31T23:24:11.971Z,1680305051.971 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-03-31T23:24:11.971Z,1680305051.971 [Default:CheckIn:C.Wait] Stopped 2023-03-31T23:24:11.971Z,1680305051.971 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-03-31T23:24:11.971Z,1680305051.971 [Default:CheckIn:D] Running Loop=1 2023-03-31T23:24:12.381Z,1680305052.381 [Default:CheckIn:D] Stopped 2023-03-31T23:24:12.381Z,1680305052.381 [Default:CheckIn:E] Running Loop=1 2023-03-31T23:24:12.784Z,1680305052.784 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 103.007625 min 2023-03-31T23:24:12.785Z,1680305052.785 [Default:CheckIn:E] Stopped 2023-03-31T23:24:12.785Z,1680305052.785 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-03-31T23:24:12.785Z,1680305052.785 [Default:CheckIn] Stopped 2023-03-31T23:24:12.785Z,1680305052.785 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-03-31T23:24:12.785Z,1680305052.785 [Default:CheckIn](INFO): Running loop #10 2023-03-31T23:24:12.785Z,1680305052.785 [Default:CheckIn] Running Loop=10 2023-03-31T23:24:12.785Z,1680305052.785 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-03-31T23:24:12.785Z,1680305052.785 [Default:CheckIn:Read_GPS] Running Loop=1 2023-03-31T23:24:14.386Z,1680305054.386 [NAL9602](FAULT): GPS failed to acquire within timeout. 2023-03-31T23:24:14.386Z,1680305054.386 [NAL9602] Data Fault, FailCount= 3 2023-03-31T23:24:14.387Z,1680305054.387 [NAL9602](ERROR): Data Fault 2023-03-31T23:24:14.409Z,1680305054.409 [CBIT](ERROR): Data Fault in component: NAL9602 2023-03-31T23:24:14.790Z,1680305054.790 [NAL9602](INFO): Powering down 2023-03-31T23:24:15.616Z,1680305055.616 [CBIT](INFO): Clearing failed state for component NAL9602 2023-03-31T23:24:15.616Z,1680305055.616 [NAL9602] No Fault, FailCount= 3 2023-03-31T23:24:45.094Z,1680305085.094 [NAL9602](INFO): Powering up NAL9602 2023-03-31T23:24:55.997Z,1680305095.997 [NAL9602](INFO): NAL9602 initialized 2023-03-31T23:25:21.085Z,1680305121.085 [CommandExec](IMPORTANT): got command quit 2023-03-31T23:25:22.088Z,1680305122.088 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2023-03-31T23:25:22.088Z,1680305122.088 [CommandExec](INFO): Uninitializing the command executive. 2023-03-31T23:25:22.088Z,1680305122.088 [CommandExec](INFO): Uninitializing the command scheduler. 2023-03-31T23:25:22.089Z,1680305122.089 [CommandExec ThreadHandler](INFO): Thread cancelled. 2023-03-31T23:25:22.228Z,1680305122.228 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2023-03-31T23:25:22.228Z,1680305122.228 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2023-03-31T23:25:22.228Z,1680305122.228 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2023-03-31T23:25:22.229Z,1680305122.229 [NavChartDb](INFO): Join timeout helper Thread ID is 3625 2023-03-31T23:25:22.412Z,1680305122.412 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2023-03-31T23:25:22.412Z,1680305122.412 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2023-03-31T23:25:22.432Z,1680305122.432 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2023-03-31T23:25:22.432Z,1680305122.432 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2023-03-31T23:25:22.433Z,1680305122.433 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 3626 2023-03-31T23:25:22.442Z,1680305122.442 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2023-03-31T23:25:22.442Z,1680305122.442 [WetLabsBB2FL](INFO): Powering down 2023-03-31T23:25:22.443Z,1680305122.443 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2023-03-31T23:25:22.455Z,1680305122.455 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2023-03-31T23:25:22.455Z,1680305122.455 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2023-03-31T23:25:22.455Z,1680305122.455 [CTD_Seabird](INFO): Join timeout helper Thread ID is 3627 2023-03-31T23:25:22.500Z,1680305122.500 [CTD_Seabird](INFO): Powering down 2023-03-31T23:25:22.512Z,1680305122.512 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2023-03-31T23:25:22.513Z,1680305122.513 [CTD_Seabird](INFO): Powering down 2023-03-31T23:25:22.524Z,1680305122.524 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2023-03-31T23:25:22.528Z,1680305122.528 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2023-03-31T23:25:22.528Z,1680305122.528 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2023-03-31T23:25:22.529Z,1680305122.529 [Radio_Surface](INFO): Join timeout helper Thread ID is 3628 2023-03-31T23:25:22.905Z,1680305122.905 [Radio_Surface](INFO): Powering down 2023-03-31T23:25:22.905Z,1680305122.905 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2023-03-31T23:25:22.906Z,1680305122.906 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2023-03-31T23:25:22.916Z,1680305122.916 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2023-03-31T23:25:22.916Z,1680305122.916 [Onboard ThreadHandler](INFO): Thread cancelled. 2023-03-31T23:25:22.916Z,1680305122.916 [Onboard](INFO): Join timeout helper Thread ID is 3629 2023-03-31T23:25:22.924Z,1680305122.924 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2023-03-31T23:25:25.501Z,1680305125.501 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2023-03-31T23:25:25.501Z,1680305125.501 [Onboard ThreadHandler](INFO): Thread cancelled. 2023-03-31T23:25:25.509Z,1680305125.509 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2023-03-31T23:25:25.509Z,1680305125.509 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2023-03-31T23:25:25.509Z,1680305125.509 [DataOverHttps](INFO): Join timeout helper Thread ID is 3630 2023-03-31T23:25:25.936Z,1680305125.936 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2023-03-31T23:25:25.936Z,1680305125.936 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2023-03-31T23:25:25.949Z,1680305125.949 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2023-03-31T23:25:25.949Z,1680305125.949 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2023-03-31T23:25:25.949Z,1680305125.949 [BackseatComponent](INFO): Join timeout helper Thread ID is 3631 2023-03-31T23:25:25.950Z,1680305125.950 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2023-03-31T23:25:25.950Z,1680305125.950 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2023-03-31T23:25:25.957Z,1680305125.957 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2023-03-31T23:25:25.957Z,1680305125.957 [logger ThreadHandler](INFO): Thread cancelled. 2023-03-31T23:25:25.957Z,1680305125.957 [logger](INFO): Join timeout helper Thread ID is 3632 2023-03-31T23:25:25.996Z,1680305125.996 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2023-03-31T23:25:25.996Z,1680305125.996 [logger ThreadHandler](INFO): Thread cancelled. 2023-03-31T23:25:26.001Z,1680305126.001 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2023-03-31T23:25:26.001Z,1680305126.001 [CommandLine ThreadHandler](INFO): Thread cancelled. 2023-03-31T23:25:26.001Z,1680305126.001 [CommandLine](INFO): Join timeout helper Thread ID is 3633 2023-03-31T23:25:26.092Z,1680305126.092 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2023-03-31T23:25:26.092Z,1680305126.092 [CommandLine ThreadHandler](INFO): Thread cancelled. 2023-03-31T23:25:26.101Z,1680305126.101 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2023-03-31T23:25:26.101Z,1680305126.101 [CommandExec ThreadHandler](INFO): Thread cancelled. 2023-03-31T23:25:26.101Z,1680305126.101 [CommandExec](INFO): Join timeout helper Thread ID is 3634 2023-03-31T23:25:26.102Z,1680305126.102 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2023-03-31T23:25:26.102Z,1680305126.102 [controlThread ThreadHandler](INFO): Thread cancelled. 2023-03-31T23:25:26.103Z,1680305126.103 [controlThread](INFO): Join timeout helper Thread ID is 3635 2023-03-31T23:25:26.280Z,1680305126.280 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2023-03-31T23:25:26.280Z,1680305126.280 [controlThread](DEBUG): Uninitializing ControlThread 2023-03-31T23:25:26.281Z,1680305126.281 [AHRS_M2](INFO): Powering down 2023-03-31T23:25:26.353Z,1680305126.353 [MultiRay](INFO): Powering down. 2023-03-31T23:25:26.354Z,1680305126.354 [NAL9602](INFO): Powering down 2023-03-31T23:25:26.355Z,1680305126.355 [Waterlinked](INFO): Powering down 2023-03-31T23:25:26.357Z,1680305126.357 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2023-03-31T23:25:26.358Z,1680305126.358 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2023-03-31T23:25:26.358Z,1680305126.358 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2023-03-31T23:25:26.359Z,1680305126.359 [MissionManager](INFO): Uninitializing Mission Default 2023-03-31T23:25:26.359Z,1680305126.359 [Default] Stopped 2023-03-31T23:25:26.359Z,1680305126.359 [Default](DEBUG): Aggregate::uninitialize Default 2023-03-31T23:25:26.359Z,1680305126.359 [Default:B.GoToSurface] Stopped 2023-03-31T23:25:26.359Z,1680305126.359 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2023-03-31T23:25:26.359Z,1680305126.359 [Default:CheckIn] Stopped 2023-03-31T23:25:26.359Z,1680305126.359 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-03-31T23:25:26.359Z,1680305126.359 [Default:CheckIn:Read_GPS] Stopped 2023-03-31T23:25:26.362Z,1680305126.362 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2023-03-31T23:25:26.362Z,1680305126.362 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2023-03-31T23:25:26.363Z,1680305126.363 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2023-03-31T23:25:26.363Z,1680305126.363 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2023-03-31T23:25:26.363Z,1680305126.363 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2023-03-31T23:25:26.364Z,1680305126.364 [BuoyancyServo](INFO): Powering down 2023-03-31T23:25:26.376Z,1680305126.376 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2023-03-31T23:25:26.376Z,1680305126.376 [ElevatorServo](INFO): Powering down 2023-03-31T23:25:26.377Z,1680305126.377 [MassServo](DEBUG): Uninitialize Mass Servo. 2023-03-31T23:25:26.377Z,1680305126.377 [MassServo](INFO): Powering down 2023-03-31T23:25:26.378Z,1680305126.378 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2023-03-31T23:25:26.378Z,1680305126.378 [RudderServo](INFO): Powering down 2023-03-31T23:25:26.379Z,1680305126.379 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2023-03-31T23:25:26.379Z,1680305126.379 [ThrusterHE](INFO): Powering down 2023-03-31T23:25:26.380Z,1680305126.380 [SBIT](DEBUG): Uninitialize SBIT Component. 2023-03-31T23:25:26.381Z,1680305126.381 [IBIT](DEBUG): Uninitialize IBIT Component. 2023-03-31T23:25:26.381Z,1680305126.381 [CBIT](DEBUG): Uninitialize CBIT Component. 2023-03-31T23:25:26.381Z,1680305126.381 [CBIT](DEBUG): Powering off loads. 2023-03-31T23:25:26.392Z,1680305126.392 [CBIT](DEBUG): Disabling WDT. 2023-03-31T23:25:26.404Z,1680305126.404 [CBIT](DEBUG): Opening all GF detection circuits. 2023-03-31T23:25:26.405Z,1680305126.405 [controlThread ThreadHandler](INFO): Thread cancelled. 2023-03-31T23:25:26.445Z,1680305126.445 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2023-03-31T23:25:26.449Z,1680305126.449 [Onboard ThreadHandler](INFO): Thread cancelled. 2023-03-31T23:25:26.456Z,1680305126.456 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2023-03-31T23:25:26.499Z,1680305126.499 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2023-03-31T23:25:26.558Z,1680305126.558 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2023-03-31T23:25:26.561Z,1680305126.561 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2023-03-31T23:25:26.627Z,1680305126.627 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2023-03-31T23:25:26.671Z,1680305126.671 [logger ThreadHandler](INFO): Thread cancelled.