2024-02-14T00:31:34.223Z,1707870694.223 [Supervisor](DEBUG): Initializing supervisor. 2024-02-14T00:31:34.227Z,1707870694.227 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2024-02-14T00:31:34.228Z,1707870694.228 [SyncHandler](INFO): Protected caller Thread ID is 839 2024-02-14T00:31:34.228Z,1707870694.228 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2024-02-14T00:31:34.229Z,1707870694.229 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2024-02-14T00:31:34.229Z,1707870694.229 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 840 2024-02-14T00:31:34.233Z,1707870694.233 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2024-02-14T00:31:34.251Z,1707870694.251 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2024-02-14T00:31:34.252Z,1707870694.252 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2024-02-14T00:31:34.252Z,1707870694.252 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 841 2024-02-14T00:31:34.256Z,1707870694.256 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2024-02-14T00:31:34.257Z,1707870694.257 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2024-02-14T00:31:34.258Z,1707870694.258 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 842 2024-02-14T00:31:34.260Z,1707870694.260 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2024-02-14T00:31:34.261Z,1707870694.261 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2024-02-14T00:31:34.261Z,1707870694.261 [logger ThreadHandler](INFO): Protected caller Thread ID is 843 2024-02-14T00:31:34.265Z,1707870694.265 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2024-02-14T00:31:34.265Z,1707870694.265 [Supervisor](INFO): Looking for Config files in directory: Config/ 2024-02-14T00:31:34.269Z,1707870694.269 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2024-02-14T00:31:34.489Z,1707870694.489 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2024-02-14T00:31:34.491Z,1707870694.491 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2024-02-14T00:31:34.599Z,1707870694.599 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2024-02-14T00:31:34.601Z,1707870694.601 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2024-02-14T00:31:34.697Z,1707870694.697 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2024-02-14T00:31:34.699Z,1707870694.699 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2024-02-14T00:31:35.175Z,1707870695.175 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2024-02-14T00:31:35.177Z,1707870695.177 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2024-02-14T00:31:35.524Z,1707870695.524 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2024-02-14T00:31:35.526Z,1707870695.526 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2024-02-14T00:31:35.856Z,1707870695.856 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2024-02-14T00:31:35.857Z,1707870695.857 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2024-02-14T00:31:36.048Z,1707870696.048 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2024-02-14T00:31:36.049Z,1707870696.049 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2024-02-14T00:31:36.130Z,1707870696.130 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2024-02-14T00:31:36.212Z,1707870696.212 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2024-02-14T00:31:36.614Z,1707870696.614 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2024-02-14T00:31:36.615Z,1707870696.615 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2024-02-14T00:31:36.900Z,1707870696.900 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2024-02-14T00:31:36.900Z,1707870696.900 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2024-02-14T00:31:37.415Z,1707870697.415 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2024-02-14T00:31:38.164Z,1707870698.164 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2024-02-14T00:31:38.506Z,1707870698.506 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2024-02-14T00:31:38.507Z,1707870698.507 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2024-02-14T00:31:38.748Z,1707870698.748 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2024-02-14T00:31:38.749Z,1707870698.749 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2024-02-14T00:31:38.890Z,1707870698.890 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2024-02-14T00:31:38.891Z,1707870698.891 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2024-02-14T00:31:39.720Z,1707870699.720 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2024-02-14T00:31:39.722Z,1707870699.722 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-galene/ 2024-02-14T00:31:39.724Z,1707870699.724 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/secure.cfg 2024-02-14T00:31:39.808Z,1707870699.808 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/vehicle.cfg 2024-02-14T00:31:39.939Z,1707870699.939 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Battery.cfg 2024-02-14T00:31:40.206Z,1707870700.206 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2024-02-14T00:31:40.208Z,1707870700.208 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Science.cfg 2024-02-14T00:31:40.331Z,1707870700.331 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Control.cfg 2024-02-14T00:31:40.431Z,1707870700.431 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/logger.cfg 2024-02-14T00:31:40.525Z,1707870700.525 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Servo.cfg 2024-02-14T00:31:40.632Z,1707870700.632 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Navigation.cfg 2024-02-14T00:31:40.726Z,1707870700.726 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Simulator.cfg 2024-02-14T00:31:40.812Z,1707870700.812 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/BIT.cfg 2024-02-14T00:31:40.913Z,1707870700.913 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/workSite.cfg 2024-02-14T00:31:40.997Z,1707870700.997 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Sensor.cfg 2024-02-14T00:31:41.160Z,1707870701.160 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg 2024-02-14T00:31:41.175Z,1707870701.175 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2024-02-14T00:31:41.246Z,1707870701.246 [DepthRateCalculator] Loaded 2024-02-14T00:31:41.246Z,1707870701.246 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2024-02-14T00:31:41.252Z,1707870701.252 [PitchRateCalculator] Loaded 2024-02-14T00:31:41.252Z,1707870701.252 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2024-02-14T00:31:41.263Z,1707870701.263 [SpeedCalculator] Loaded 2024-02-14T00:31:41.263Z,1707870701.263 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2024-02-14T00:31:41.268Z,1707870701.268 [YawRateCalculator] Loaded 2024-02-14T00:31:41.268Z,1707870701.268 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2024-02-14T00:31:41.290Z,1707870701.290 [ElevatorOffsetCalculator] Loaded 2024-02-14T00:31:41.290Z,1707870701.290 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2024-02-14T00:31:41.291Z,1707870701.291 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2024-02-14T00:31:41.291Z,1707870701.291 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2024-02-14T00:31:41.335Z,1707870701.335 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2024-02-14T00:31:41.335Z,1707870701.335 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2024-02-14T00:31:41.351Z,1707870701.351 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2024-02-14T00:31:41.351Z,1707870701.351 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2024-02-14T00:31:42.124Z,1707870702.124 [AHRS_M2] Loaded 2024-02-14T00:31:42.124Z,1707870702.124 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2024-02-14T00:31:42.381Z,1707870702.381 [BackseatComponent] Loaded 2024-02-14T00:31:42.381Z,1707870702.381 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2024-02-14T00:31:42.383Z,1707870702.383 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 4084F4E0 2024-02-14T00:31:42.383Z,1707870702.383 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 928 2024-02-14T00:31:42.386Z,1707870702.386 [LcmUniversalReporter] Loaded 2024-02-14T00:31:42.386Z,1707870702.386 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread. 2024-02-14T00:31:43.875Z,1707870703.875 [BPC1] Loaded 2024-02-14T00:31:43.876Z,1707870703.876 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2024-02-14T00:31:44.019Z,1707870704.019 [DataOverHttps] Loaded 2024-02-14T00:31:44.020Z,1707870704.020 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2024-02-14T00:31:44.021Z,1707870704.021 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 4087F4E0 2024-02-14T00:31:44.021Z,1707870704.021 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 929 2024-02-14T00:31:44.042Z,1707870704.042 [Depth_Keller] Loaded 2024-02-14T00:31:44.042Z,1707870704.042 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2024-02-14T00:31:44.047Z,1707870704.047 [DropWeight] Loaded 2024-02-14T00:31:44.047Z,1707870704.047 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2024-02-14T00:31:44.065Z,1707870704.065 [MultiRay] Loaded 2024-02-14T00:31:44.066Z,1707870704.066 [ComponentRegistry](DEBUG): SyncComponent "MultiRay" handled in the control thread. 2024-02-14T00:31:44.170Z,1707870704.170 [NAL9602] Loaded 2024-02-14T00:31:44.170Z,1707870704.170 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2024-02-14T00:31:44.200Z,1707870704.200 [Onboard] Loaded 2024-02-14T00:31:44.200Z,1707870704.200 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2024-02-14T00:31:44.201Z,1707870704.201 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 408AF4E0 2024-02-14T00:31:44.201Z,1707870704.201 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 931 2024-02-14T00:31:44.207Z,1707870704.207 [PowerOnly](INFO): Adding load control power supply at /dev/loadC3 2024-02-14T00:31:44.219Z,1707870704.219 [PowerOnly] Loaded 2024-02-14T00:31:44.219Z,1707870704.219 [ComponentRegistry](DEBUG): SyncComponent "PowerOnly" handled in the control thread. 2024-02-14T00:31:44.231Z,1707870704.231 [Power24vConverter] Loaded 2024-02-14T00:31:44.231Z,1707870704.231 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2024-02-14T00:31:44.245Z,1707870704.245 [Radio_Surface] Loaded 2024-02-14T00:31:44.245Z,1707870704.245 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2024-02-14T00:31:44.246Z,1707870704.246 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 408DF4E0 2024-02-14T00:31:44.247Z,1707870704.247 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 932 2024-02-14T00:31:44.248Z,1707870704.248 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2024-02-14T00:31:44.248Z,1707870704.248 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2024-02-14T00:31:44.386Z,1707870704.386 [DeadReckonUsingMultipleVelocitySources] Loaded 2024-02-14T00:31:44.386Z,1707870704.386 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2024-02-14T00:31:44.428Z,1707870704.428 [DeadReckonUsingSpeedCalculator] Loaded 2024-02-14T00:31:44.429Z,1707870704.429 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread. 2024-02-14T00:31:44.443Z,1707870704.443 [NavChart] Loaded 2024-02-14T00:31:44.443Z,1707870704.443 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2024-02-14T00:31:44.448Z,1707870704.448 [UniversalFixResidualReporter] Loaded 2024-02-14T00:31:44.449Z,1707870704.449 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2024-02-14T00:31:44.449Z,1707870704.449 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2024-02-14T00:31:44.450Z,1707870704.450 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2024-02-14T00:31:44.620Z,1707870704.620 [SBIT](DEBUG): Construct Startup Built In Test. 2024-02-14T00:31:44.634Z,1707870704.634 [SBIT] Loaded 2024-02-14T00:31:44.635Z,1707870704.635 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2024-02-14T00:31:44.637Z,1707870704.637 [IBIT](DEBUG): Construct Initiated Built In Test. 2024-02-14T00:31:44.650Z,1707870704.650 [IBIT] Loaded 2024-02-14T00:31:44.650Z,1707870704.650 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2024-02-14T00:31:44.656Z,1707870704.656 [CBIT](DEBUG): Construct Continuous Built In Test. 2024-02-14T00:31:44.761Z,1707870704.761 [CBIT] Loaded 2024-02-14T00:31:44.761Z,1707870704.761 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2024-02-14T00:31:44.761Z,1707870704.761 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2024-02-14T00:31:44.762Z,1707870704.762 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2024-02-14T00:31:44.984Z,1707870704.984 [CTD_Seabird] Loaded 2024-02-14T00:31:44.984Z,1707870704.984 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2024-02-14T00:31:44.985Z,1707870704.985 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 409E64E0 2024-02-14T00:31:44.986Z,1707870704.986 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 933 2024-02-14T00:31:45.006Z,1707870705.006 [PAR_Licor] Loaded 2024-02-14T00:31:45.006Z,1707870705.006 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2024-02-14T00:31:45.047Z,1707870705.047 [WetLabsBB2FL] Loaded 2024-02-14T00:31:45.047Z,1707870705.047 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2024-02-14T00:31:45.048Z,1707870705.048 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40A164E0 2024-02-14T00:31:45.049Z,1707870705.049 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 934 2024-02-14T00:31:45.050Z,1707870705.050 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2024-02-14T00:31:45.050Z,1707870705.050 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2024-02-14T00:31:45.212Z,1707870705.212 [BuoyancyServo] Loaded 2024-02-14T00:31:45.212Z,1707870705.212 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2024-02-14T00:31:45.235Z,1707870705.235 [ElevatorServo] Loaded 2024-02-14T00:31:45.235Z,1707870705.235 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2024-02-14T00:31:45.256Z,1707870705.256 [MassServo] Loaded 2024-02-14T00:31:45.257Z,1707870705.257 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2024-02-14T00:31:45.277Z,1707870705.277 [RudderServo] Loaded 2024-02-14T00:31:45.277Z,1707870705.277 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2024-02-14T00:31:45.293Z,1707870705.293 [ThrusterHE] Loaded 2024-02-14T00:31:45.294Z,1707870705.294 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread. 2024-02-14T00:31:45.294Z,1707870705.294 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2024-02-14T00:31:45.295Z,1707870705.295 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2024-02-14T00:31:45.363Z,1707870705.363 [VerticalControl](DEBUG): Construct VerticalControl. 2024-02-14T00:31:45.414Z,1707870705.414 [VerticalControl] Loaded 2024-02-14T00:31:45.415Z,1707870705.415 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2024-02-14T00:31:45.418Z,1707870705.418 [HorizontalControl](DEBUG): Construct HorizontalControl. 2024-02-14T00:31:45.456Z,1707870705.456 [HorizontalControl] Loaded 2024-02-14T00:31:45.456Z,1707870705.456 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2024-02-14T00:31:45.459Z,1707870705.459 [SpeedControl](DEBUG): Construct SpeedControl. 2024-02-14T00:31:45.460Z,1707870705.460 [SpeedControl] Loaded 2024-02-14T00:31:45.460Z,1707870705.460 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2024-02-14T00:31:45.463Z,1707870705.463 [LoopControl](DEBUG): Construct LoopControl. 2024-02-14T00:31:45.464Z,1707870705.464 [LoopControl] Loaded 2024-02-14T00:31:45.464Z,1707870705.464 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2024-02-14T00:31:45.464Z,1707870705.464 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2024-02-14T00:31:45.465Z,1707870705.465 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2024-02-14T00:31:45.608Z,1707870705.608 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2024-02-14T00:31:45.608Z,1707870705.608 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2024-02-14T00:31:45.791Z,1707870705.791 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2024-02-14T00:31:45.792Z,1707870705.792 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2024-02-14T00:31:46.189Z,1707870706.189 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2024-02-14T00:31:46.189Z,1707870706.189 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2024-02-14T00:31:46.273Z,1707870706.273 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2024-02-14T00:31:46.279Z,1707870706.279 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2024-02-14T00:31:46.282Z,1707870706.282 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2024-02-14T00:31:46.293Z,1707870706.293 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2024-02-14T00:31:46.295Z,1707870706.295 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40BE14E0 2024-02-14T00:31:46.295Z,1707870706.295 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 935 2024-02-14T00:31:46.299Z,1707870706.299 [Supervisor](INFO): Main Thread ID is 831 2024-02-14T00:31:46.299Z,1707870706.299 [Supervisor](DEBUG): Running supervisor. 2024-02-14T00:31:46.300Z,1707870706.300 [CommandExec ThreadHandler](INFO): Handler Thread ID is 936 2024-02-14T00:31:46.301Z,1707870706.301 [CommandExec](INFO): Initializing the command executive. 2024-02-14T00:31:46.302Z,1707870706.302 [CommandLine ThreadHandler](INFO): Handler Thread ID is 937 2024-02-14T00:31:46.304Z,1707870706.304 [controlThread ThreadHandler](INFO): Handler Thread ID is 938 2024-02-14T00:31:46.305Z,1707870706.305 [controlThread](DEBUG): Initializing ControlThread 2024-02-14T00:31:46.306Z,1707870706.306 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2024-02-14T00:31:46.306Z,1707870706.306 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2024-02-14T00:31:46.306Z,1707870706.306 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2024-02-14T00:31:46.307Z,1707870706.307 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2024-02-14T00:31:46.307Z,1707870706.307 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2024-02-14T00:31:46.312Z,1707870706.312 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-02-14T00:31:46.313Z,1707870706.313 [NavChart](DEBUG): Initialize NavChart Navigation. 2024-02-14T00:31:46.313Z,1707870706.313 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2024-02-14T00:31:46.314Z,1707870706.314 [SBIT](INFO): Initialize SBIT Component. 2024-02-14T00:31:46.314Z,1707870706.314 [SBIT](IMPORTANT): git: 2024-02-06 2024-02-14T00:31:46.314Z,1707870706.314 [SBIT](INFO): git hash: 45759fb189c1cf26f5343b3c07f985a86883e7e8 2024-02-14T00:31:46.314Z,1707870706.314 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2024-02-14T00:31:46.316Z,1707870706.316 [SBIT](INFO): Kernel Reporting Different Version From Configuration. Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018 Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021 2024-02-14T00:31:46.317Z,1707870706.317 [SBIT](INFO): Beginning SBIT in 48.000000 seconds. 2024-02-14T00:31:46.317Z,1707870706.317 [IBIT](INFO): Initialize IBIT Component. 2024-02-14T00:31:46.318Z,1707870706.318 [CBIT](DEBUG): Initialize CBIT Component. 2024-02-14T00:31:46.319Z,1707870706.319 [logger ThreadHandler](INFO): Handler Thread ID is 939 2024-02-14T00:31:46.329Z,1707870706.329 [CBIT](DEBUG): Initialized mux pins. 2024-02-14T00:31:46.329Z,1707870706.329 [CBIT](DEBUG): Initializing the watchdog timer. 2024-02-14T00:31:46.338Z,1707870706.338 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 940 2024-02-14T00:31:46.349Z,1707870706.349 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 941 2024-02-14T00:31:46.351Z,1707870706.351 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2024-02-14T00:31:46.353Z,1707870706.353 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2024-02-14T00:31:46.354Z,1707870706.354 [CBIT](DEBUG): Initializing heartbeat. 2024-02-14T00:31:46.369Z,1707870706.369 [Onboard ThreadHandler](INFO): Handler Thread ID is 942 2024-02-14T00:31:46.381Z,1707870706.381 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 943 2024-02-14T00:31:46.407Z,1707870706.407 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 944 2024-02-14T00:31:46.407Z,1707870706.407 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2024-02-14T00:31:46.410Z,1707870706.410 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 946 2024-02-14T00:31:46.413Z,1707870706.413 [WetLabsBB2FL](INFO): Powering up 2024-02-14T00:31:46.415Z,1707870706.415 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 948 2024-02-14T00:31:46.422Z,1707870706.422 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2024-02-14T00:31:46.422Z,1707870706.422 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2024-02-14T00:31:46.422Z,1707870706.422 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2024-02-14T00:31:46.422Z,1707870706.422 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2024-02-14T00:31:46.423Z,1707870706.423 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2024-02-14T00:31:46.423Z,1707870706.423 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2024-02-14T00:31:46.423Z,1707870706.423 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2024-02-14T00:31:46.423Z,1707870706.423 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2024-02-14T00:31:46.425Z,1707870706.425 [CBIT](DEBUG): Deactivating GF circuits. 2024-02-14T00:31:46.425Z,1707870706.425 [CBIT](DEBUG): Deactivating emergency mode. 2024-02-14T00:31:46.465Z,1707870706.465 [CBIT](DEBUG): Backplane powered. 2024-02-14T00:31:46.470Z,1707870706.470 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2024-02-14T00:31:46.472Z,1707870706.472 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2024-02-14T00:31:46.473Z,1707870706.473 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2024-02-14T00:31:46.473Z,1707870706.473 [LoopControl](DEBUG): Initialize LoopControlComponent. 2024-02-14T00:31:46.474Z,1707870706.474 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser 2024-02-14T00:31:46.475Z,1707870706.475 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl 2024-02-14T00:31:46.475Z,1707870706.475 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl 2024-02-14T00:31:46.481Z,1707870706.481 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl 2024-02-14T00:31:46.533Z,1707870706.533 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into: 2024-02-14T00:31:46.558Z,1707870706.558 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2024-02-14T00:31:46.568Z,1707870706.568 [MissionManager](DEBUG): mission Startup { behavior Guidance:GoToSurface { run in progression } aggregate StartupSatComms { run in sequence readDatum { timeout duration=P1M Universal:latitude_fix } readDatum { timeout duration=P1M Universal:platform_communications } } } 2024-02-14T00:31:46.581Z,1707870706.581 [MissionManager](INFO): Loading Mission from file: Missions/Default.xml 2024-02-14T00:31:46.631Z,1707870706.631 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2024-02-14T00:31:46.632Z,1707870706.632 [Default:A.Wait](DEBUG): Construct Wait. 2024-02-14T00:31:46.635Z,1707870706.635 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2024-02-14T00:31:46.668Z,1707870706.668 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2024-02-14T00:31:46.671Z,1707870706.671 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2024-02-14T00:31:46.678Z,1707870706.678 [Default:E.Execute](DEBUG): Construct Execute. 2024-02-14T00:31:46.681Z,1707870706.681 [MissionManager](DEBUG): 0 Wait a moment to see if the scheduler starts a new mission before starting to actually run Default. 13 Burn on Dropped weight due to communications timeout. 5 Default mission has been running for Restarting logs and Default mission. restart logs 2024-02-14T00:31:46.709Z,1707870706.709 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,MultiRay,NAL9602,PowerOnly,Power24vConverter,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2024-02-14T00:31:46.716Z,1707870706.716 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2024-02-14T00:31:46.789Z,1707870706.789 [Radio_Surface](INFO): Powering up 2024-02-14T00:31:46.839Z,1707870706.839 [MultiRay](INFO): Powering up MultiRay Lights 2024-02-14T00:31:46.882Z,1707870706.882 [PowerOnly](INFO): Powering up loadControl 2024-02-14T00:31:46.902Z,1707870706.902 [Power24vConverter](INFO): Powering up. 2024-02-14T00:31:46.939Z,1707870706.939 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2024-02-14T00:31:46.945Z,1707870706.945 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2024-02-14T00:31:46.946Z,1707870706.946 [ElevatorServo](DEBUG): Initializing EZServoServo. 2024-02-14T00:31:46.953Z,1707870706.953 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2024-02-14T00:31:46.954Z,1707870706.954 [MassServo](DEBUG): Initializing EZServoServo. 2024-02-14T00:31:46.961Z,1707870706.961 [MassServo](DEBUG): Initializing MassServo. 2024-02-14T00:31:46.962Z,1707870706.962 [RudderServo](DEBUG): Initializing EZServoServo. 2024-02-14T00:31:46.969Z,1707870706.969 [RudderServo](DEBUG): Initializing RudderServo. 2024-02-14T00:31:46.970Z,1707870706.970 [ThrusterHE](DEBUG): Initializing EZServoServo. 2024-02-14T00:31:46.977Z,1707870706.977 [ThrusterHE](DEBUG): Initializing ThrusterHE. 2024-02-14T00:31:49.025Z,1707870709.025 [WetLabsBB2FL](INFO): Powering down 2024-02-14T00:31:52.610Z,1707870712.610 [ThrusterHE](ERROR): Zero Speed Commanded. 2024-02-14T00:32:14.232Z,1707870734.232 [NAL9602](INFO): Powering up NAL9602 2024-02-14T00:32:25.133Z,1707870745.133 [NAL9602](INFO): NAL9602 initialized 2024-02-14T00:32:34.926Z,1707870754.926 [SBIT](IMPORTANT): Beginning Startup BIT 2024-02-14T00:32:34.930Z,1707870754.930 [CBIT](IMPORTANT): Beginning ground fault scan 2024-02-14T00:32:45.825Z,1707870765.825 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): -0.000021 CHAN A1 (24V): 0.000387 CHAN A2 (12V): -0.005229 CHAN A3 (5V): -0.002872 CHAN B0 (3.3V): -0.001202 CHAN B1 (3.15aV): -0.001521 CHAN B2 (3.15bV): -0.001535 CHAN B3 (GND): -0.000721 OPEN: 0.004273 Full Scale: +/- 1 mA 2024-02-14T00:32:58.716Z,1707870778.716 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-02-14T00:33:10.428Z,1707870790.428 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-02-14T00:33:29.066Z,1707870809.066 [SBIT](IMPORTANT): SBIT PASSED 2024-02-14T00:33:29.066Z,1707870809.066 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2024-02-14T00:33:29.067Z,1707870809.067 [SBIT](IMPORTANT): BackseatComponent.missionCritical=0 bool; 2024-02-14T00:33:29.067Z,1707870809.067 [SBIT](IMPORTANT): BuoyancyServo.deviationVolume=2 cubic_centimeter; 2024-02-14T00:33:29.067Z,1707870809.067 [SBIT](IMPORTANT): BuoyancyServo.pidW=3000 count; 2024-02-14T00:33:29.068Z,1707870809.068 [SBIT](IMPORTANT): CBIT.runNavErrorCritical=1 bool; 2024-02-14T00:33:29.068Z,1707870809.068 [SBIT](IMPORTANT): DAT.loadAtStartup=0 bool; 2024-02-14T00:33:29.068Z,1707870809.068 [SBIT](IMPORTANT): MultiRay.loadAtStartup=1 bool; 2024-02-14T00:33:29.068Z,1707870809.068 [SBIT](IMPORTANT): Vehicle.useTlLoader=1 bool; 2024-02-14T00:33:29.068Z,1707870809.068 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=473.280850 cubic_centimeter; 2024-02-14T00:33:29.068Z,1707870809.068 [SBIT](IMPORTANT): VerticalControl.massDeadband=0 centimeter; 2024-02-14T00:33:29.068Z,1707870809.068 [SBIT](IMPORTANT): VerticalControl.massDefault=-7.151472 millimeter; 2024-02-14T00:33:29.405Z,1707870809.405 [MissionManager](IMPORTANT): Started mission Startup 2024-02-14T00:33:29.406Z,1707870809.406 [Startup] Running Loop=1 2024-02-14T00:33:29.406Z,1707870809.406 [Startup](DEBUG): Aggregate::initialize Startup 2024-02-14T00:33:29.406Z,1707870809.406 [Startup:A.GoToSurface] Running Loop=1 2024-02-14T00:33:29.406Z,1707870809.406 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2024-02-14T00:33:29.406Z,1707870809.406 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2024-02-14T00:33:29.407Z,1707870809.407 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2024-02-14T00:33:29.407Z,1707870809.407 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2024-02-14T00:33:29.408Z,1707870809.408 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2024-02-14T00:33:29.408Z,1707870809.408 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2024-02-14T00:33:29.409Z,1707870809.409 [Startup:StartupSatComms] Running Loop=1 2024-02-14T00:33:29.409Z,1707870809.409 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2024-02-14T00:33:29.409Z,1707870809.409 [Startup:StartupSatComms:A] Running Loop=1 2024-02-14T00:33:29.789Z,1707870809.789 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2024-02-14T00:33:46.789Z,1707870826.789 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-02-14T00:34:11.608Z,1707870851.608 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004990 2024-02-14T00:34:29.727Z,1707870869.727 [Startup:StartupSatComms:A](INFO): Timed out from 2024-02-14T00:33:29.4Z 2024-02-14T00:34:29.727Z,1707870869.727 [Startup:StartupSatComms:A] Stopped 2024-02-14T00:34:29.727Z,1707870869.727 [Startup:StartupSatComms:B] Running Loop=1 2024-02-14T00:34:30.126Z,1707870870.126 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2024-02-14T00:34:36.936Z,1707870876.936 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240213T213716/Courier0049.lzma 2024-02-14T00:34:37.937Z,1707870877.937 [DataOverHttps](INFO): Moved sent file to Logs/20240213T213716/Courier0049.lzma.bak 2024-02-14T00:34:37.938Z,1707870877.938 [DataOverHttps](INFO): SBD MOMSN=19277441 2024-02-14T00:34:46.335Z,1707870886.335 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2024-02-14T00:34:46.335Z,1707870886.335 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-02-14T00:34:46.337Z,1707870886.337 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1 2024-02-14T00:34:46.337Z,1707870886.337 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-02-14T00:34:46.429Z,1707870886.429 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-02-14T00:34:46.429Z,1707870886.429 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-02-14T00:34:46.827Z,1707870886.827 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-02-14T00:34:46.827Z,1707870886.827 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2024-02-14T00:34:46.828Z,1707870886.828 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-02-14T00:34:46.828Z,1707870886.828 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1 2024-02-14T00:34:47.152Z,1707870887.152 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-02-14T00:34:53.867Z,1707870893.867 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20240214T003134/Courier0000.lzma 2024-02-14T00:34:54.869Z,1707870894.869 [DataOverHttps](INFO): Moved sent file to Logs/20240214T003134/Courier0000.lzma.bak 2024-02-14T00:34:54.869Z,1707870894.869 [DataOverHttps](INFO): SBD MOMSN=19277443 2024-02-14T00:35:10.888Z,1707870910.888 [DataOverHttps](INFO): Sending 150 bytes from file Logs/20240213T213716/Express0050.lzma 2024-02-14T00:35:11.891Z,1707870911.891 [DataOverHttps](INFO): Moved sent file to Logs/20240213T213716/Express0050.lzma.bak 2024-02-14T00:35:11.892Z,1707870911.892 [DataOverHttps](INFO): SBD MOMSN=19277446 2024-02-14T00:35:27.845Z,1707870927.845 [DataOverHttps](INFO): Sending 823 bytes from file Logs/20240214T003134/Express0001.lzma 2024-02-14T00:35:28.845Z,1707870928.845 [DataOverHttps](INFO): Moved sent file to Logs/20240214T003134/Express0001.lzma.bak 2024-02-14T00:35:28.845Z,1707870928.845 [DataOverHttps](INFO): SBD MOMSN=19277450 2024-02-14T00:35:29.982Z,1707870929.982 [Startup:StartupSatComms:B](INFO): Timed out from 2024-02-14T00:34:29.7Z 2024-02-14T00:35:29.982Z,1707870929.982 [Startup:StartupSatComms:B] Stopped 2024-02-14T00:35:29.983Z,1707870929.983 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2024-02-14T00:35:29.983Z,1707870929.983 [Startup:StartupSatComms] Stopped 2024-02-14T00:35:29.983Z,1707870929.983 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2024-02-14T00:35:29.988Z,1707870929.988 [Startup](INFO): Completed Startup 2024-02-14T00:35:29.988Z,1707870929.988 [MissionManager](INFO): Startup is completed. 2024-02-14T00:35:29.988Z,1707870929.988 [MissionManager](INFO): Uninitializing Mission Startup 2024-02-14T00:35:29.988Z,1707870929.988 [Startup] Stopped 2024-02-14T00:35:29.988Z,1707870929.988 [Startup](DEBUG): Aggregate::uninitialize Startup 2024-02-14T00:35:29.988Z,1707870929.988 [Startup:A.GoToSurface] Stopped 2024-02-14T00:35:29.988Z,1707870929.988 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2024-02-14T00:35:30.370Z,1707870930.370 [MissionManager](IMPORTANT): Started mission Default 2024-02-14T00:35:30.371Z,1707870930.371 [Default] Running Loop=1 2024-02-14T00:35:30.371Z,1707870930.371 [Default](DEBUG): Aggregate::initialize Default 2024-02-14T00:35:30.371Z,1707870930.371 [Default:B.GoToSurface] Running Loop=1 2024-02-14T00:35:30.371Z,1707870930.371 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2024-02-14T00:35:30.371Z,1707870930.371 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2024-02-14T00:35:30.372Z,1707870930.372 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2024-02-14T00:35:30.372Z,1707870930.372 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2024-02-14T00:35:30.372Z,1707870930.372 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2024-02-14T00:35:30.373Z,1707870930.373 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2024-02-14T00:35:30.373Z,1707870930.373 [Default:A.Wait] Running Loop=1 2024-02-14T00:35:30.373Z,1707870930.373 [Default:A.Wait](DEBUG): Initialize Wait Component. 2024-02-14T00:35:43.398Z,1707870943.398 [Default:A.Wait](INFO): Done Waiting. 2024-02-14T00:35:43.398Z,1707870943.398 [Default:A.Wait] Stopped 2024-02-14T00:35:43.398Z,1707870943.398 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2024-02-14T00:35:43.792Z,1707870943.792 [Default:CheckIn] Running Loop=1 2024-02-14T00:35:43.793Z,1707870943.793 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-02-14T00:35:43.793Z,1707870943.793 [Default:CheckIn:Read_GPS] Running Loop=1 2024-02-14T00:35:44.102Z,1707870944.102 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2024-02-14T00:35:44.550Z,1707870944.550 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-02-14T00:36:10.834Z,1707870970.834 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-02-14T00:37:17.873Z,1707871037.873 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-02-14T00:37:29.145Z,1707871049.145 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2024-02-14T00:37:40.085Z,1707871060.085 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-02-14T00:37:47.314Z,1707871067.314 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2024-02-14T00:37:47.314Z,1707871067.314 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-02-14T00:37:47.315Z,1707871067.315 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 2 2024-02-14T00:37:47.315Z,1707871067.315 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-02-14T00:37:47.403Z,1707871067.403 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-02-14T00:37:47.404Z,1707871067.404 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-02-14T00:37:47.811Z,1707871067.811 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-02-14T00:37:47.811Z,1707871067.811 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2024-02-14T00:37:47.812Z,1707871067.812 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-02-14T00:37:47.812Z,1707871067.812 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 2 2024-02-14T00:37:48.162Z,1707871068.162 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-02-14T00:37:57.505Z,1707871077.505 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-02-14T00:38:51.560Z,1707871131.560 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6. 2024-02-14T00:38:51.564Z,1707871131.564 [BPC1](INFO): Received data from all battery sticks. 2024-02-14T00:40:43.870Z,1707871243.870 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-02-14T00:35:43.8Z 2024-02-14T00:40:43.870Z,1707871243.870 [Default:CheckIn:Read_GPS] Stopped 2024-02-14T00:40:43.870Z,1707871243.870 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-02-14T00:40:44.274Z,1707871244.274 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications 2024-02-14T00:40:48.351Z,1707871248.351 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3 2024-02-14T00:40:48.351Z,1707871248.351 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-02-14T00:40:48.372Z,1707871248.372 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 3 2024-02-14T00:40:48.372Z,1707871248.372 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-02-14T00:40:48.452Z,1707871248.452 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-02-14T00:40:48.452Z,1707871248.452 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-02-14T00:40:48.807Z,1707871248.807 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-02-14T00:40:48.807Z,1707871248.807 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3 2024-02-14T00:40:48.808Z,1707871248.808 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-02-14T00:40:48.808Z,1707871248.808 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 3 2024-02-14T00:40:49.151Z,1707871249.151 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-02-14T00:40:51.127Z,1707871251.127 [DataOverHttps](INFO): Sending 168 bytes from file Logs/20240214T003134/Courier0004.lzma 2024-02-14T00:40:52.129Z,1707871252.129 [DataOverHttps](INFO): Moved sent file to Logs/20240214T003134/Courier0004.lzma.bak 2024-02-14T00:40:52.129Z,1707871252.129 [DataOverHttps](INFO): SBD MOMSN=19277472 2024-02-14T00:41:08.212Z,1707871268.212 [DataOverHttps](INFO): Sending 186 bytes from file Logs/20240214T003134/Express0005.lzma 2024-02-14T00:41:09.214Z,1707871269.214 [DataOverHttps](INFO): Moved sent file to Logs/20240214T003134/Express0005.lzma.bak 2024-02-14T00:41:09.214Z,1707871269.214 [DataOverHttps](INFO): SBD MOMSN=19277474 2024-02-14T00:41:10.550Z,1707871270.550 [Default:CheckIn:Read_Iridium] Stopped 2024-02-14T00:41:10.550Z,1707871270.550 [Default:CheckIn:C.Wait] Running Loop=1 2024-02-14T00:41:10.550Z,1707871270.550 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-02-14T00:42:28.093Z,1707871348.093 [NAL9602](FAULT): GPS failed to acquire within timeout. 2024-02-14T00:42:28.093Z,1707871348.093 [NAL9602] Data Fault, FailCount= 1 2024-02-14T00:42:28.093Z,1707871348.093 [NAL9602](ERROR): Data Fault 2024-02-14T00:42:28.172Z,1707871348.172 [CBIT](ERROR): Data Fault in component: NAL9602 2024-02-14T00:42:28.497Z,1707871348.497 [NAL9602](INFO): Powering down 2024-02-14T00:42:29.391Z,1707871349.391 [CBIT](INFO): Clearing failed state for component NAL9602 2024-02-14T00:42:29.391Z,1707871349.391 [NAL9602] No Fault, FailCount= 1 2024-02-14T00:42:58.793Z,1707871378.793 [NAL9602](INFO): Powering up NAL9602 2024-02-14T00:43:09.705Z,1707871389.705 [NAL9602](INFO): NAL9602 initialized 2024-02-14T00:43:49.328Z,1707871429.328 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4 2024-02-14T00:43:49.328Z,1707871429.328 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-02-14T00:43:49.329Z,1707871429.329 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 4 2024-02-14T00:43:49.329Z,1707871429.329 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-02-14T00:43:49.392Z,1707871429.392 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-02-14T00:43:49.392Z,1707871429.392 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-02-14T00:43:49.783Z,1707871429.783 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-02-14T00:43:49.783Z,1707871429.783 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4 2024-02-14T00:43:49.784Z,1707871429.784 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-02-14T00:43:49.784Z,1707871429.784 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 4 2024-02-14T00:43:50.112Z,1707871430.112 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-02-14T00:46:11.110Z,1707871571.110 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-02-14T00:46:11.110Z,1707871571.110 [Default:CheckIn:C.Wait] Stopped 2024-02-14T00:46:11.110Z,1707871571.110 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-02-14T00:46:11.110Z,1707871571.110 [Default:CheckIn:D] Running Loop=1 2024-02-14T00:46:11.530Z,1707871571.530 [Default:CheckIn:D] Stopped 2024-02-14T00:46:11.530Z,1707871571.530 [Default:CheckIn:E] Running Loop=1 2024-02-14T00:46:11.938Z,1707871571.938 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 10.685992 min 2024-02-14T00:46:11.938Z,1707871571.938 [Default:CheckIn:E] Stopped 2024-02-14T00:46:11.938Z,1707871571.938 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-02-14T00:46:11.938Z,1707871571.938 [Default:CheckIn] Stopped 2024-02-14T00:46:11.938Z,1707871571.938 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-02-14T00:46:11.939Z,1707871571.939 [Default:CheckIn](INFO): Running loop #2 2024-02-14T00:46:11.939Z,1707871571.939 [Default:CheckIn] Running Loop=2 2024-02-14T00:46:11.939Z,1707871571.939 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-02-14T00:46:11.939Z,1707871571.939 [Default:CheckIn:Read_GPS] Running Loop=1 2024-02-14T00:46:50.298Z,1707871610.298 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5 2024-02-14T00:46:50.298Z,1707871610.298 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-02-14T00:46:50.299Z,1707871610.299 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 5 2024-02-14T00:46:50.299Z,1707871610.299 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-02-14T00:46:50.364Z,1707871610.364 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-02-14T00:46:50.364Z,1707871610.364 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-02-14T00:46:50.775Z,1707871610.775 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-02-14T00:46:50.776Z,1707871610.776 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5 2024-02-14T00:46:50.776Z,1707871610.776 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-02-14T00:46:50.776Z,1707871610.776 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 5 2024-02-14T00:46:51.128Z,1707871611.128 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-02-14T00:49:51.292Z,1707871791.292 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6 2024-02-14T00:49:51.292Z,1707871791.292 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-02-14T00:49:51.293Z,1707871791.293 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 6 2024-02-14T00:49:51.293Z,1707871791.293 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-02-14T00:49:51.356Z,1707871791.356 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-02-14T00:49:51.356Z,1707871791.356 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-02-14T00:49:51.767Z,1707871791.767 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-02-14T00:49:51.767Z,1707871791.767 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6 2024-02-14T00:49:51.768Z,1707871791.768 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-02-14T00:49:51.768Z,1707871791.768 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 6 2024-02-14T00:49:52.109Z,1707871792.109 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-02-14T00:51:12.094Z,1707871872.094 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-02-14T00:46:11.9Z 2024-02-14T00:51:12.094Z,1707871872.094 [Default:CheckIn:Read_GPS] Stopped 2024-02-14T00:51:12.094Z,1707871872.094 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-02-14T00:51:19.362Z,1707871879.362 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240214T003134/Courier0007.lzma 2024-02-14T00:51:20.365Z,1707871880.365 [DataOverHttps](INFO): Moved sent file to Logs/20240214T003134/Courier0007.lzma.bak 2024-02-14T00:51:20.365Z,1707871880.365 [DataOverHttps](INFO): SBD MOMSN=19277480 2024-02-14T00:51:41.779Z,1707871901.779 [DataOverHttps](INFO): Sending 181 bytes from file Logs/20240214T003134/Express0008.lzma 2024-02-14T00:51:42.781Z,1707871902.781 [DataOverHttps](INFO): Moved sent file to Logs/20240214T003134/Express0008.lzma.bak 2024-02-14T00:51:42.781Z,1707871902.781 [DataOverHttps](INFO): SBD MOMSN=19277485 2024-02-14T00:51:44.094Z,1707871904.094 [Default:CheckIn:Read_Iridium] Stopped 2024-02-14T00:51:44.094Z,1707871904.094 [Default:CheckIn:C.Wait] Running Loop=1 2024-02-14T00:51:44.094Z,1707871904.094 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-02-14T00:52:52.368Z,1707871972.368 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7 2024-02-14T00:52:52.368Z,1707871972.368 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-02-14T00:52:52.369Z,1707871972.369 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 7 2024-02-14T00:52:52.369Z,1707871972.369 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-02-14T00:52:52.439Z,1707871972.439 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-02-14T00:52:52.440Z,1707871972.440 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-02-14T00:52:52.843Z,1707871972.843 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-02-14T00:52:52.843Z,1707871972.843 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7 2024-02-14T00:52:52.844Z,1707871972.844 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-02-14T00:52:52.844Z,1707871972.844 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 7 2024-02-14T00:52:53.172Z,1707871973.172 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-02-14T00:53:10.521Z,1707871990.521 [NAL9602](FAULT): GPS failed to acquire within timeout. 2024-02-14T00:53:10.521Z,1707871990.521 [NAL9602] Data Fault, FailCount= 2 2024-02-14T00:53:10.521Z,1707871990.521 [NAL9602](ERROR): Data Fault 2024-02-14T00:53:10.629Z,1707871990.629 [CBIT](ERROR): Data Fault in component: NAL9602 2024-02-14T00:53:10.925Z,1707871990.925 [NAL9602](INFO): Powering down 2024-02-14T00:53:11.803Z,1707871991.803 [CBIT](INFO): Clearing failed state for component NAL9602 2024-02-14T00:53:11.804Z,1707871991.804 [NAL9602] No Fault, FailCount= 2 2024-02-14T00:53:41.225Z,1707872021.225 [NAL9602](INFO): Powering up NAL9602 2024-02-14T00:53:52.133Z,1707872032.133 [NAL9602](INFO): NAL9602 initialized 2024-02-14T00:55:53.346Z,1707872153.346 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8 2024-02-14T00:55:53.346Z,1707872153.346 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-02-14T00:55:53.347Z,1707872153.347 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 8 2024-02-14T00:55:53.347Z,1707872153.347 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-02-14T00:55:53.411Z,1707872153.411 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-02-14T00:55:53.412Z,1707872153.412 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-02-14T00:55:53.827Z,1707872153.827 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-02-14T00:55:53.827Z,1707872153.827 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8 2024-02-14T00:55:53.828Z,1707872153.828 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-02-14T00:55:53.828Z,1707872153.828 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 8 2024-02-14T00:55:54.145Z,1707872154.145 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-02-14T00:56:44.685Z,1707872204.685 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-02-14T00:56:44.685Z,1707872204.685 [Default:CheckIn:C.Wait] Stopped 2024-02-14T00:56:44.685Z,1707872204.685 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-02-14T00:56:44.685Z,1707872204.685 [Default:CheckIn:D] Running Loop=1 2024-02-14T00:56:45.058Z,1707872205.058 [Default:CheckIn:D] Stopped 2024-02-14T00:56:45.058Z,1707872205.058 [Default:CheckIn:E] Running Loop=1 2024-02-14T00:56:45.466Z,1707872205.466 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 21.244784 min 2024-02-14T00:56:45.466Z,1707872205.466 [Default:CheckIn:E] Stopped 2024-02-14T00:56:45.466Z,1707872205.466 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-02-14T00:56:45.466Z,1707872205.466 [Default:CheckIn] Stopped 2024-02-14T00:56:45.466Z,1707872205.466 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-02-14T00:56:45.466Z,1707872205.466 [Default:CheckIn](INFO): Running loop #3 2024-02-14T00:56:45.466Z,1707872205.466 [Default:CheckIn] Running Loop=3 2024-02-14T00:56:45.466Z,1707872205.466 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-02-14T00:56:45.466Z,1707872205.466 [Default:CheckIn:Read_GPS] Running Loop=1 2024-02-14T00:58:54.359Z,1707872334.359 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 9 2024-02-14T00:58:54.359Z,1707872334.359 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-02-14T00:58:54.361Z,1707872334.361 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 9 2024-02-14T00:58:54.361Z,1707872334.361 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-02-14T00:58:54.455Z,1707872334.455 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-02-14T00:58:54.456Z,1707872334.456 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-02-14T00:58:54.819Z,1707872334.819 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-02-14T00:58:54.820Z,1707872334.820 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 9 2024-02-14T00:58:54.820Z,1707872334.820 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-02-14T00:58:54.820Z,1707872334.820 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 9 2024-02-14T00:58:55.175Z,1707872335.175 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-02-14T01:01:45.674Z,1707872505.674 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-02-14T00:56:45.5Z 2024-02-14T01:01:45.674Z,1707872505.674 [Default:CheckIn:Read_GPS] Stopped 2024-02-14T01:01:45.674Z,1707872505.674 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-02-14T01:01:53.191Z,1707872513.191 [DataOverHttps](INFO): Sending 38 bytes from file Logs/20240214T003134/Courier0010.lzma 2024-02-14T01:01:54.193Z,1707872514.193 [DataOverHttps](INFO): Moved sent file to Logs/20240214T003134/Courier0010.lzma.bak 2024-02-14T01:01:54.193Z,1707872514.193 [DataOverHttps](INFO): SBD MOMSN=19277506 2024-02-14T01:01:55.387Z,1707872515.387 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 10 2024-02-14T01:01:55.388Z,1707872515.388 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-02-14T01:01:55.389Z,1707872515.389 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 10 2024-02-14T01:01:55.389Z,1707872515.389 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-02-14T01:01:55.473Z,1707872515.473 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-02-14T01:01:55.473Z,1707872515.473 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-02-14T01:01:55.837Z,1707872515.837 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-02-14T01:01:55.837Z,1707872515.837 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 10 2024-02-14T01:01:55.838Z,1707872515.838 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-02-14T01:01:55.838Z,1707872515.838 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 10 2024-02-14T01:01:56.168Z,1707872516.168 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-02-14T01:02:10.011Z,1707872530.011 [DataOverHttps](INFO): Sending 150 bytes from file Logs/20240214T003134/Express0011.lzma 2024-02-14T01:02:11.013Z,1707872531.013 [DataOverHttps](INFO): Moved sent file to Logs/20240214T003134/Express0011.lzma.bak 2024-02-14T01:02:11.013Z,1707872531.013 [DataOverHttps](INFO): SBD MOMSN=19277508 2024-02-14T01:02:12.358Z,1707872532.358 [Default:CheckIn:Read_Iridium] Stopped 2024-02-14T01:02:12.358Z,1707872532.358 [Default:CheckIn:C.Wait] Running Loop=1 2024-02-14T01:02:12.358Z,1707872532.358 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-02-14T01:03:54.133Z,1707872634.133 [NAL9602](FAULT): GPS failed to acquire within timeout. 2024-02-14T01:03:54.133Z,1707872634.133 [NAL9602] Data Fault, FailCount= 3 2024-02-14T01:03:54.133Z,1707872634.133 [NAL9602](ERROR): Data Fault 2024-02-14T01:03:54.215Z,1707872634.215 [CBIT](ERROR): Data Fault in component: NAL9602 2024-02-14T01:03:54.543Z,1707872634.543 [NAL9602](INFO): Powering down 2024-02-14T01:03:55.411Z,1707872635.411 [CBIT](INFO): Clearing failed state for component NAL9602 2024-02-14T01:03:55.411Z,1707872635.411 [NAL9602] No Fault, FailCount= 3 2024-02-14T01:04:24.833Z,1707872664.833 [NAL9602](INFO): Powering up NAL9602 2024-02-14T01:04:35.745Z,1707872675.745 [NAL9602](INFO): NAL9602 initialized 2024-02-14T01:04:56.365Z,1707872696.365 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 11 2024-02-14T01:04:56.365Z,1707872696.365 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-02-14T01:04:56.366Z,1707872696.366 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 11 2024-02-14T01:04:56.366Z,1707872696.366 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-02-14T01:04:56.428Z,1707872696.428 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-02-14T01:04:56.428Z,1707872696.428 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-02-14T01:04:56.828Z,1707872696.828 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-02-14T01:04:56.828Z,1707872696.828 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 11 2024-02-14T01:04:56.828Z,1707872696.828 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-02-14T01:04:56.828Z,1707872696.828 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 11 2024-02-14T01:04:57.164Z,1707872697.164 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-02-14T01:07:12.930Z,1707872832.930 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-02-14T01:07:12.930Z,1707872832.930 [Default:CheckIn:C.Wait] Stopped 2024-02-14T01:07:12.930Z,1707872832.930 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-02-14T01:07:12.930Z,1707872832.930 [Default:CheckIn:D] Running Loop=1 2024-02-14T01:07:13.341Z,1707872833.341 [Default:CheckIn:D] Stopped 2024-02-14T01:07:13.341Z,1707872833.341 [Default:CheckIn:E] Running Loop=1 2024-02-14T01:07:13.718Z,1707872833.718 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 31.716174 min 2024-02-14T01:07:13.718Z,1707872833.718 [Default:CheckIn:E] Stopped 2024-02-14T01:07:13.718Z,1707872833.718 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-02-14T01:07:13.718Z,1707872833.718 [Default:CheckIn] Stopped 2024-02-14T01:07:13.718Z,1707872833.718 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-02-14T01:07:13.718Z,1707872833.718 [Default:CheckIn](INFO): Running loop #4 2024-02-14T01:07:13.719Z,1707872833.719 [Default:CheckIn] Running Loop=4 2024-02-14T01:07:13.719Z,1707872833.719 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-02-14T01:07:13.719Z,1707872833.719 [Default:CheckIn:Read_GPS] Running Loop=1 2024-02-14T01:07:57.352Z,1707872877.352 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 12 2024-02-14T01:07:57.352Z,1707872877.352 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-02-14T01:07:57.353Z,1707872877.353 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 12 2024-02-14T01:07:57.353Z,1707872877.353 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-02-14T01:07:57.435Z,1707872877.435 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-02-14T01:07:57.436Z,1707872877.436 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-02-14T01:07:57.831Z,1707872877.831 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-02-14T01:07:57.831Z,1707872877.831 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 12 2024-02-14T01:07:57.832Z,1707872877.832 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-02-14T01:07:57.832Z,1707872877.832 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 12 2024-02-14T01:07:58.156Z,1707872878.156 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-02-14T01:10:58.410Z,1707873058.410 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 13 2024-02-14T01:10:58.410Z,1707873058.410 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-02-14T01:10:58.411Z,1707873058.411 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 13 2024-02-14T01:10:58.411Z,1707873058.411 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-02-14T01:10:58.499Z,1707873058.499 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-02-14T01:10:58.500Z,1707873058.500 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-02-14T01:10:58.847Z,1707873058.847 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-02-14T01:10:58.847Z,1707873058.847 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 13 2024-02-14T01:10:58.848Z,1707873058.848 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-02-14T01:10:58.848Z,1707873058.848 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 13 2024-02-14T01:10:59.163Z,1707873059.163 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-02-14T01:12:02.908Z,1707873122.908 [CommandExec](IMPORTANT): got command restart system 2024-02-14T01:12:04.991Z,1707873124.991 [Supervisor](INFO): Stop Mission called by Supervisor::terminate 2024-02-14T01:12:04.992Z,1707873124.992 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2024-02-14T01:12:04.992Z,1707873124.992 [CommandExec](INFO): Uninitializing the command executive. 2024-02-14T01:12:04.992Z,1707873124.992 [CommandExec](INFO): Uninitializing the command scheduler. 2024-02-14T01:12:04.992Z,1707873124.992 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-02-14T01:12:05.168Z,1707873125.168 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2024-02-14T01:12:05.168Z,1707873125.168 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2024-02-14T01:12:05.168Z,1707873125.168 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-02-14T01:12:05.169Z,1707873125.169 [NavChartDb](INFO): Join timeout helper Thread ID is 1004 2024-02-14T01:12:05.351Z,1707873125.351 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2024-02-14T01:12:05.352Z,1707873125.352 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-02-14T01:12:05.371Z,1707873125.371 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2024-02-14T01:12:05.371Z,1707873125.371 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-02-14T01:12:05.372Z,1707873125.372 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 1005 2024-02-14T01:12:05.507Z,1707873125.507 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2024-02-14T01:12:05.508Z,1707873125.508 [WetLabsBB2FL](INFO): Powering down 2024-02-14T01:12:05.508Z,1707873125.508 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-02-14T01:12:05.523Z,1707873125.523 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2024-02-14T01:12:05.523Z,1707873125.523 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-02-14T01:12:05.523Z,1707873125.523 [CTD_Seabird](INFO): Join timeout helper Thread ID is 1006 2024-02-14T01:12:06.163Z,1707873