2025-06-17T16:33:57.024Z,1750178037.024 [Supervisor](DEBUG): Initializing supervisor. 2025-06-17T16:33:57.028Z,1750178037.028 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2025-06-17T16:33:57.029Z,1750178037.029 [SyncHandler](INFO): Protected caller Thread ID is 2865 2025-06-17T16:33:57.029Z,1750178037.029 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2025-06-17T16:33:57.030Z,1750178037.030 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2025-06-17T16:33:57.030Z,1750178037.030 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 2866 2025-06-17T16:33:57.034Z,1750178037.034 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2025-06-17T16:33:57.054Z,1750178037.054 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2025-06-17T16:33:57.055Z,1750178037.055 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2025-06-17T16:33:57.055Z,1750178037.055 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 2867 2025-06-17T16:33:57.060Z,1750178037.060 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2025-06-17T16:33:57.061Z,1750178037.061 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2025-06-17T16:33:57.061Z,1750178037.061 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 2868 2025-06-17T16:33:57.063Z,1750178037.063 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2025-06-17T16:33:57.064Z,1750178037.064 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2025-06-17T16:33:57.065Z,1750178037.065 [logger ThreadHandler](INFO): Protected caller Thread ID is 2869 2025-06-17T16:33:57.068Z,1750178037.068 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2025-06-17T16:33:57.069Z,1750178037.069 [Supervisor](INFO): Looking for Config files in directory: Config/ 2025-06-17T16:33:57.070Z,1750178037.070 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2025-06-17T16:33:57.552Z,1750178037.552 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2025-06-17T16:33:57.552Z,1750178037.552 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2025-06-17T16:33:57.773Z,1750178037.773 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2025-06-17T16:33:57.773Z,1750178037.773 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2025-06-17T16:33:57.875Z,1750178037.875 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Guidance 2025-06-17T16:33:57.876Z,1750178037.876 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2025-06-17T16:33:58.125Z,1750178038.125 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2025-06-17T16:33:58.125Z,1750178038.125 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2025-06-17T16:33:58.214Z,1750178038.214 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2025-06-17T16:33:58.320Z,1750178038.320 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2025-06-17T16:33:58.321Z,1750178038.321 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2025-06-17T16:33:58.679Z,1750178038.679 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2025-06-17T16:33:58.680Z,1750178038.680 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2025-06-17T16:33:58.824Z,1750178038.824 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2025-06-17T16:33:58.825Z,1750178038.825 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2025-06-17T16:33:59.365Z,1750178039.365 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2025-06-17T16:33:59.366Z,1750178039.366 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2025-06-17T16:33:59.555Z,1750178039.555 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2025-06-17T16:33:59.556Z,1750178039.556 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2025-06-17T16:33:59.990Z,1750178039.990 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2025-06-17T16:33:59.990Z,1750178039.990 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2025-06-17T16:34:00.283Z,1750178040.283 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2025-06-17T16:34:00.283Z,1750178040.283 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2025-06-17T16:34:00.405Z,1750178040.405 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2025-06-17T16:34:00.405Z,1750178040.405 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2025-06-17T16:34:01.281Z,1750178041.281 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2025-06-17T16:34:01.281Z,1750178041.281 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2025-06-17T16:34:02.102Z,1750178042.102 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2025-06-17T16:34:02.103Z,1750178042.103 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2025-06-17T16:34:02.361Z,1750178042.361 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2025-06-17T16:34:02.363Z,1750178042.363 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-triton/ 2025-06-17T16:34:02.364Z,1750178042.364 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/vehicle.cfg 2025-06-17T16:34:02.492Z,1750178042.492 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/secure.cfg 2025-06-17T16:34:02.586Z,1750178042.586 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Science.cfg 2025-06-17T16:34:02.736Z,1750178042.736 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Simulator.cfg 2025-06-17T16:34:02.833Z,1750178042.833 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Battery.cfg 2025-06-17T16:34:03.112Z,1750178043.112 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2025-06-17T16:34:03.113Z,1750178043.113 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/logger.cfg 2025-06-17T16:34:03.226Z,1750178043.226 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Servo.cfg 2025-06-17T16:34:03.343Z,1750178043.343 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Navigation.cfg 2025-06-17T16:34:03.452Z,1750178043.452 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Sensor.cfg 2025-06-17T16:34:03.612Z,1750178043.612 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Control.cfg 2025-06-17T16:34:03.719Z,1750178043.719 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/BIT.cfg 2025-06-17T16:34:03.818Z,1750178043.818 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-triton/root/ 2025-06-17T16:34:03.818Z,1750178043.818 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg 2025-06-17T16:34:03.827Z,1750178043.827 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2025-06-17T16:34:03.838Z,1750178043.838 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2025-06-17T16:34:03.838Z,1750178043.838 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2025-06-17T16:34:03.972Z,1750178043.972 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2025-06-17T16:34:03.973Z,1750178043.973 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2025-06-17T16:34:04.027Z,1750178044.027 [VerticalControl](DEBUG): Construct VerticalControl. 2025-06-17T16:34:04.088Z,1750178044.088 [VerticalControl] Loaded 2025-06-17T16:34:04.088Z,1750178044.088 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2025-06-17T16:34:04.091Z,1750178044.091 [HorizontalControl](DEBUG): Construct HorizontalControl. 2025-06-17T16:34:04.138Z,1750178044.138 [HorizontalControl] Loaded 2025-06-17T16:34:04.139Z,1750178044.139 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2025-06-17T16:34:04.141Z,1750178044.141 [SpeedControl](DEBUG): Construct SpeedControl. 2025-06-17T16:34:04.144Z,1750178044.144 [SpeedControl] Loaded 2025-06-17T16:34:04.144Z,1750178044.144 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2025-06-17T16:34:04.147Z,1750178044.147 [LoopControl](DEBUG): Construct LoopControl. 2025-06-17T16:34:04.148Z,1750178044.148 [LoopControl] Loaded 2025-06-17T16:34:04.148Z,1750178044.148 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2025-06-17T16:34:04.148Z,1750178044.148 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2025-06-17T16:34:04.149Z,1750178044.149 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2025-06-17T16:34:04.311Z,1750178044.311 [BuoyancyServo] Loaded 2025-06-17T16:34:04.312Z,1750178044.312 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2025-06-17T16:34:04.334Z,1750178044.334 [ElevatorServo] Loaded 2025-06-17T16:34:04.334Z,1750178044.334 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2025-06-17T16:34:04.356Z,1750178044.356 [MassServo] Loaded 2025-06-17T16:34:04.356Z,1750178044.356 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2025-06-17T16:34:04.377Z,1750178044.377 [RudderServo] Loaded 2025-06-17T16:34:04.377Z,1750178044.377 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2025-06-17T16:34:04.394Z,1750178044.394 [ThrusterHE] Loaded 2025-06-17T16:34:04.394Z,1750178044.394 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread. 2025-06-17T16:34:04.394Z,1750178044.394 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2025-06-17T16:34:04.395Z,1750178044.395 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2025-06-17T16:34:04.446Z,1750178044.446 [DepthRateCalculator] Loaded 2025-06-17T16:34:04.446Z,1750178044.446 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2025-06-17T16:34:04.451Z,1750178044.451 [PitchRateCalculator] Loaded 2025-06-17T16:34:04.451Z,1750178044.451 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2025-06-17T16:34:04.461Z,1750178044.461 [SpeedCalculator] Loaded 2025-06-17T16:34:04.461Z,1750178044.461 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2025-06-17T16:34:04.465Z,1750178044.465 [YawRateCalculator] Loaded 2025-06-17T16:34:04.466Z,1750178044.466 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2025-06-17T16:34:04.484Z,1750178044.484 [ElevatorOffsetCalculator] Loaded 2025-06-17T16:34:04.484Z,1750178044.484 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2025-06-17T16:34:04.485Z,1750178044.485 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2025-06-17T16:34:04.485Z,1750178044.485 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2025-06-17T16:34:04.600Z,1750178044.600 [DeadReckonUsingMultipleVelocitySources] Loaded 2025-06-17T16:34:04.600Z,1750178044.600 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2025-06-17T16:34:04.614Z,1750178044.614 [NavChart] Loaded 2025-06-17T16:34:04.614Z,1750178044.614 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2025-06-17T16:34:04.620Z,1750178044.620 [UniversalFixResidualReporter] Loaded 2025-06-17T16:34:04.620Z,1750178044.620 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2025-06-17T16:34:04.621Z,1750178044.621 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2025-06-17T16:34:04.621Z,1750178044.621 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2025-06-17T16:34:05.102Z,1750178045.102 [AHRS_M2] Loaded 2025-06-17T16:34:05.102Z,1750178045.102 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2025-06-17T16:34:05.142Z,1750178045.142 [BackseatComponent] Loaded 2025-06-17T16:34:05.142Z,1750178045.142 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2025-06-17T16:34:05.144Z,1750178045.144 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 409294E0 2025-06-17T16:34:05.144Z,1750178045.144 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 2951 2025-06-17T16:34:05.147Z,1750178045.147 [LcmUniversalReporter] Loaded 2025-06-17T16:34:05.147Z,1750178045.147 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread. 2025-06-17T16:34:05.153Z,1750178045.153 [BioacousticsDataBridge] Loaded 2025-06-17T16:34:05.154Z,1750178045.154 [ComponentRegistry](DEBUG): SyncComponent "BioacousticsDataBridge" handled in the control thread. 2025-06-17T16:34:06.011Z,1750178046.011 [BPC1] Loaded 2025-06-17T16:34:06.011Z,1750178046.011 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2025-06-17T16:34:06.112Z,1750178046.112 [DAT] Loaded 2025-06-17T16:34:06.112Z,1750178046.112 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread. 2025-06-17T16:34:06.113Z,1750178046.113 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 409594E0 2025-06-17T16:34:06.113Z,1750178046.113 [DAT ThreadHandler](INFO): Protected caller Thread ID is 2952 2025-06-17T16:34:06.186Z,1750178046.186 [DataOverHttps] Loaded 2025-06-17T16:34:06.186Z,1750178046.186 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2025-06-17T16:34:06.187Z,1750178046.187 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 409894E0 2025-06-17T16:34:06.188Z,1750178046.188 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 2953 2025-06-17T16:34:06.211Z,1750178046.211 [Depth_Keller] Loaded 2025-06-17T16:34:06.212Z,1750178046.212 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2025-06-17T16:34:06.217Z,1750178046.217 [DropWeight] Loaded 2025-06-17T16:34:06.217Z,1750178046.217 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2025-06-17T16:34:06.282Z,1750178046.282 [NAL9602] Loaded 2025-06-17T16:34:06.283Z,1750178046.283 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2025-06-17T16:34:06.313Z,1750178046.313 [Onboard] Loaded 2025-06-17T16:34:06.313Z,1750178046.313 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2025-06-17T16:34:06.314Z,1750178046.314 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 409B94E0 2025-06-17T16:34:06.314Z,1750178046.314 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 2954 2025-06-17T16:34:06.329Z,1750178046.329 [Power24vConverter] Loaded 2025-06-17T16:34:06.329Z,1750178046.329 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2025-06-17T16:34:06.345Z,1750178046.345 [Radio_Surface] Loaded 2025-06-17T16:34:06.346Z,1750178046.346 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2025-06-17T16:34:06.347Z,1750178046.347 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409E94E0 2025-06-17T16:34:06.347Z,1750178046.347 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 2955 2025-06-17T16:34:06.364Z,1750178046.364 [Sonardyne_Nano] Loaded 2025-06-17T16:34:06.365Z,1750178046.365 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread. 2025-06-17T16:34:06.388Z,1750178046.388 [Waterlinked] Loaded 2025-06-17T16:34:06.389Z,1750178046.389 [ComponentRegistry](DEBUG): SyncComponent "Waterlinked" handled in the control thread. 2025-06-17T16:34:06.389Z,1750178046.389 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2025-06-17T16:34:06.390Z,1750178046.390 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2025-06-17T16:34:06.481Z,1750178046.481 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2025-06-17T16:34:06.481Z,1750178046.481 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2025-06-17T16:34:06.793Z,1750178046.793 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2025-06-17T16:34:06.793Z,1750178046.793 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2025-06-17T16:34:06.826Z,1750178046.826 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2025-06-17T16:34:06.828Z,1750178046.828 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2025-06-17T16:34:07.004Z,1750178047.004 [CTD_Seabird] Loaded 2025-06-17T16:34:07.004Z,1750178047.004 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2025-06-17T16:34:07.005Z,1750178047.005 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40B314E0 2025-06-17T16:34:07.005Z,1750178047.005 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 2956 2025-06-17T16:34:07.028Z,1750178047.028 [PAR_Licor] Loaded 2025-06-17T16:34:07.028Z,1750178047.028 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2025-06-17T16:34:07.074Z,1750178047.074 [WetLabsBB2FL] Loaded 2025-06-17T16:34:07.074Z,1750178047.074 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2025-06-17T16:34:07.075Z,1750178047.075 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40B614E0 2025-06-17T16:34:07.075Z,1750178047.075 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 2957 2025-06-17T16:34:07.076Z,1750178047.076 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2025-06-17T16:34:07.077Z,1750178047.077 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2025-06-17T16:34:07.422Z,1750178047.422 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2025-06-17T16:34:07.423Z,1750178047.423 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2025-06-17T16:34:07.584Z,1750178047.584 [SBIT](DEBUG): Construct Startup Built In Test. 2025-06-17T16:34:07.593Z,1750178047.593 [SBIT] Loaded 2025-06-17T16:34:07.593Z,1750178047.593 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2025-06-17T16:34:07.596Z,1750178047.596 [IBIT](DEBUG): Construct Initiated Built In Test. 2025-06-17T16:34:07.609Z,1750178047.609 [IBIT] Loaded 2025-06-17T16:34:07.609Z,1750178047.609 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2025-06-17T16:34:07.615Z,1750178047.615 [CBIT](DEBUG): Construct Continuous Built In Test. 2025-06-17T16:34:07.696Z,1750178047.696 [CBIT] Loaded 2025-06-17T16:34:07.696Z,1750178047.696 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2025-06-17T16:34:07.730Z,1750178047.730 [GFScanner] Loaded 2025-06-17T16:34:07.730Z,1750178047.730 [ComponentRegistry](DEBUG): SyncComponent "GFScanner" handled in the control thread. 2025-06-17T16:34:07.730Z,1750178047.730 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2025-06-17T16:34:07.737Z,1750178047.737 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2025-06-17T16:34:07.740Z,1750178047.740 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2025-06-17T16:34:07.751Z,1750178047.751 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2025-06-17T16:34:07.752Z,1750178047.752 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C694E0 2025-06-17T16:34:07.753Z,1750178047.753 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 2958 2025-06-17T16:34:07.757Z,1750178047.757 [Supervisor](INFO): Main Thread ID is 2359 2025-06-17T16:34:07.757Z,1750178047.757 [Supervisor](DEBUG): Running supervisor. 2025-06-17T16:34:07.758Z,1750178047.758 [CommandExec ThreadHandler](INFO): Handler Thread ID is 2959 2025-06-17T16:34:07.758Z,1750178047.758 [CommandExec](INFO): Initializing the command executive. 2025-06-17T16:34:07.760Z,1750178047.760 [CommandLine ThreadHandler](INFO): Handler Thread ID is 2960 2025-06-17T16:34:07.763Z,1750178047.763 [controlThread ThreadHandler](INFO): Handler Thread ID is 2961 2025-06-17T16:34:07.763Z,1750178047.763 [controlThread](DEBUG): Initializing ControlThread 2025-06-17T16:34:07.764Z,1750178047.764 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2025-06-17T16:34:07.766Z,1750178047.766 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2025-06-17T16:34:07.766Z,1750178047.766 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2025-06-17T16:34:07.767Z,1750178047.767 [LoopControl](DEBUG): Initialize LoopControlComponent. 2025-06-17T16:34:07.769Z,1750178047.769 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2025-06-17T16:34:07.769Z,1750178047.769 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2025-06-17T16:34:07.770Z,1750178047.770 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2025-06-17T16:34:07.770Z,1750178047.770 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2025-06-17T16:34:07.770Z,1750178047.770 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2025-06-17T16:34:07.771Z,1750178047.771 [NavChart](DEBUG): Initialize NavChart Navigation. 2025-06-17T16:34:07.772Z,1750178047.772 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2025-06-17T16:34:07.780Z,1750178047.780 [SBIT](INFO): Initialize SBIT Component. 2025-06-17T16:34:07.780Z,1750178047.780 [SBIT](IMPORTANT): git: 2025-06-12 2025-06-17T16:34:07.781Z,1750178047.781 [SBIT](INFO): git hash: a60a180f7032adfdf60d6884e5f8533735b6cd09 2025-06-17T16:34:07.781Z,1750178047.781 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2025-06-17T16:34:07.782Z,1750178047.782 [SBIT](INFO): Kernel Reporting Different Version From Configuration. Kernel Expected: #1 PREEMPT Tue Dec 18 21:19:28 PST 2018 Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021 2025-06-17T16:34:07.783Z,1750178047.783 [SBIT](INFO): Beginning SBIT in 25.000000 seconds. 2025-06-17T16:34:07.784Z,1750178047.784 [IBIT](INFO): Initialize IBIT Component. 2025-06-17T16:34:07.785Z,1750178047.785 [CBIT](DEBUG): Initialize CBIT Component. 2025-06-17T16:34:07.785Z,1750178047.785 [logger ThreadHandler](INFO): Handler Thread ID is 2962 2025-06-17T16:34:07.795Z,1750178047.795 [CBIT](DEBUG): Initialized mux pins. 2025-06-17T16:34:07.796Z,1750178047.796 [CBIT](DEBUG): Initializing the watchdog timer. 2025-06-17T16:34:07.804Z,1750178047.804 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 2963 2025-06-17T16:34:07.816Z,1750178047.816 [DAT ThreadHandler](INFO): Handler Thread ID is 2964 2025-06-17T16:34:07.817Z,1750178047.817 [DAT](INFO): Powering up 2025-06-17T16:34:07.817Z,1750178047.817 [DAT](DEBUG): Initializing DAT. 2025-06-17T16:34:07.820Z,1750178047.820 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2025-06-17T16:34:07.820Z,1750178047.820 [CBIT](DEBUG): Initializing heartbeat. 2025-06-17T16:34:07.822Z,1750178047.822 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 2966 2025-06-17T16:34:07.823Z,1750178047.823 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2025-06-17T16:34:07.832Z,1750178047.832 [Onboard ThreadHandler](INFO): Handler Thread ID is 2967 2025-06-17T16:34:07.850Z,1750178047.850 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 2968 2025-06-17T16:34:07.876Z,1750178047.876 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 2969 2025-06-17T16:34:07.876Z,1750178047.876 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2025-06-17T16:34:07.881Z,1750178047.881 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 2971 2025-06-17T16:34:07.884Z,1750178047.884 [WetLabsBB2FL](INFO): Powering up 2025-06-17T16:34:07.885Z,1750178047.885 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 2973 2025-06-17T16:34:07.889Z,1750178047.889 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2MI79M.000 2025-06-17T16:34:07.889Z,1750178047.889 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2MI79M.000 2025-06-17T16:34:07.889Z,1750178047.889 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MI2QL.000 2025-06-17T16:34:07.889Z,1750178047.889 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI2QL.000 2025-06-17T16:34:07.889Z,1750178047.889 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MI2QM.000 2025-06-17T16:34:07.889Z,1750178047.889 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI2QM.000 2025-06-17T16:34:07.890Z,1750178047.890 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MI2PM.000 2025-06-17T16:34:07.890Z,1750178047.890 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI2PM.000 2025-06-17T16:34:07.890Z,1750178047.890 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5MI74M.000 2025-06-17T16:34:07.890Z,1750178047.890 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5MI74M.000 2025-06-17T16:34:07.890Z,1750178047.890 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MI2QN.000 2025-06-17T16:34:07.890Z,1750178047.890 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI2QN.000 2025-06-17T16:34:07.891Z,1750178047.891 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MI2QO.000 2025-06-17T16:34:07.891Z,1750178047.891 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI2QO.000 2025-06-17T16:34:07.891Z,1750178047.891 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MI2RO.000 2025-06-17T16:34:07.891Z,1750178047.891 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI2RO.000 2025-06-17T16:34:07.891Z,1750178047.891 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MI2RN.000 2025-06-17T16:34:07.891Z,1750178047.891 [CBIT](DEBUG): Deactivating emergency mode. 2025-06-17T16:34:07.892Z,1750178047.892 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI2RN.000 2025-06-17T16:34:07.892Z,1750178047.892 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MI2QP.000 2025-06-17T16:34:07.892Z,1750178047.892 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI2QP.000 2025-06-17T16:34:07.931Z,1750178047.931 [CBIT](DEBUG): Backplane powered. 2025-06-17T16:34:07.932Z,1750178047.932 [GFScanner](DEBUG): Initializing GFScanner 2025-06-17T16:34:07.932Z,1750178047.932 [GFScanner](DEBUG): Deactivating GF circuits. 2025-06-17T16:34:07.936Z,1750178047.936 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser 2025-06-17T16:34:07.937Z,1750178047.937 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl 2025-06-17T16:34:07.937Z,1750178047.937 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl 2025-06-17T16:34:07.939Z,1750178047.939 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl 2025-06-17T16:34:07.987Z,1750178047.987 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into: 2025-06-17T16:34:08.008Z,1750178048.008 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2025-06-17T16:34:08.040Z,1750178048.040 [MissionManager](DEBUG): # Copyright (c) 2024 MBARI # MBARI Proprietary Information. Confidential. All Rights Reserved # Unauthorized copying or distribution of this file via any medium is strictly # prohibited. # # WARNING - This file contains information whose export is restricted by the # Export Administration Act of 1979 (Title 50, U.S.C., App. 2401 et seq.), as # amended. Violations of these export laws are subject to severe civil and/or # criminal penalties. mission Startup { behavior Guidance:GoToSurface { run in progression } aggregate StartupSatComms { run in sequence readDatum { timeout duration=P1M Universal:latitude_fix } readDatum { timeout duration=P1M Universal:platform_communications } } } 2025-06-17T16:34:08.041Z,1750178048.041 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl 2025-06-17T16:34:08.041Z,1750178048.041 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl 2025-06-17T16:34:08.042Z,1750178048.042 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl 2025-06-17T16:34:08.256Z,1750178048.256 [Radio_Surface](INFO): Powering up 2025-06-17T16:34:08.369Z,1750178048.369 [MissionManager](DEBUG): TethyslAPI: Missions/Default.tl translated into: 0 13 Burn on Dropped weight due to communications timeout. 5 Default mission has been running for Restarting logs and Default mission. restart logs 2025-06-17T16:34:08.387Z,1750178048.387 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2025-06-17T16:34:08.388Z,1750178048.388 [Default:A.Wait](DEBUG): Construct Wait. 2025-06-17T16:34:08.391Z,1750178048.391 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2025-06-17T16:34:08.436Z,1750178048.436 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2025-06-17T16:34:08.438Z,1750178048.438 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2025-06-17T16:34:08.460Z,1750178048.460 [Default:E.Execute](DEBUG): Construct Execute. 2025-06-17T16:34:08.480Z,1750178048.480 [MissionManager](DEBUG): # Copyright (c) 2024 MBARI # MBARI Proprietary Information. Confidential. All Rights Reserved # Unauthorized copying or distribution of this file via any medium is strictly # prohibited. # # WARNING - This file contains information whose export is restricted by the # Export Administration Act of 1979 (Title 50, U.S.C., App. 2401 et seq.), as # amended. Violations of these export laws are subject to severe civil and/or # criminal penalties. mission Default { arguments { ElapsedSinceDefaultStarted = 0 minute } behavior Guidance:Wait { """ Wait a moment to see if the scheduler starts a new mission before starting to actually run Default. """ run in sequence set duration = 13 second } behavior Guidance:GoToSurface { run in progression } aggregate CheckIn { run in sequence repeat=288 readDatum id="Read_GPS" { timeout duration=P5M Universal:time_fix } readDatum id="Read_Iridium" { timeout duration=P4H { behavior Guidance:Execute { run in sequence set command = "Burn on" } syslog critical "Dropped weight due to communications timeout." } Universal:platform_communications } behavior Guidance:Wait { run in sequence set duration = 5 minute } assign in sequence ElapsedSinceDefaultStarted = elapsed ( Universal:mission_started ) syslog important "Default mission has been running for " + ElapsedSinceDefaultStarted~minute } syslog important "Restarting logs and Default mission." behavior Guidance:Execute { run in sequence set command = "restart logs" } } 2025-06-17T16:34:08.485Z,1750178048.485 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BioacousticsDataBridge,BPC1,Depth_Keller,DropWeight,NAL9602,Power24vConverter,Sonardyne_Nano,Waterlinked,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,GFScanner,LcmUniversalReporter,Reporter,LogSplitter, 2025-06-17T16:34:08.508Z,1750178048.508 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2025-06-17T16:34:08.573Z,1750178048.573 [Depth_Keller](INFO): Initializing. 2025-06-17T16:34:08.574Z,1750178048.574 [Power24vConverter](INFO): Powering up. 2025-06-17T16:34:08.575Z,1750178048.575 [Sonardyne_Nano](INFO): Initializing. 2025-06-17T16:34:08.621Z,1750178048.621 [DepthRateCalculator](ERROR): Depth measurement is not active 2025-06-17T16:34:08.647Z,1750178048.647 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2025-06-17T16:34:08.664Z,1750178048.664 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2025-06-17T16:34:08.665Z,1750178048.665 [ElevatorServo](DEBUG): Initializing EZServoServo. 2025-06-17T16:34:08.672Z,1750178048.672 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2025-06-17T16:34:08.673Z,1750178048.673 [MassServo](DEBUG): Initializing EZServoServo. 2025-06-17T16:34:08.680Z,1750178048.680 [MassServo](DEBUG): Initializing MassServo. 2025-06-17T16:34:08.681Z,1750178048.681 [RudderServo](DEBUG): Initializing EZServoServo. 2025-06-17T16:34:08.688Z,1750178048.688 [RudderServo](DEBUG): Initializing RudderServo. 2025-06-17T16:34:08.689Z,1750178048.689 [ThrusterHE](DEBUG): Initializing EZServoServo. 2025-06-17T16:34:08.696Z,1750178048.696 [ThrusterHE](DEBUG): Initializing ThrusterHE. 2025-06-17T16:34:10.514Z,1750178050.514 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART 2025-06-17T16:34:10.524Z,1750178050.524 [WetLabsBB2FL](INFO): Powering down 2025-06-17T16:34:11.800Z,1750178051.800 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2107 2025-06-17T16:34:14.509Z,1750178054.509 [ThrusterHE](ERROR): Zero Speed Commanded. 2025-06-17T16:34:20.164Z,1750178060.164 [DAT](INFO): DAT read: 2025-06-17T16:34:20.166Z,1750178060.166 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series 2025-06-17T16:34:21.928Z,1750178061.928 [DAT](INFO): DAT read: MF Frequency Band 2025-06-17T16:34:21.930Z,1750178061.930 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.15.0 2025-06-17T16:34:21.930Z,1750178061.930 [DAT](INFO): DAT read: Jun 17 2025 16:34:16 2025-06-17T16:34:22.937Z,1750178062.937 [DAT](INFO): DAT read: Features enabled [Bearing] 2025-06-17T16:34:22.938Z,1750178062.938 [DAT](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP 2025-06-17T16:34:22.938Z,1750178062.938 [DAT](INFO): commRate: 800 2025-06-17T16:34:25.004Z,1750178065.004 [DAT](INFO): entering command mode 2025-06-17T16:34:25.204Z,1750178065.204 [DAT](INFO): DAT read: 2025-06-17T16:34:25.205Z,1750178065.205 [DAT](INFO): DAT read: user:1> 2025-06-17T16:34:25.205Z,1750178065.205 [DAT](INFO): setting verbose to 3 2025-06-17T16:34:25.456Z,1750178065.456 [DAT](INFO): DAT read: user:1> 2025-06-17T16:34:25.457Z,1750178065.457 [DAT](INFO): DAT read: Verbose | 3 2025-06-17T16:34:25.458Z,1750178065.458 [DAT](INFO): set verbose to 3 2025-06-17T16:34:25.458Z,1750178065.458 [DAT](INFO): setting DatVerbose to 27440 2025-06-17T16:34:25.709Z,1750178065.709 [DAT](INFO): DAT read: user:2> 2025-06-17T16:34:25.710Z,1750178065.710 [DAT](INFO): DAT read: DatVerbose | 27440 2025-06-17T16:34:25.710Z,1750178065.710 [DAT](INFO): set DatVerbose to 27440 2025-06-17T16:34:25.710Z,1750178065.710 [DAT](INFO): setting transmit power to 8 2025-06-17T16:34:25.960Z,1750178065.960 [DAT](INFO): DAT read: user:3> 2025-06-17T16:34:25.961Z,1750178065.961 [DAT](INFO): DAT read: TxPower | 8 (Max) 2025-06-17T16:34:25.962Z,1750178065.962 [DAT](INFO): set transmit power to 8 2025-06-17T16:34:25.962Z,1750178065.962 [DAT](INFO): setting local address to 12 2025-06-17T16:34:26.212Z,1750178066.212 [DAT](INFO): DAT read: user:4> 2025-06-17T16:34:26.213Z,1750178066.213 [DAT](INFO): DAT read: LocalAddr | 12 2025-06-17T16:34:26.214Z,1750178066.214 [DAT](INFO): set local address to 12 2025-06-17T16:34:26.215Z,1750178066.215 [DAT](INFO): Setting time to: 16:34:26 And date to:6/17/2025 2025-06-17T16:34:26.464Z,1750178066.464 [DAT](INFO): DAT read: user:5> 2025-06-17T16:34:26.465Z,1750178066.465 [DAT](INFO): DAT read: Tue Jun 17, 2025 16:34:26 2025-06-17T16:34:26.466Z,1750178066.466 [DAT](INFO): Local DAT time set to Tue Jun 17, 2025 16:34:26 2025-06-17T16:34:33.601Z,1750178073.601 [SBIT](IMPORTANT): Beginning Startup BIT 2025-06-17T16:34:33.606Z,1750178073.606 [GFScanner](IMPORTANT): Beginning ground fault scan 2025-06-17T16:34:36.405Z,1750178076.405 [NAL9602](INFO): Powering up NAL9602 2025-06-17T16:34:38.640Z,1750178078.640 [GFScanner](IMPORTANT): Ground fault detected mA: CHAN A0 (Batt): 0.034025 CHAN A1 (24V): 0.053185 CHAN A2 (12V): 0.023114 CHAN A3 (5V): 0.005936 CHAN B0 (3.3V): 0.003775 CHAN B1 (3.15aV): 0.003464 CHAN B2 (3.15bV): 0.003979 CHAN B3 (GND): -0.003712 OPEN: 0.006591 Full Scale: +/- 1 mA 2025-06-17T16:34:45.792Z,1750178085.792 [Waterlinked](INFO): Powering down 2025-06-17T16:34:47.315Z,1750178087.315 [NAL9602](INFO): NAL9602 initialized 2025-06-17T16:35:14.808Z,1750178114.808 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-06-17T16:35:26.982Z,1750178126.982 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-06-17T16:35:27.423Z,1750178127.423 [SBIT](IMPORTANT): SBIT PASSED 2025-06-17T16:35:27.423Z,1750178127.423 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2025-06-17T16:35:27.424Z,1750178127.424 [SBIT](IMPORTANT): BPC1.batteryMissingStickThreshold=15 count; 2025-06-17T16:35:27.424Z,1750178127.424 [SBIT](IMPORTANT): DAT.loadAtStartup=1 bool; 2025-06-17T16:35:27.424Z,1750178127.424 [SBIT](IMPORTANT): DAT.simulateHardware=0 bool; 2025-06-17T16:35:27.424Z,1750178127.424 [SBIT](IMPORTANT): Express none CTD_Seabird.bin_median_sea_water_salinity; 2025-06-17T16:35:27.424Z,1750178127.424 [SBIT](IMPORTANT): Express none CTD_Seabird.bin_median_sea_water_temperature; 2025-06-17T16:35:27.424Z,1750178127.424 [SBIT](IMPORTANT): Express none WetLabsBB2FL.bin_mean_mass_concentration_of_chlorophyll_in_sea_water; 2025-06-17T16:35:27.424Z,1750178127.424 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=251.216000 cubic_centimeter; 2025-06-17T16:35:27.425Z,1750178127.425 [SBIT](IMPORTANT): VerticalControl.massDefault=-1.404580 millimeter; 2025-06-17T16:35:27.425Z,1750178127.425 [SBIT](IMPORTANT): Waterlinked.loadAtStartup=1 bool; 2025-06-17T16:35:27.824Z,1750178127.824 [MissionManager](IMPORTANT): Started mission Startup 2025-06-17T16:35:27.824Z,1750178127.824 [Startup] Running Loop=1 2025-06-17T16:35:27.824Z,1750178127.824 [Startup](DEBUG): Aggregate::initialize Startup 2025-06-17T16:35:27.824Z,1750178127.824 [Startup:A.GoToSurface] Running Loop=1 2025-06-17T16:35:27.824Z,1750178127.824 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2025-06-17T16:35:27.825Z,1750178127.825 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2025-06-17T16:35:27.825Z,1750178127.825 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2025-06-17T16:35:27.826Z,1750178127.826 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2025-06-17T16:35:27.826Z,1750178127.826 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2025-06-17T16:35:27.826Z,1750178127.826 [Startup:A.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2025-06-17T16:35:27.827Z,1750178127.827 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2025-06-17T16:35:27.829Z,1750178127.829 [Startup:StartupSatComms] Running Loop=1 2025-06-17T16:35:27.829Z,1750178127.829 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2025-06-17T16:35:27.829Z,1750178127.829 [Startup:StartupSatComms:A] Running Loop=1 2025-06-17T16:35:28.218Z,1750178128.218 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2025-06-17T16:35:39.508Z,1750178139.508 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-06-17T16:35:51.626Z,1750178151.626 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-06-17T16:36:04.150Z,1750178164.150 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-06-17T16:36:16.675Z,1750178176.675 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-06-17T16:36:28.006Z,1750178188.006 [Startup:StartupSatComms:A](INFO): Timed out from 2025-06-17T16:35:27.8Z 2025-06-17T16:36:28.006Z,1750178188.006 [Startup:StartupSatComms:A] Stopped 2025-06-17T16:36:28.007Z,1750178188.007 [Startup:StartupSatComms:B] Running Loop=1 2025-06-17T16:36:28.422Z,1750178188.422 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2025-06-17T16:36:29.198Z,1750178189.198 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-06-17T16:37:08.082Z,1750178228.082 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2025-06-17T16:37:08.082Z,1750178228.082 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-06-17T16:37:08.094Z,1750178228.094 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-06-17T16:37:08.415Z,1750178228.415 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-06-17T16:37:08.415Z,1750178228.415 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2025-06-17T16:37:28.213Z,1750178248.213 [Startup:StartupSatComms:B](INFO): Timed out from 2025-06-17T16:36:28.0Z 2025-06-17T16:37:28.213Z,1750178248.213 [Startup:StartupSatComms:B] Stopped 2025-06-17T16:37:28.213Z,1750178248.213 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2025-06-17T16:37:28.213Z,1750178248.213 [Startup:StartupSatComms] Stopped 2025-06-17T16:37:28.213Z,1750178248.213 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2025-06-17T16:37:28.214Z,1750178248.214 [Startup](INFO): Completed Startup 2025-06-17T16:37:28.214Z,1750178248.214 [MissionManager](INFO): Startup is completed. 2025-06-17T16:37:28.215Z,1750178248.215 [MissionManager](INFO): Uninitializing Mission Startup 2025-06-17T16:37:28.215Z,1750178248.215 [Startup] Stopped 2025-06-17T16:37:28.215Z,1750178248.215 [Startup](DEBUG): Aggregate::uninitialize Startup 2025-06-17T16:37:28.215Z,1750178248.215 [Startup:A.GoToSurface] Stopped 2025-06-17T16:37:28.215Z,1750178248.215 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2025-06-17T16:37:28.642Z,1750178248.642 [MissionManager](IMPORTANT): Started mission Default 2025-06-17T16:37:28.642Z,1750178248.642 [Default] Running Loop=1 2025-06-17T16:37:28.642Z,1750178248.642 [Default](DEBUG): Aggregate::initialize Default 2025-06-17T16:37:28.642Z,1750178248.642 [Default:B.GoToSurface] Running Loop=1 2025-06-17T16:37:28.642Z,1750178248.642 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2025-06-17T16:37:28.642Z,1750178248.642 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2025-06-17T16:37:28.643Z,1750178248.643 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2025-06-17T16:37:28.643Z,1750178248.643 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2025-06-17T16:37:28.656Z,1750178248.656 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2025-06-17T16:37:28.658Z,1750178248.658 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2025-06-17T16:37:28.707Z,1750178248.707 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2025-06-17T16:37:28.708Z,1750178248.708 [Default:A.Wait] Running Loop=1 2025-06-17T16:37:28.708Z,1750178248.708 [Default:A.Wait](DEBUG): Initialize Wait Component. 2025-06-17T16:37:32.314Z,1750178252.314 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004710 2025-06-17T16:37:38.712Z,1750178258.712 [CommandExec](IMPORTANT): got command failComponent 2025-06-17T16:37:38.712Z,1750178258.712 [CommandExec](IMPORTANT): Failed components: 2025-06-17T16:37:38.713Z,1750178258.713 [CommandExec](IMPORTANT): No failed Components. 2025-06-17T16:37:41.961Z,1750178261.961 [Default:A.Wait](INFO): Done Waiting. 2025-06-17T16:37:41.961Z,1750178261.961 [Default:A.Wait] Stopped 2025-06-17T16:37:41.961Z,1750178261.961 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2025-06-17T16:37:42.145Z,1750178262.145 [CommandExec](IMPORTANT): got command strobe off 2025-06-17T16:37:42.145Z,1750178262.145 [CommandExec](IMPORTANT): Deactivating strobe 2025-06-17T16:37:42.357Z,1750178262.357 [Default:CheckIn] Running Loop=1 2025-06-17T16:37:42.357Z,1750178262.357 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-06-17T16:37:42.357Z,1750178262.357 [Default:CheckIn:Read_GPS] Running Loop=1 2025-06-17T16:37:42.765Z,1750178262.765 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2025-06-17T16:39:07.167Z,1750178347.167 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2025-06-17T16:39:12.417Z,1750178352.417 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-06-17T16:39:22.114Z,1750178362.114 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2025-06-17T16:39:27.770Z,1750178367.770 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-06-17T16:39:37.062Z,1750178377.062 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2025-06-17T16:39:43.527Z,1750178383.527 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-06-17T16:39:50.809Z,1750178390.809 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2025-06-17T16:39:52.415Z,1750178392.415 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2025-06-17T16:39:59.283Z,1750178399.283 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-06-17T16:40:07.363Z,1750178407.363 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2025-06-17T16:40:08.997Z,1750178408.997 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2025-06-17T16:40:08.997Z,1750178408.997 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-06-17T16:40:09.008Z,1750178409.008 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-06-17T16:40:09.414Z,1750178409.414 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-06-17T16:40:09.414Z,1750178409.414 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2025-06-17T16:40:15.443Z,1750178415.443 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-06-17T16:40:22.309Z,1750178422.309 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2025-06-17T16:40:30.794Z,1750178430.794 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-06-17T16:40:37.663Z,1750178437.663 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2025-06-17T16:40:46.953Z,1750178446.953 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-06-17T16:40:53.824Z,1750178453.824 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2025-06-17T16:41:02.306Z,1750178462.306 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-06-17T16:41:08.770Z,1750178468.770 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2025-06-17T16:41:17.254Z,1750178477.254 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2025-06-17T16:41:23.362Z,1750178483.362 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2025-06-17T16:41:29.850Z,1750178489.850 [BPC1](INFO): Calculating totals. Valid battery stick count: 44. Valid reserve battery stick count: 5. 2025-06-17T16:41:29.853Z,1750178489.853 [BPC1](INFO): Received data from all battery sticks. 2025-06-17T16:42:42.515Z,1750178562.515 [Default:CheckIn:Read_GPS](INFO): Timed out from 2025-06-17T16:37:42.4Z 2025-06-17T16:42:42.515Z,1750178562.515 [Default:CheckIn:Read_GPS] Stopped 2025-06-17T16:42:42.515Z,1750178562.515 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-06-17T16:42:42.921Z,1750178562.921 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications 2025-06-17T16:42:50.197Z,1750178570.197 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250617T160045/Courier0013.lzma 2025-06-17T16:42:51.197Z,1750178571.197 [DataOverHttps](INFO): Moved sent file to Logs/20250617T160045/Courier0013.lzma.bak 2025-06-17T16:42:51.198Z,1750178571.198 [DataOverHttps](INFO): SBD MOMSN=25221797 2025-06-17T16:43:07.903Z,1750178587.903 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20250617T163356/Courier0000.lzma 2025-06-17T16:43:08.905Z,1750178588.905 [DataOverHttps](INFO): Moved sent file to Logs/20250617T163356/Courier0000.lzma.bak 2025-06-17T16:43:08.905Z,1750178588.905 [DataOverHttps](INFO): SBD MOMSN=25221799 2025-06-17T16:43:10.001Z,1750178590.001 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3 2025-06-17T16:43:10.001Z,1750178590.001 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-06-17T16:43:10.024Z,1750178590.024 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-06-17T16:43:10.423Z,1750178590.423 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-06-17T16:43:10.423Z,1750178590.423 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3 2025-06-17T16:43:25.055Z,1750178605.055 [DataOverHttps](INFO): Sending 168 bytes from file Logs/20250617T163356/Courier0004.lzma 2025-06-17T16:43:26.057Z,1750178606.057 [DataOverHttps](INFO): Moved sent file to Logs/20250617T163356/Courier0004.lzma.bak 2025-06-17T16:43:26.057Z,1750178606.057 [DataOverHttps](INFO): SBD MOMSN=25221802 2025-06-17T16:43:41.643Z,1750178621.643 [DataOverHttps](INFO): Sending 130 bytes from file Logs/20250617T160045/Express0014.lzma 2025-06-17T16:43:42.645Z,1750178622.645 [DataOverHttps](INFO): Moved sent file to Logs/20250617T160045/Express0014.lzma.bak 2025-06-17T16:43:42.646Z,1750178622.646 [DataOverHttps](INFO): SBD MOMSN=25221804 2025-06-17T16:43:58.201Z,1750178638.201 [DataOverHttps](INFO): Sending 911 bytes from file Logs/20250617T163356/Express0001.lzma 2025-06-17T16:43:59.201Z,1750178639.201 [DataOverHttps](INFO): Moved sent file to Logs/20250617T163356/Express0001.lzma.bak 2025-06-17T16:43:59.202Z,1750178639.202 [DataOverHttps](INFO): SBD MOMSN=25221808 2025-06-17T16:44:14.944Z,1750178654.944 [DataOverHttps](INFO): Sending 282 bytes from file Logs/20250617T163356/Express0005.lzma 2025-06-17T16:44:15.945Z,1750178655.945 [DataOverHttps](INFO): Moved sent file to Logs/20250617T163356/Express0005.lzma.bak 2025-06-17T16:44:15.945Z,1750178655.945 [DataOverHttps](INFO): SBD MOMSN=25221830 2025-06-17T16:44:17.463Z,1750178657.463 [Default:CheckIn:Read_Iridium] Stopped 2025-06-17T16:44:17.463Z,1750178657.463 [Default:CheckIn:C.Wait] Running Loop=1 2025-06-17T16:44:17.463Z,1750178657.463 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-06-17T16:44:49.761Z,1750178689.761 [NAL9602](FAULT): GPS failed to acquire within timeout. 2025-06-17T16:44:49.761Z,1750178689.761 [NAL9602] Data Fault, FailCount= 1 2025-06-17T16:44:49.761Z,1750178689.761 [NAL9602](ERROR): Data Fault 2025-06-17T16:44:49.800Z,1750178689.800 [CBIT](ERROR): Data Fault in component: NAL9602 2025-06-17T16:44:50.169Z,1750178690.169 [NAL9602](INFO): Powering down 2025-06-17T16:44:51.002Z,1750178691.002 [CBIT](INFO): Clearing failed state for component NAL9602 2025-06-17T16:44:51.002Z,1750178691.002 [NAL9602] No Fault, FailCount= 1 2025-06-17T16:45:20.469Z,1750178720.469 [NAL9602](INFO): Powering up NAL9602 2025-06-17T16:45:31.373Z,1750178731.373 [NAL9602](INFO): NAL9602 initialized 2025-06-17T16:46:11.005Z,1750178771.005 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4 2025-06-17T16:46:11.005Z,1750178771.005 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2025-06-17T16:46:11.015Z,1750178771.015 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2025-06-17T16:46:11.431Z,1750178771.431 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2025-06-17T16:46:11.431Z,1750178771.431 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4 2025-06-17T16:47:21.925Z,1750178841.925 [DataOverHttps](IMPORTANT): SBD MTMSN=20250617T164721 2025-06-17T16:47:22.883Z,1750178842.883 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,164721.00,A,3648.13331,N,12147.25291,W,0.019,112.17,170625,,,A*76 2025-06-17T16:47:22.886Z,1750178842.886 [NAL9602](INFO): GPS fix at 20250617T164721: (36.802222, -121.787548) 2025-06-17T16:47:29.400Z,1750178849.400 [DataOverHttps](INFO): Received command: ibit 2025-06-17T16:47:29.484Z,1750178849.484 [CommandExec](IMPORTANT): got command ibit 2025-06-17T16:47:29.776Z,1750178849.776 [IBIT](IMPORTANT): Beginning Initiated BIT 2025-06-17T16:47:29.776Z,1750178849.776 [IBIT](IMPORTANT): Beginning control surface checks. 2025-06-17T16:47:29.780Z,1750178849.780 [GFScanner](IMPORTANT): Beginning ground fault scan 2025-06-17T16:47:30.401Z,1750178850.401 [DataOverHttps](IMPORTANT): SBD MTMSN=20250617T164729 2025-06-17T16:47:31.374Z,1750178851.374 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,164729.00,A,3648.14143,N,12147.24488,W,0.078,112.17,170625,,,A*76 2025-06-17T16:47:31.376Z,1750178851.376 [NAL9602](INFO): GPS fix at 20250617T164729: (36.802357, -121.787415) 2025-06-17T16:47:33.794Z,1750178853.794 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,164732.00,A,3648.14162,N,12147.24441,W,0.194,112.17,170625,,,A*79 2025-06-17T16:47:33.797Z,1750178853.797 [NAL9602](INFO): GPS fix at 20250617T164732: (36.802360, -121.787407) 2025-06-17T16:47:34.412Z,1750178854.412 [GFScanner](IMPORTANT): Ground fault detected mA: CHAN A0 (Batt): 0.038182 CHAN A1 (24V): 0.058197 CHAN A2 (12V): 0.023042 CHAN A3 (5V): 0.004518 CHAN B0 (3.3V): 0.002350 CHAN B1 (3.15aV): 0.002503 CHAN B2 (3.15bV): 0.003601 CHAN B3 (GND): -0.005671 OPEN: 0.006672 Full Scale: +/- 1 mA 2025-06-17T16:47:37.030Z,1750178857.030 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,164735.00,A,3648.14182,N,12147.24405,W,0.175,112.17,170625,,,A*7F 2025-06-17T16:47:37.033Z,1750178857.033 [NAL9602](INFO): GPS fix at 20250617T164735: (36.802364, -121.787401) 2025-06-17T16:47:38.079Z,1750178858.079 [DataOverHttps](INFO): Received command: failc 2025-06-17T16:47:38.140Z,1750178858.140 [CommandExec](IMPORTANT): got command failComponent 2025-06-17T16:47:38.140Z,1750178858.140 [CommandExec](IMPORTANT): Failed components: 2025-06-17T16:47:38.140Z,1750178858.140 [CommandExec](IMPORTANT): No failed Components. 2025-06-17T16:47:39.854Z,1750178859.854 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,164738.00,A,3648.14206,N,12147.24343,W,0.156,112.17,170625,,,A*79 2025-06-17T16:47:39.865Z,1750178859.865 [NAL9602](INFO): GPS fix at 20250617T164738: (36.802368, -121.787391) 2025-06-17T16:47:42.681Z,1750178862.681 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,164741.00,A,3648.14208,N,12147.24321,W,0.039,112.17,170625,,,A*75 2025-06-17T16:47:42.683Z,1750178862.683 [NAL9602](INFO): GPS fix at 20250617T164741: (36.802368, -121.787387) 2025-06-17T16:47:45.910Z,1750178865.910 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,164744.00,A,3648.14198,N,12147.24308,W,0.505,112.17,170625,,,A*7B 2025-06-17T16:47:45.913Z,1750178865.913 [NAL9602](INFO): GPS fix at 20250617T164744: (36.802366, -121.787385) 2025-06-17T16:47:48.740Z,1750178868.740 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,164747.00,A,3648.14180,N,12147.24327,W,0.447,112.17,170625,,,A*7B 2025-06-17T16:47:48.742Z,1750178868.742 [NAL9602](INFO): GPS fix at 20250617T164747: (36.802363, -121.787388) 2025-06-17T16:47:51.970Z,1750178871.970 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,164750.00,A,3648.14174,N,12147.24289,W,0.369,112.17,170625,,,A*78 2025-06-17T16:47:51.973Z,1750178871.973 [NAL9602](INFO): GPS fix at 20250617T164750: (36.802362, -121.787381) 2025-06-17T16:47:54.801Z,1750178874.801 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,164753.00,A,3648.14100,N,12147.24012,W,2.119,135.66,170625,,,A*7C 2025-06-17T16:47:54.803Z,1750178874.803 [NAL9602](INFO): GPS fix at 20250617T164753: (36.802350, -121.787335) 2025-06-17T16:47:58.032Z,1750178878.032 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,164756.00,A,3648.13986,N,12147.23766,W,2.430,109.38,170625,,,A*71 2025-06-17T16:47:58.034Z,1750178878.034 [NAL9602](INFO): GPS fix at 20250617T164756: (36.802331, -121.787294) 2025-06-17T16:48:00.863Z,1750178880.863 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,164759.00,A,3648.13994,N,12147.23460,W,1.652,83.87,170625,,,A*4A 2025-06-17T16:48:00.865Z,1750178880.865 [NAL9602](INFO): GPS fix at 20250617T164759: (36.802332, -121.787243) 2025-06-17T16:48:03.688Z,1750178883.688 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,164802.00,A,3648.14037,N,12147.23204,W,2.527,68.75,170625,,,A*42 2025-06-17T16:48:03.690Z,1750178883.690 [NAL9602](INFO): GPS fix at 20250617T164802: (36.802340, -121.787201) 2025-06-17T16:48:06.921Z,1750178886.921 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,164805.00,A,3648.14152,N,12147.22999,W,2.896,50.25,170625,,,A*40 2025-06-17T16:48:06.924Z,1750178886.924 [NAL9602](INFO): GPS fix at 20250617T164805: (36.802359, -121.787166) 2025-06-17T16:48:09.757Z,1750178889.757 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,164808.00,A,3648.14403,N,12147.22856,W,2.916,24.12,170625,,,A*40 2025-06-17T16:48:09.759Z,1750178889.759 [NAL9602](INFO): GPS fix at 20250617T164808: (36.802400, -121.787143) 2025-06-17T16:48:12.979Z,1750178892.979 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,164811.00,A,3648.14636,N,12147.22762,W,2.838,16.69,170625,,,A*44 2025-06-17T16:48:12.989Z,1750178892.989 [NAL9602](INFO): GPS fix at 20250617T164811: (36.802439, -121.787127) 2025-06-17T16:48:15.810Z,1750178895.810 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,164814.00,A,3648.14854,N,12147.22640,W,2.488,22.56,170625,,,A*46 2025-06-17T16:48:15.812Z,1750178895.812 [NAL9602](INFO): GPS fix at 20250617T164814: (36.802476, -121.787107) 2025-06-17T16:48:19.040Z,1750178899.040 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,164817.00,A,3648.15005,N,12147.22556,W,1.672,24.08,170625,,,A*45 2025-06-17T16:48:19.042Z,1750178899.042 [NAL9602](INFO): GPS fix at 20250617T164817: (36.802501, -121.787093) 2025-06-17T16:48:21.866Z,1750178901.866 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,164820.00,A,3648.15024,N,12147.22538,W,0.039,24.08,170625,,,A*42 2025-06-17T16:48:21.869Z,1750178901.869 [NAL9602](INFO): GPS fix at 20250617T164820: (36.802504, -121.787090) 2025-06-17T16:48:24.699Z,1750178904.699 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,164823.00,A,3648.15009,N,12147.22551,W,0.019,24.08,170625,,,A*43 2025-06-17T16:48:24.701Z,1750178904.701 [NAL9602](INFO): GPS fix at 20250617T164823: (36.802501, -121.787092) 2025-06-17T16:48:27.926Z,1750178907.926 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,164826.00,A,3648.14989,N,12147.22565,W,0.078,24.08,170625,,,A*46 2025-06-17T16:48:27.929Z,1750178907.929 [NAL9602](INFO): GPS fix at 20250617T164826: (36.802498, -121.787094) 2025-06-17T16:48:30.758Z,1750178910.758 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,164829.00,A,3648.14976,N,12147.22581,W,0.039,24.08,170625,,,A*46 2025-06-17T16:48:30.761Z,1750178910.761 [NAL9602](INFO): GPS fix at 20250617T164829: (36.802496, -121.787097) 2025-06-17T16:48:33.987Z,1750178913.987 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,164832.00,A,3648.14959,N,12147.22605,W,0.078,24.08,170625,,,A*4B 2025-06-17T16:48:34.001Z,1750178914.001 [NAL9602](INFO): GPS fix at 20250617T164832: (36.802493, -121.787101) 2025-06-17T16:48:36.817Z,1750178916.817 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,164835.00,A,3648.14949,N,12147.22626,W,0.058,24.08,170625,,,A*4E 2025-06-17T16:48:36.819Z,1750178916.819 [NAL9602](INFO): GPS fix at 20250617T164835: (36.802492, -121.787104) 2025-06-17T16:48:40.055Z,1750178920.055 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,164838.00,A,3648.14942,N,12147.22646,W,0.078,24.08,170625,,,A*4C 2025-06-17T16:48:40.057Z,1750178920.057 [NAL9602](INFO): GPS fix at 20250617T164838: (36.802490, -121.787108) 2025-06-17T16:48:42.874Z,1750178922.874 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,164841.00,A,3648.14939,N,12147.22656,W,0.019,24.08,170625,,,A*48 2025-06-17T16:48:42.877Z,1750178922.877 [NAL9602](INFO): GPS fix at 20250617T164841: (36.802490, -121.787109) 2025-06-17T16:48:45.702Z,1750178925.702 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,164844.00,A,3648.14941,N,12147.22666,W,0.019,24.08,170625,,,A*41 2025-06-17T16:48:45.705Z,1750178925.705 [NAL9602](INFO): GPS fix at 20250617T164844: (36.802490, -121.787111) 2025-06-17T16:48:48.943Z,1750178928.943 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,164847.00,A,3648.14938,N,12147.22676,W,0.019,24.08,170625,,,A*4D 2025-06-17T16:48:48.946Z,1750178928.946 [NAL9602](INFO): GPS fix at 20250617T164847: (36.802490, -121.787113) 2025-06-17T16:48:51.771Z,1750178931.771 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,164850.00,A,3648.14975,N,12147.22625,W,0.019,24.08,170625,,,A*44 2025-06-17T16:48:51.773Z,1750178931.773 [NAL9602](INFO): GPS fix at 20250617T164850: (36.802496, -121.787104) 2025-06-17T16:48:54.996Z,1750178934.996 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,164853.00,A,3648.14983,N,12147.22616,W,0.000,24.08,170625,,,A*46 2025-06-17T16:48:54.998Z,1750178934.998 [NAL9602](INFO): GPS fix at 20250617T164853: (36.802497, -121.787103) 2025-06-17T16:48:57.822Z,1750178937.822 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,164856.00,A,3648.14975,N,12147.22608,W,0.000,24.08,170625,,,A*45 2025-06-17T16:48:57.825Z,1750178937.825 [NAL9602](INFO): GPS fix at 20250617T164856: (36.802496, -121.787101) 2025-06-17T16:49:01.054Z,1750178941.054 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,164859.00,A,3648.14969,N,12147.22602,W,0.000,24.08,170625,,,A*4D 2025-06-17T16:49:01.057Z,1750178941.057 [NAL9602](INFO): GPS fix at 20250617T164859: (36.802495, -121.787100) 2025-06-17T16:49:03.903Z,1750178943.903 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,164902.00,A,3648.14961,N,12147.22594,W,0.019,24.08,170625,,,A*4E 2025-06-17T16:49:03.905Z,1750178943.905 [NAL9602](INFO): GPS fix at 20250617T164902: (36.802493, -121.787099) 2025-06-17T16:49:06.721Z,1750178946.721 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,164905.00,A,3648.14956,N,12147.22592,W,0.019,24.08,170625,,,A*4B 2025-06-17T16:49:06.723Z,1750178946.723 [NAL9602](INFO): GPS fix at 20250617T164905: (36.802493, -121.787099) 2025-06-17T16:49:09.942Z,1750178949.942 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,164908.00,A,3648.14960,N,12147.22589,W,0.019,24.08,170625,,,A*49 2025-06-17T16:49:09.954Z,1750178949.954 [NAL9602](INFO): GPS fix at 20250617T164908: (36.802493, -121.787098) 2025-06-17T16:49:12.774Z,1750178952.774 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,164911.00,A,3648.14970,N,12147.22584,W,0.019,24.08,170625,,,A*4D 2025-06-17T16:49:12.776Z,1750178952.776 [NAL9602](INFO): GPS fix at 20250617T164911: (36.802495, -121.787097) 2025-06-17T16:49:16.005Z,1750178956.005 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,164914.00,A,3648.14987,N,12147.22587,W,0.039,24.08,170625,,,A*41 2025-06-17T16:49:16.007Z,1750178956.007 [NAL9602](INFO): GPS fix at 20250617T164914: (36.802498, -121.787098) 2025-06-17T16:49:18.832Z,1750178958.832 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,164917.00,A,3648.15006,N,12147.22592,W,0.019,24.08,170625,,,A*45 2025-06-17T16:49:18.835Z,1750178958.835 [NAL9602](INFO): GPS fix at 20250617T164917: (36.802501, -121.787099) 2025-06-17T16:49:20.887Z,1750178960.887 [IBIT](FAULT): Error acquiring IBIT communications status. Timeout expired. 2025-06-17T16:49:21.304Z,1750178961.304 [IBIT](IMPORTANT): Battery Status: Battery Charge (AH): 0.000000 Voltage: 16.452999 2025-06-17T16:49:21.305Z,1750178961.305 [IBIT](IMPORTANT): batteryCapacityThreshold: 50.000000 Ah 2025-06-17T16:49:21.305Z,1750178961.305 [IBIT](IMPORTANT): batteryVoltageThreshold: 13.700000 V 2025-06-17T16:49:21.713Z,1750178961.713 [IBIT](IMPORTANT): bitHumidityThreshold: 55.000000 % 2025-06-17T16:49:21.713Z,1750178961.713 [IBIT](IMPORTANT): bitPressureThreshold: 0.750000 psi 2025-06-17T16:49:21.713Z,1750178961.713 [IBIT](IMPORTANT): Pressure:9.546252 PSI 2025-06-17T16:49:21.713Z,1750178961.713 [IBIT](IMPORTANT): Humidity:17.623001 % 2025-06-17T16:49:22.062Z,1750178962.062 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,164920.00,A,3648.15027,N,12147.22595,W,0.272,24.08,170625,,,D*4F 2025-06-17T16:49:22.065Z,1750178962.065 [NAL9602](INFO): GPS fix at 20250617T164920: (36.802504, -121.787099) 2025-06-17T16:49:22.141Z,1750178962.141 [IBIT](IMPORTANT): Vehicle Pitch:-0.567973 degrees 2025-06-17T16:49:22.141Z,1750178962.141 [IBIT](IMPORTANT): Vehicle Roll:-3.781936 degrees 2025-06-17T16:49:22.141Z,1750178962.141 [IBIT](IMPORTANT): Vehicle Heading:21.506557 degrees 2025-06-17T16:49:22.529Z,1750178962.529 [IBIT](IMPORTANT): surfaceThreshold: 1.000000 m 2025-06-17T16:49:22.529Z,1750178962.529 [IBIT](IMPORTANT): buoyancyNeutral: 251.216003 cc 2025-06-17T16:49:22.529Z,1750178962.529 [IBIT](IMPORTANT): massDefault: -0.140458 cm 2025-06-17T16:49:22.529Z,1750178962.529 [IBIT](IMPORTANT): stopDepth: 275.000000 m 2025-06-17T16:49:22.530Z,1750178962.530 [IBIT](IMPORTANT): abortDepth: 300.000000 m 2025-06-17T16:49:22.530Z,1750178962.530 [IBIT](IMPORTANT): IBIT FAILED 2025-06-17T16:49:22.892Z,1750178962.892 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-06-17T16:49:22.892Z,1750178962.892 [Default:CheckIn:C.Wait] Stopped 2025-06-17T16:49:22.892Z,1750178962.892 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-06-17T16:49:22.892Z,1750178962.892 [Default:CheckIn:D] Running Loop=1 2025-06-17T16:49:23.311Z,1750178963.311 [Default:CheckIn:D] Stopped 2025-06-17T16:49:23.311Z,1750178963.311 [Default:CheckIn:E] Running Loop=1 2025-06-17T16:49:23.728Z,1750178963.728 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 11.911143 min 2025-06-17T16:49:23.728Z,1750178963.728 [Default:CheckIn:E] Stopped 2025-06-17T16:49:23.728Z,1750178963.728 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-06-17T16:49:23.728Z,1750178963.728 [Default:CheckIn] Stopped 2025-06-17T16:49:23.728Z,1750178963.728 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-06-17T16:49:23.728Z,1750178963.728 [Default:CheckIn](INFO): Running loop #2 2025-06-17T16:49:23.728Z,1750178963.728 [Default:CheckIn] Running Loop=2 2025-06-17T16:49:23.728Z,1750178963.728 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-06-17T16:49:23.728Z,1750178963.728 [Default:CheckIn:Read_GPS] Running Loop=1 2025-06-17T16:49:26.105Z,1750178966.105 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,164924.00,A,3648.15059,N,12147.22608,W,0.039,24.08,170625,,,D*48 2025-06-17T16:49:26.108Z,1750178966.108 [NAL9602](INFO): GPS fix at 20250617T164924: (36.802510, -121.787101) 2025-06-17T16:49:26.118Z,1750178966.118 [Default:CheckIn:Read_GPS] Stopped 2025-06-17T16:49:26.118Z,1750178966.118 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-06-17T16:49:33.335Z,1750178973.335 [DataOverHttps](INFO): Sending 223 bytes from file Logs/20250617T163356/Courier0007.lzma 2025-06-17T16:49:34.337Z,1750178974.337 [DataOverHttps](INFO): Moved sent file to Logs/20250617T163356/Courier0007.lzma.bak 2025-06-17T16:49:34.338Z,1750178974.338 [DataOverHttps](INFO): SBD MOMSN=25221849 2025-06-17T16:49:50.290Z,1750178990.290 [DataOverHttps](INFO): Sending 1605 bytes from file Logs/20250617T163356/Express0008.lzma 2025-06-17T16:49:51.289Z,1750178991.289 [DataOverHttps](INFO): Moved sent file to Logs/20250617T163356/Express0008.lzma.bak 2025-06-17T16:49:51.289Z,1750178991.289 [DataOverHttps](INFO): SBD MOMSN=25221852 2025-06-17T16:49:58.426Z,1750178998.426 [NAL9602](INFO): Not Powering down - fast GPS 2025-06-17T16:50:07.455Z,1750179007.455 [DataOverHttps](INFO): Sending 61 bytes from file Logs/20250617T163356/Express0011.lzma 2025-06-17T16:50:08.457Z,1750179008.457 [DataOverHttps](INFO): Moved sent file to Logs/20250617T163356/Express0011.lzma.bak 2025-06-17T16:50:08.457Z,1750179008.457 [DataOverHttps](INFO): SBD MOMSN=25221922 2025-06-17T16:50:09.750Z,1750179009.750 [Default:CheckIn:Read_Iridium] Stopped 2025-06-17T16:50:09.750Z,1750179009.750 [Default:CheckIn:C.Wait] Running Loop=1 2025-06-17T16:50:09.750Z,1750179009.750 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2025-06-17T16:53:50.029Z,1750179230.029 [DataOverHttps](IMPORTANT): SBD MTMSN=20250617T165349 2025-06-17T16:53:57.456Z,1750179237.456 [DataOverHttps](INFO): Received command: ibit 2025-06-17T16:53:57.480Z,1750179237.480 [CommandExec](IMPORTANT): got command ibit 2025-06-17T16:53:57.635Z,1750179237.635 [IBIT](IMPORTANT): Beginning Initiated BIT 2025-06-17T16:53:57.636Z,1750179237.636 [IBIT](IMPORTANT): Beginning control surface checks. 2025-06-17T16:53:57.639Z,1750179237.639 [GFScanner](IMPORTANT): Beginning ground fault scan 2025-06-17T16:53:59.234Z,1750179239.234 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,165357.00,A,3648.14994,N,12147.22404,W,0.058,24.08,170625,,,D*47 2025-06-17T16:53:59.245Z,1750179239.245 [NAL9602](INFO): GPS fix at 20250617T165357: (36.802499, -121.787067) 2025-06-17T16:54:02.252Z,1750179242.252 [GFScanner](IMPORTANT): Ground fault detected mA: CHAN A0 (Batt): 0.037991 CHAN A1 (24V): 0.057779 CHAN A2 (12V): 0.023357 CHAN A3 (5V): 0.003728 CHAN B0 (3.3V): 0.003186 CHAN B1 (3.15aV): 0.002390 CHAN B2 (3.15bV): 0.002820 CHAN B3 (GND): -0.005117 OPEN: 0.006528 Full Scale: +/- 1 mA 2025-06-17T16:54:25.900Z,1750179265.900 [NAL9602](INFO): SBD MO Status=0, MOMSN=9488, MT Status=0, MTMSN=0 2025-06-17T16:54:25.901Z,1750179265.901 [NAL9602](INFO): No messages in MT queue 2025-06-17T16:54:27.111Z,1750179267.111 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,165425.00,A,3648.15023,N,12147.22398,W,0.117,24.08,170625,,,D*49 2025-06-17T16:54:27.113Z,1750179267.113 [NAL9602](INFO): GPS fix at 20250617T165425: (36.802504, -121.787066) 2025-06-17T16:54:29.959Z,1750179269.959 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,165428.00,A,3648.15026,N,12147.22395,W,0.019,24.08,170625,,,D*43 2025-06-17T16:54:29.961Z,1750179269.961 [NAL9602](INFO): GPS fix at 20250617T165428: (36.802504, -121.787066) 2025-06-17T16:54:32.798Z,1750179272.798 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,165431.00,A,3648.15041,N,12147.22395,W,0.039,24.08,170625,,,D*48 2025-06-17T16:54:32.801Z,1750179272.801 [NAL9602](INFO): GPS fix at 20250617T165431: (36.802507, -121.787066) 2025-06-17T16:54:36.015Z,1750179276.015 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,165434.00,A,3648.15058,N,12147.22393,W,0.019,24.08,170625,,,D*41 2025-06-17T16:54:36.018Z,1750179276.018 [NAL9602](INFO): GPS fix at 20250617T165434: (36.802510, -121.787065) 2025-06-17T16:54:38.867Z,1750179278.867 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,165437.00,A,3648.15074,N,12147.22394,W,0.019,24.08,170625,,,D*4B 2025-06-17T16:54:38.869Z,1750179278.869 [NAL9602](INFO): GPS fix at 20250617T165437: (36.802512, -121.787066) 2025-06-17T16:54:42.071Z,1750179282.071 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,165440.00,A,3648.15089,N,12147.22401,W,0.019,24.08,170625,,,D*42 2025-06-17T16:54:42.073Z,1750179282.073 [NAL9602](INFO): GPS fix at 20250617T165440: (36.802515, -121.787067) 2025-06-17T16:54:44.114Z,1750179284.114 [IBIT](IMPORTANT): Communications Status: Fix Status: 1 Iridium Signal Strength: 5 Latitude: 36.802513 Longitude: -121.787064 2025-06-17T16:54:44.533Z,1750179284.533 [IBIT](IMPORTANT): Battery Status: Battery Charge (AH): 0.000000 Voltage: 16.452999 2025-06-17T16:54:44.533Z,1750179284.533 [IBIT](IMPORTANT): batteryCapacityThreshold: 50.000000 Ah 2025-06-17T16:54:44.534Z,1750179284.534 [IBIT](IMPORTANT): batteryVoltageThreshold: 13.700000 V 2025-06-17T16:54:44.899Z,1750179284.899 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,165443.00,A,3648.15108,N,12147.22412,W,0.000,24.08,170625,,,D*43 2025-06-17T16:54:44.906Z,1750179284.906 [NAL9602](INFO): GPS fix at 20250617T165443: (36.802518, -121.787069) 2025-06-17T16:54:44.954Z,1750179284.954 [IBIT](IMPORTANT): bitHumidityThreshold: 55.000000 % 2025-06-17T16:54:44.954Z,1750179284.954 [IBIT](IMPORTANT): bitPressureThreshold: 0.750000 psi 2025-06-17T16:54:44.954Z,1750179284.954 [IBIT](IMPORTANT): Pressure:9.586382 PSI 2025-06-17T16:54:44.955Z,1750179284.955 [IBIT](IMPORTANT): Humidity:17.561958 % 2025-06-17T16:54:45.341Z,1750179285.341 [IBIT](IMPORTANT): Vehicle Pitch:-0.581185 degrees 2025-06-17T16:54:45.341Z,1750179285.341 [IBIT](IMPORTANT): Vehicle Roll:-3.771556 degrees 2025-06-17T16:54:45.341Z,1750179285.341 [IBIT](IMPORTANT): Vehicle Heading:21.520826 degrees 2025-06-17T16:54:45.736Z,1750179285.736 [IBIT](IMPORTANT): surfaceThreshold: 1.000000 m 2025-06-17T16:54:45.737Z,1750179285.737 [IBIT](IMPORTANT): buoyancyNeutral: 251.216003 cc 2025-06-17T16:54:45.737Z,1750179285.737 [IBIT](IMPORTANT): massDefault: -0.140458 cm 2025-06-17T16:54:45.737Z,1750179285.737 [IBIT](IMPORTANT): stopDepth: 275.000000 m 2025-06-17T16:54:45.738Z,1750179285.738 [IBIT](IMPORTANT): abortDepth: 300.000000 m 2025-06-17T16:54:45.738Z,1750179285.738 [IBIT](IMPORTANT): IBIT PASSED 2025-06-17T16:55:10.368Z,1750179310.368 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2025-06-17T16:55:10.368Z,1750179310.368 [Default:CheckIn:C.Wait] Stopped 2025-06-17T16:55:10.368Z,1750179310.368 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2025-06-17T16:55:10.368Z,1750179310.368 [Default:CheckIn:D] Running Loop=1 2025-06-17T16:55:10.766Z,1750179310.766 [Default:CheckIn:D] Stopped 2025-06-17T16:55:10.766Z,1750179310.766 [Default:CheckIn:E] Running Loop=1 2025-06-17T16:55:11.168Z,1750179311.168 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 17.702067 min 2025-06-17T16:55:11.168Z,1750179311.168 [Default:CheckIn:E] Stopped 2025-06-17T16:55:11.168Z,1750179311.168 [Default:CheckIn](INFO): Completed Default:CheckIn 2025-06-17T16:55:11.168Z,1750179311.168 [Default:CheckIn] Stopped 2025-06-17T16:55:11.168Z,1750179311.168 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2025-06-17T16:55:11.168Z,1750179311.168 [Default:CheckIn](INFO): Running loop #3 2025-06-17T16:55:11.168Z,1750179311.168 [Default:CheckIn] Running Loop=3 2025-06-17T16:55:11.168Z,1750179311.168 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2025-06-17T16:55:11.169Z,1750179311.169 [Default:CheckIn:Read_GPS] Running Loop=1 2025-06-17T16:55:13.181Z,1750179313.181 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,165511.00,A,3648.15143,N,12147.22456,W,0.039,24.08,170625,,,D*40 2025-06-17T16:55:13.183Z,1750179313.183 [NAL9602](INFO): GPS fix at 20250617T165511: (36.802524, -121.787076) 2025-06-17T16:55:13.198Z,1750179313.198 [Default:CheckIn:Read_GPS] Stopped 2025-06-17T16:55:13.198Z,1750179313.198 [Default:CheckIn:Read_Iridium] Running Loop=1 2025-06-17T16:55:20.839Z,1750179320.839 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20250617T163356/Courier0013.lzma 2025-06-17T16:55:21.841Z,1750179321.841 [DataOverHttps](INFO): Moved sent file to Logs/20250617T163356/Courier0013.lzma.bak 2025-06-17T16:55:21.841Z,1750179321.841 [DataOverHttps](INFO): SBD MOMSN=25221970 2025-06-17T16:55:37.671Z,1750179337.671 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20250617T163356/Courier0016.lzma 2025-06-17T16:55:38.673Z,1750179338.673 [DataOverHttps](INFO): Moved sent file to Logs/20250617T163356/Courier0016.lzma.bak 2025-06-17T16:55:38.673Z,1750179338.673 [DataOverHttps](INFO): SBD MOMSN=25221973 2025-06-17T16:55:45.506Z,1750179345.506 [NAL9602](INFO): Not Powering down - fast GPS 2025-06-17T16:55:47.133Z,1750179347.133 [CommandExec](IMPORTANT): got command restart system 2025-06-17T16:55:49.196Z,1750179349.196 [Supervisor](INFO): Stop Mission called by Supervisor::terminate 2025-06-17T16:55:49.196Z,1750179349.196 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2025-06-17T16:55:49.196Z,1750179349.196 [CommandExec](INFO): Uninitializing the command executive. 2025-06-17T16:55:49.196Z,1750179349.196 [CommandExec](INFO): Uninitializing the command scheduler. 2025-06-17T16:55:49.197Z,1750179349.197 [CommandExec ThreadHandler](INFO): Thread cancelled. 2025-06-17T16:55:49.215Z,1750179349.215 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2025-06-17T16:55:49.216Z,1750179349.216 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2025-06-17T16:55:49.216Z,1750179349.216 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2025-06-17T16:55:49.216Z,1750179349.216 [NavChartDb](INFO): Join timeout helper Thread ID is 3121 2025-06-17T16:55:49.376Z,1750179349.376 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2025-06-17T16:55:49.376Z,1750179349.376 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2025-06-17T16:55:49.384Z,1750179349.384 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2025-06-17T16:55:49.385Z,1750179349.385 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2025-06-17T16:55:49.385Z,1750179349.385 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 3122 2025-06-17T16:55:49.424Z,1750179349.424 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2025-06-17T16:55:49.424Z,1750179349.424 [WetLabsBB2FL](INFO): Powering down 2025-06-17T16:55:49.425Z,1750179349.425 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2025-06-17T16:55:49.428Z,1750179349.428 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2025-06-17T16:55:49.428Z,1750179349.428 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2025-06-17T16:55:49.428Z,1750179349.428 [CTD_Seabird](INFO): Join timeout helper Thread ID is 3123 2025-06-17T16:55:50.360Z,1750179350.360 [CTD_Seabird](INFO): Powering down 2025-06-17T16:55:50.372Z,1750179350.372 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2025-06-17T16:55:50.372Z,1750179350.372 [CTD_Seabird](INFO): Powering down 2025-06-17T16:55:50.384Z,1750179350.384 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2025-06-17T16:55:50.403Z,1750179350.403 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2025-06-17T16:55:50.404Z,17501