2025-01-16T00:36:02.418Z,1736987762.418 [Supervisor](DEBUG): Initializing supervisor. 2025-01-16T00:36:02.422Z,1736987762.422 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2025-01-16T00:36:02.423Z,1736987762.423 [SyncHandler](INFO): Protected caller Thread ID is 839 2025-01-16T00:36:02.423Z,1736987762.423 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2025-01-16T00:36:02.424Z,1736987762.424 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2025-01-16T00:36:02.425Z,1736987762.425 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 840 2025-01-16T00:36:02.429Z,1736987762.429 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2025-01-16T00:36:02.446Z,1736987762.446 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2025-01-16T00:36:02.447Z,1736987762.447 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2025-01-16T00:36:02.447Z,1736987762.447 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 841 2025-01-16T00:36:02.452Z,1736987762.452 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2025-01-16T00:36:02.453Z,1736987762.453 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2025-01-16T00:36:02.453Z,1736987762.453 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 842 2025-01-16T00:36:02.455Z,1736987762.455 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2025-01-16T00:36:02.456Z,1736987762.456 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2025-01-16T00:36:02.456Z,1736987762.456 [logger ThreadHandler](INFO): Protected caller Thread ID is 843 2025-01-16T00:36:02.460Z,1736987762.460 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2025-01-16T00:36:02.461Z,1736987762.461 [Supervisor](INFO): Looking for Config files in directory: Config/ 2025-01-16T00:36:02.465Z,1736987762.465 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2025-01-16T00:36:02.752Z,1736987762.752 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2025-01-16T00:36:02.754Z,1736987762.754 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2025-01-16T00:36:02.971Z,1736987762.971 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2025-01-16T00:36:02.973Z,1736987762.973 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2025-01-16T00:36:03.078Z,1736987763.078 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2025-01-16T00:36:03.080Z,1736987763.080 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2025-01-16T00:36:03.270Z,1736987763.270 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2025-01-16T00:36:03.271Z,1736987763.271 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2025-01-16T00:36:03.771Z,1736987763.771 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2025-01-16T00:36:03.773Z,1736987763.773 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2025-01-16T00:36:03.889Z,1736987763.889 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2025-01-16T00:36:03.891Z,1736987763.891 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2025-01-16T00:36:04.169Z,1736987764.169 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2025-01-16T00:36:04.169Z,1736987764.169 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2025-01-16T00:36:04.388Z,1736987764.388 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2025-01-16T00:36:04.389Z,1736987764.389 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2025-01-16T00:36:04.928Z,1736987764.928 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2025-01-16T00:36:04.929Z,1736987764.929 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2025-01-16T00:36:05.371Z,1736987765.371 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2025-01-16T00:36:05.371Z,1736987765.371 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2025-01-16T00:36:12.662Z,1736987772.662 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2025-01-16T00:36:13.132Z,1736987773.132 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2025-01-16T00:36:13.132Z,1736987773.132 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2025-01-16T00:36:13.955Z,1736987773.955 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2025-01-16T00:36:13.956Z,1736987773.956 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2025-01-16T00:36:14.806Z,1736987774.806 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2025-01-16T00:36:14.807Z,1736987774.807 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2025-01-16T00:36:15.160Z,1736987775.160 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2025-01-16T00:36:15.161Z,1736987775.161 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2025-01-16T00:36:15.253Z,1736987775.253 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-aku/ 2025-01-16T00:36:15.255Z,1736987775.255 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/secure.cfg 2025-01-16T00:36:15.348Z,1736987775.348 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/logger.cfg 2025-01-16T00:36:15.464Z,1736987775.464 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/vehicle.cfg 2025-01-16T00:36:15.577Z,1736987775.577 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/BIT.cfg 2025-01-16T00:36:15.674Z,1736987775.674 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Simulator.cfg 2025-01-16T00:36:15.769Z,1736987775.769 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Servo.cfg 2025-01-16T00:36:15.881Z,1736987775.881 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Science.cfg 2025-01-16T00:36:16.032Z,1736987776.032 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Sensor.cfg 2025-01-16T00:36:16.206Z,1736987776.206 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Control.cfg 2025-01-16T00:36:16.312Z,1736987776.312 [Supervisor](INFO): Opening Config file at: Config/lrauv-aku/Battery.cfg 2025-01-16T00:36:16.586Z,1736987776.586 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2025-01-16T00:36:16.587Z,1736987776.587 [Supervisor](FAULT): Ignoring configuration overrides from Data/persisted.cfg 2025-01-16T00:36:16.592Z,1736987776.592 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2025-01-16T00:36:17.010Z,1736987777.010 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2025-01-16T00:36:17.011Z,1736987777.011 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2025-01-16T00:36:18.017Z,1736987778.017 [AHRS_M2] Loaded 2025-01-16T00:36:18.017Z,1736987778.017 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2025-01-16T00:36:18.270Z,1736987778.270 [BackseatComponent] Loaded 2025-01-16T00:36:18.270Z,1736987778.270 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2025-01-16T00:36:18.271Z,1736987778.271 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 408AA4E0 2025-01-16T00:36:18.272Z,1736987778.272 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 923 2025-01-16T00:36:18.275Z,1736987778.275 [LcmUniversalReporter] Loaded 2025-01-16T00:36:18.275Z,1736987778.275 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread. 2025-01-16T00:36:18.281Z,1736987778.281 [BioacousticsDataBridge] Loaded 2025-01-16T00:36:18.281Z,1736987778.281 [ComponentRegistry](DEBUG): SyncComponent "BioacousticsDataBridge" handled in the control thread. 2025-01-16T00:36:19.088Z,1736987779.088 [BPC1] Loaded 2025-01-16T00:36:19.089Z,1736987779.089 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2025-01-16T00:36:19.183Z,1736987779.183 [DAT] Loaded 2025-01-16T00:36:19.183Z,1736987779.183 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread. 2025-01-16T00:36:19.184Z,1736987779.184 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 408DA4E0 2025-01-16T00:36:19.185Z,1736987779.185 [DAT ThreadHandler](INFO): Protected caller Thread ID is 924 2025-01-16T00:36:19.512Z,1736987779.512 [DataOverHttps] Loaded 2025-01-16T00:36:19.512Z,1736987779.512 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2025-01-16T00:36:19.513Z,1736987779.513 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 4090A4E0 2025-01-16T00:36:19.514Z,1736987779.514 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 925 2025-01-16T00:36:19.536Z,1736987779.536 [Depth_Keller] Loaded 2025-01-16T00:36:19.537Z,1736987779.537 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2025-01-16T00:36:19.541Z,1736987779.541 [DropWeight] Loaded 2025-01-16T00:36:19.542Z,1736987779.542 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2025-01-16T00:36:19.605Z,1736987779.605 [NAL9602] Loaded 2025-01-16T00:36:19.606Z,1736987779.606 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2025-01-16T00:36:19.635Z,1736987779.635 [Onboard] Loaded 2025-01-16T00:36:19.635Z,1736987779.635 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2025-01-16T00:36:19.636Z,1736987779.636 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 4093A4E0 2025-01-16T00:36:19.637Z,1736987779.637 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 926 2025-01-16T00:36:19.650Z,1736987779.650 [Power24vConverter] Loaded 2025-01-16T00:36:19.651Z,1736987779.651 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2025-01-16T00:36:19.667Z,1736987779.667 [Radio_Surface] Loaded 2025-01-16T00:36:19.667Z,1736987779.667 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2025-01-16T00:36:19.669Z,1736987779.669 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 4096A4E0 2025-01-16T00:36:19.669Z,1736987779.669 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 927 2025-01-16T00:36:19.684Z,1736987779.684 [Sonardyne_Nano] Loaded 2025-01-16T00:36:19.684Z,1736987779.684 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread. 2025-01-16T00:36:19.685Z,1736987779.685 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2025-01-16T00:36:19.685Z,1736987779.685 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2025-01-16T00:36:22.587Z,1736987782.587 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2025-01-16T00:36:23.437Z,1736987783.437 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2025-01-16T00:36:24.401Z,1736987784.401 [VerticalControl](DEBUG): Construct VerticalControl. 2025-01-16T00:36:24.460Z,1736987784.460 [VerticalControl] Loaded 2025-01-16T00:36:24.460Z,1736987784.460 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2025-01-16T00:36:24.463Z,1736987784.463 [HorizontalControl](DEBUG): Construct HorizontalControl. 2025-01-16T00:36:24.511Z,1736987784.511 [HorizontalControl] Loaded 2025-01-16T00:36:24.511Z,1736987784.511 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2025-01-16T00:36:24.513Z,1736987784.513 [SpeedControl](DEBUG): Construct SpeedControl. 2025-01-16T00:36:24.517Z,1736987784.517 [SpeedControl] Loaded 2025-01-16T00:36:24.517Z,1736987784.517 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2025-01-16T00:36:24.520Z,1736987784.520 [LoopControl](DEBUG): Construct LoopControl. 2025-01-16T00:36:24.520Z,1736987784.520 [LoopControl] Loaded 2025-01-16T00:36:24.521Z,1736987784.521 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2025-01-16T00:36:24.521Z,1736987784.521 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2025-01-16T00:36:24.522Z,1736987784.522 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2025-01-16T00:36:24.538Z,1736987784.538 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2025-01-16T00:36:24.539Z,1736987784.539 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2025-01-16T00:36:24.583Z,1736987784.583 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2025-01-16T00:36:24.584Z,1736987784.584 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2025-01-16T00:36:24.724Z,1736987784.724 [DeadReckonUsingMultipleVelocitySources] Loaded 2025-01-16T00:36:24.724Z,1736987784.724 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2025-01-16T00:36:24.738Z,1736987784.738 [NavChart] Loaded 2025-01-16T00:36:24.738Z,1736987784.738 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2025-01-16T00:36:24.744Z,1736987784.744 [UniversalFixResidualReporter] Loaded 2025-01-16T00:36:24.744Z,1736987784.744 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2025-01-16T00:36:24.745Z,1736987784.745 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2025-01-16T00:36:24.746Z,1736987784.746 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2025-01-16T00:36:24.919Z,1736987784.919 [SBIT](DEBUG): Construct Startup Built In Test. 2025-01-16T00:36:24.928Z,1736987784.928 [SBIT] Loaded 2025-01-16T00:36:24.928Z,1736987784.928 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2025-01-16T00:36:24.931Z,1736987784.931 [IBIT](DEBUG): Construct Initiated Built In Test. 2025-01-16T00:36:24.944Z,1736987784.944 [IBIT] Loaded 2025-01-16T00:36:24.944Z,1736987784.944 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2025-01-16T00:36:24.950Z,1736987784.950 [CBIT](DEBUG): Construct Continuous Built In Test. 2025-01-16T00:36:25.055Z,1736987785.055 [CBIT] Loaded 2025-01-16T00:36:25.056Z,1736987785.056 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2025-01-16T00:36:25.056Z,1736987785.056 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2025-01-16T00:36:25.057Z,1736987785.057 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2025-01-16T00:36:25.281Z,1736987785.281 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2025-01-16T00:36:25.282Z,1736987785.282 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2025-01-16T00:36:25.462Z,1736987785.462 [BuoyancyServo] Loaded 2025-01-16T00:36:25.462Z,1736987785.462 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2025-01-16T00:36:25.485Z,1736987785.485 [ElevatorServo] Loaded 2025-01-16T00:36:25.485Z,1736987785.485 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2025-01-16T00:36:25.506Z,1736987785.506 [MassServo] Loaded 2025-01-16T00:36:25.507Z,1736987785.507 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2025-01-16T00:36:25.528Z,1736987785.528 [RudderServo] Loaded 2025-01-16T00:36:25.528Z,1736987785.528 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2025-01-16T00:36:25.545Z,1736987785.545 [ThrusterHE] Loaded 2025-01-16T00:36:25.546Z,1736987785.546 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread. 2025-01-16T00:36:25.546Z,1736987785.546 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2025-01-16T00:36:25.546Z,1736987785.546 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2025-01-16T00:36:25.775Z,1736987785.775 [CTD_Seabird] Loaded 2025-01-16T00:36:25.775Z,1736987785.775 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2025-01-16T00:36:25.776Z,1736987785.776 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40B924E0 2025-01-16T00:36:25.776Z,1736987785.776 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 928 2025-01-16T00:36:25.799Z,1736987785.799 [PAR_Licor] Loaded 2025-01-16T00:36:25.799Z,1736987785.799 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2025-01-16T00:36:25.844Z,1736987785.844 [WetLabsBB2FL] Loaded 2025-01-16T00:36:25.844Z,1736987785.844 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2025-01-16T00:36:25.845Z,1736987785.845 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40BC24E0 2025-01-16T00:36:25.846Z,1736987785.846 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 929 2025-01-16T00:36:25.847Z,1736987785.847 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2025-01-16T00:36:25.847Z,1736987785.847 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2025-01-16T00:36:25.919Z,1736987785.919 [DepthRateCalculator] Loaded 2025-01-16T00:36:25.919Z,1736987785.919 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2025-01-16T00:36:25.924Z,1736987785.924 [PitchRateCalculator] Loaded 2025-01-16T00:36:25.925Z,1736987785.925 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2025-01-16T00:36:25.933Z,1736987785.933 [SpeedCalculator] Loaded 2025-01-16T00:36:25.934Z,1736987785.934 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2025-01-16T00:36:25.938Z,1736987785.938 [YawRateCalculator] Loaded 2025-01-16T00:36:25.938Z,1736987785.938 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2025-01-16T00:36:25.958Z,1736987785.958 [ElevatorOffsetCalculator] Loaded 2025-01-16T00:36:25.958Z,1736987785.958 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2025-01-16T00:36:25.959Z,1736987785.959 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2025-01-16T00:36:25.959Z,1736987785.959 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2025-01-16T00:36:26.046Z,1736987786.046 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2025-01-16T00:36:26.053Z,1736987786.053 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2025-01-16T00:36:26.055Z,1736987786.055 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2025-01-16T00:36:26.067Z,1736987786.067 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2025-01-16T00:36:26.068Z,1736987786.068 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C4F4E0 2025-01-16T00:36:26.068Z,1736987786.068 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 930 2025-01-16T00:36:26.073Z,1736987786.073 [Supervisor](INFO): Main Thread ID is 830 2025-01-16T00:36:26.073Z,1736987786.073 [Supervisor](DEBUG): Running supervisor. 2025-01-16T00:36:26.073Z,1736987786.073 [CommandExec ThreadHandler](INFO): Handler Thread ID is 931 2025-01-16T00:36:26.074Z,1736987786.074 [CommandExec](INFO): Initializing the command executive. 2025-01-16T00:36:26.075Z,1736987786.075 [CommandLine ThreadHandler](INFO): Handler Thread ID is 932 2025-01-16T00:36:26.077Z,1736987786.077 [controlThread ThreadHandler](INFO): Handler Thread ID is 933 2025-01-16T00:36:26.078Z,1736987786.078 [controlThread](DEBUG): Initializing ControlThread 2025-01-16T00:36:26.086Z,1736987786.086 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2025-01-16T00:36:26.088Z,1736987786.088 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2025-01-16T00:36:26.088Z,1736987786.088 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2025-01-16T00:36:26.089Z,1736987786.089 [LoopControl](DEBUG): Initialize LoopControlComponent. 2025-01-16T00:36:26.089Z,1736987786.089 [NavChart](DEBUG): Initialize NavChart Navigation. 2025-01-16T00:36:26.090Z,1736987786.090 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2025-01-16T00:36:26.090Z,1736987786.090 [SBIT](INFO): Initialize SBIT Component. 2025-01-16T00:36:26.090Z,1736987786.090 [SBIT](IMPORTANT): git: 2025-01-07-5-g43d21c9ef 2025-01-16T00:36:26.091Z,1736987786.091 [SBIT](INFO): git hash: 43d21c9efc147f997a8d5d66157a481179a2d63b 2025-01-16T00:36:26.091Z,1736987786.091 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2025-01-16T00:36:26.092Z,1736987786.092 [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 Dec 4 01:17:04 UTC 2024 2025-01-16T00:36:26.094Z,1736987786.094 [SBIT](INFO): Beginning SBIT in 20.000000 seconds. 2025-01-16T00:36:26.094Z,1736987786.094 [IBIT](INFO): Initialize IBIT Component. 2025-01-16T00:36:26.095Z,1736987786.095 [CBIT](DEBUG): Initialize CBIT Component. 2025-01-16T00:36:26.096Z,1736987786.096 [logger ThreadHandler](INFO): Handler Thread ID is 934 2025-01-16T00:36:26.108Z,1736987786.108 [CBIT](DEBUG): Initialized mux pins. 2025-01-16T00:36:26.108Z,1736987786.108 [CBIT](FAULT): LAST RESTART WAS UNINTENTIONAL. 2025-01-16T00:36:26.108Z,1736987786.108 [CBIT](DEBUG): Initializing the watchdog timer. 2025-01-16T00:36:26.116Z,1736987786.116 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 935 2025-01-16T00:36:26.128Z,1736987786.128 [DAT ThreadHandler](INFO): Handler Thread ID is 936 2025-01-16T00:36:26.129Z,1736987786.129 [DAT](INFO): Powering up 2025-01-16T00:36:26.129Z,1736987786.129 [DAT](DEBUG): Initializing DAT. 2025-01-16T00:36:26.132Z,1736987786.132 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2025-01-16T00:36:26.132Z,1736987786.132 [CBIT](DEBUG): Initializing heartbeat. 2025-01-16T00:36:26.134Z,1736987786.134 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 938 2025-01-16T00:36:26.136Z,1736987786.136 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2025-01-16T00:36:26.145Z,1736987786.145 [Onboard ThreadHandler](INFO): Handler Thread ID is 939 2025-01-16T00:36:26.162Z,1736987786.162 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 940 2025-01-16T00:36:26.181Z,1736987786.181 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 941 2025-01-16T00:36:26.181Z,1736987786.181 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2025-01-16T00:36:26.185Z,1736987786.185 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 943 2025-01-16T00:36:26.188Z,1736987786.188 [WetLabsBB2FL](INFO): Powering up 2025-01-16T00:36:26.190Z,1736987786.190 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 945 2025-01-16T00:36:26.200Z,1736987786.200 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2025-01-16T00:36:26.201Z,1736987786.201 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2025-01-16T00:36:26.201Z,1736987786.201 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2025-01-16T00:36:26.201Z,1736987786.201 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2025-01-16T00:36:26.201Z,1736987786.201 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2025-01-16T00:36:26.201Z,1736987786.201 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2025-01-16T00:36:26.201Z,1736987786.201 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2025-01-16T00:36:26.202Z,1736987786.202 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2025-01-16T00:36:26.204Z,1736987786.204 [CBIT](DEBUG): Deactivating GF circuits. 2025-01-16T00:36:26.204Z,1736987786.204 [CBIT](DEBUG): Deactivating emergency mode. 2025-01-16T00:36:26.244Z,1736987786.244 [CBIT](DEBUG): Backplane powered. 2025-01-16T00:36:26.248Z,1736987786.248 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2025-01-16T00:36:26.249Z,1736987786.249 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2025-01-16T00:36:26.249Z,1736987786.249 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2025-01-16T00:36:26.249Z,1736987786.249 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2025-01-16T00:36:26.250Z,1736987786.250 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2025-01-16T00:36:26.251Z,1736987786.251 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser 2025-01-16T00:36:26.251Z,1736987786.251 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl 2025-01-16T00:36:26.252Z,1736987786.252 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl 2025-01-16T00:36:26.264Z,1736987786.264 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl 2025-01-16T00:36:26.340Z,1736987786.340 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into: 2025-01-16T00:36:26.361Z,1736987786.361 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2025-01-16T00:36:26.397Z,1736987786.397 [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-01-16T00:36:26.397Z,1736987786.397 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl 2025-01-16T00:36:26.398Z,1736987786.398 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl 2025-01-16T00:36:26.402Z,1736987786.402 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl 2025-01-16T00:36:26.568Z,1736987786.568 [Radio_Surface](INFO): Powering up 2025-01-16T00:36:26.686Z,1736987786.686 [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-01-16T00:36:26.708Z,1736987786.708 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2025-01-16T00:36:26.710Z,1736987786.710 [Default:A.Wait](DEBUG): Construct Wait. 2025-01-16T00:36:26.712Z,1736987786.712 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2025-01-16T00:36:26.756Z,1736987786.756 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2025-01-16T00:36:26.759Z,1736987786.759 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2025-01-16T00:36:26.773Z,1736987786.773 [Default:E.Execute](DEBUG): Construct Execute. 2025-01-16T00:36:26.792Z,1736987786.792 [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-01-16T00:36:26.797Z,1736987786.797 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BioacousticsDataBridge,BPC1,Depth_Keller,DropWeight,NAL9602,Power24vConverter,Sonardyne_Nano,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,LcmUniversalReporter,Reporter,LogSplitter, 2025-01-16T00:36:26.811Z,1736987786.811 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2025-01-16T00:36:26.911Z,1736987786.911 [Power24vConverter](INFO): Powering up. 2025-01-16T00:36:26.912Z,1736987786.912 [Sonardyne_Nano](INFO): Initializing. 2025-01-16T00:36:26.974Z,1736987786.974 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2025-01-16T00:36:26.980Z,1736987786.980 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2025-01-16T00:36:26.981Z,1736987786.981 [ElevatorServo](DEBUG): Initializing EZServoServo. 2025-01-16T00:36:26.988Z,1736987786.988 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2025-01-16T00:36:26.989Z,1736987786.989 [MassServo](DEBUG): Initializing EZServoServo. 2025-01-16T00:36:26.996Z,1736987786.996 [MassServo](DEBUG): Initializing MassServo. 2025-01-16T00:36:26.997Z,1736987786.997 [RudderServo](DEBUG): Initializing EZServoServo. 2025-01-16T00:36:27.004Z,1736987787.004 [RudderServo](DEBUG): Initializing RudderServo. 2025-01-16T00:36:27.005Z,1736987787.005 [ThrusterHE](DEBUG): Initializing EZServoServo. 2025-01-16T00:36:27.012Z,1736987787.012 [ThrusterHE](DEBUG): Initializing ThrusterHE. 2025-01-16T00:36:28.296Z,1736987788.296 [WetLabsBB2FL](INFO): Powering down 2025-01-16T00:36:29.230Z,1736987789.230 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART 2025-01-16T00:36:30.468Z,1736987790.468 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2409 2025-01-16T00:36:32.721Z,1736987792.721 [ThrusterHE](ERROR): Zero Speed Commanded. 2025-01-16T00:36:33.212Z,1736987793.212 [CTD_Seabird](ERROR): Device message queue exceeded the allowed limit. 2025-01-16T00:36:38.733Z,1736987798.733 [DAT](INFO): DAT read: 2025-01-16T00:36:38.734Z,1736987798.734 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series 2025-01-16T00:36:40.245Z,1736987800.245 [DAT](INFO): DAT read: MF Frequency Band 2025-01-16T00:36:40.246Z,1736987800.246 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.15.0 2025-01-16T00:36:40.247Z,1736987800.247 [DAT](INFO): DAT read: Jan 16 2025 00:32:34 2025-01-16T00:36:41.253Z,1736987801.253 [DAT](INFO): DAT read: Features enabled [Bearing] 2025-01-16T00:36:41.254Z,1736987801.254 [DAT](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP 2025-01-16T00:36:41.255Z,1736987801.255 [DAT](INFO): commRate: 800 2025-01-16T00:36:43.324Z,1736987803.324 [DAT](INFO): entering command mode 2025-01-16T00:36:43.525Z,1736987803.525 [DAT](INFO): DAT read: 2025-01-16T00:36:43.525Z,1736987803.525 [DAT](INFO): DAT read: user:1> 2025-01-16T00:36:43.525Z,1736987803.525 [DAT](INFO): setting verbose to 3 2025-01-16T00:36:43.776Z,1736987803.776 [DAT](INFO): DAT read: user:1> 2025-01-16T00:36:43.778Z,1736987803.778 [DAT](INFO): DAT read: Verbose | 3 2025-01-16T00:36:43.778Z,1736987803.778 [DAT](INFO): set verbose to 3 2025-01-16T00:36:43.778Z,1736987803.778 [DAT](INFO): setting DatVerbose to 27440 2025-01-16T00:36:44.029Z,1736987804.029 [DAT](INFO): DAT read: user:2> 2025-01-16T00:36:44.030Z,1736987804.030 [DAT](INFO): DAT read: DatVerbose | 27440 2025-01-16T00:36:44.030Z,1736987804.030 [DAT](INFO): set DatVerbose to 27440 2025-01-16T00:36:44.030Z,1736987804.030 [DAT](INFO): setting transmit power to 8 2025-01-16T00:36:44.281Z,1736987804.281 [DAT](INFO): DAT read: user:3> 2025-01-16T00:36:44.282Z,1736987804.282 [DAT](INFO): DAT read: TxPower | 8 (Max) 2025-01-16T00:36:44.282Z,1736987804.282 [DAT](INFO): set transmit power to 8 2025-01-16T00:36:44.282Z,1736987804.282 [DAT](INFO): setting local address to 2 2025-01-16T00:36:44.533Z,1736987804.533 [DAT](INFO): DAT read: user:4> 2025-01-16T00:36:44.534Z,1736987804.534 [DAT](INFO): DAT read: LocalAddr | 2 2025-01-16T00:36:44.534Z,1736987804.534 [DAT](INFO): set local address to 2 2025-01-16T00:36:44.535Z,1736987804.535 [DAT](INFO): Setting time to: 0:36:44 And date to:1/16/2025 2025-01-16T00:36:44.785Z,1736987804.785 [DAT](INFO): DAT read: user:5> 2025-01-16T00:36:44.785Z,1736987804.785 [DAT](INFO): DAT read: Thu Jan 16, 2025 00:36:44 2025-01-16T00:36:44.786Z,1736987804.786 [DAT](INFO): Local DAT time set to Thu Jan 16, 2025 00:36:44 2025-01-16T00:36:45.289Z,1736987805.289 [DAT](FAULT): LCB fault: Current Limiter Activated. 2025-01-16T00:36:45.289Z,1736987805.289 [DAT] Hardware Fault, FailCount= 1 2025-01-16T00:36:45.289Z,1736987805.289 [DAT](ERROR): Hardware Fault 2025-01-16T00:36:45.289Z,1736987805.289 [DAT](INFO): Powering down 2025-01-16T00:36:45.437Z,1736987805.437 [CBIT](ERROR): Hardware Fault in component: DAT 2025-01-16T00:36:45.764Z,1736987805.764 [DAT](INFO): Powering down 2025-01-16T00:36:46.168Z,1736987806.168 [DAT](FAULT): LCB fault: Current Limiter Activated. 2025-01-16T00:36:46.635Z,1736987806.635 [SBIT](IMPORTANT): Beginning Startup BIT 2025-01-16T00:36:46.643Z,1736987806.643 [CBIT](INFO): Clearing failed state for component DAT 2025-01-16T00:36:46.648Z,1736987806.648 [DAT] No Fault, FailCount= 1 2025-01-16T00:36:46.648Z,1736987806.648 [CBIT](IMPORTANT): Beginning ground fault scan 2025-01-16T00:36:48.996Z,1736987808.996 [DAT](INFO): Powering up 2025-01-16T00:36:48.997Z,1736987808.997 [DAT](DEBUG): Initializing DAT. 2025-01-16T00:36:49.890Z,1736987809.890 [NAL9602](INFO): Powering up NAL9602 2025-01-16T00:36:58.860Z,1736987818.860 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): 0.001078 CHAN A1 (24V): -0.000680 CHAN A2 (12V): 0.000671 CHAN A3 (5V): -0.001913 CHAN B0 (3.3V): -0.001225 CHAN B1 (3.15aV): -0.001453 CHAN B2 (3.15bV): -0.001803 CHAN B3 (GND): -0.002125 OPEN: 0.004706 Full Scale: +/- 1 mA 2025-01-16T00:37:00.592Z,1736987820.592 [DAT](INFO): DAT read: 2025-01-16T00:37:00.593Z,1736987820.593 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series 2025-01-16T00:37:00.798Z,1736987820.798 [NAL9602](INFO): NAL9602 initialized 2025-01-16T00:37:02.105Z,1736987822.105 [DAT](INFO): DAT read: MF Frequency Band 2025-01-16T00:37:02.106Z,1736987822.106 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.15.0 2025-01-16T00:37:02.107Z,1736987822.107 [DAT](INFO): DAT read: Jan 16 2025 00:36:57 2025-01-16T00:37:03.367Z,1736987823.367 [DAT](INFO): DAT read: Features enabled [Bearing] 2025-01-16T00:37:03.368Z,1736987823.368 [DAT](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP 2025-01-16T00:37:03.368Z,1736987823.368 [DAT](INFO): commRate: 800 2025-01-16T00:37:05.432Z,1736987825.432 [DAT](INFO): entering command mode 2025-01-16T00:37:05.632Z,1736987825.632 [DAT](INFO): DAT read: 2025-01-16T00:37:05.633Z,1736987825.633 [DAT](INFO): DAT read: user:1> 2025-01-16T00:37:05.633Z,1736987825.633 [DAT](INFO): setting verbose to 3 2025-01-16T00:37:05.885Z,1736987825.885 [DAT](INFO): DAT read: user:1> 2025-01-16T00:37:05.886Z,1736987825.886 [DAT](INFO): DAT read: Verbose | 3 2025-01-16T00:37:05.886Z,1736987825.886 [DAT](INFO): set verbose to 3 2025-01-16T00:37:05.886Z,1736987825.886 [DAT](INFO): setting DatVerbose to 27440 2025-01-16T00:37:06.137Z,1736987826.137 [DAT](INFO): DAT read: user:2> 2025-01-16T00:37:06.138Z,1736987826.138 [DAT](INFO): DAT read: DatVerbose | 27440 2025-01-16T00:37:06.138Z,1736987826.138 [DAT](INFO): set DatVerbose to 27440 2025-01-16T00:37:06.138Z,1736987826.138 [DAT](INFO): setting transmit power to 8 2025-01-16T00:37:06.389Z,1736987826.389 [DAT](INFO): DAT read: user:3> 2025-01-16T00:37:06.390Z,1736987826.390 [DAT](INFO): DAT read: TxPower | 8 (Max) 2025-01-16T00:37:06.390Z,1736987826.390 [DAT](INFO): set transmit power to 8 2025-01-16T00:37:06.390Z,1736987826.390 [DAT](INFO): setting local address to 2 2025-01-16T00:37:06.641Z,1736987826.641 [DAT](INFO): DAT read: user:4> 2025-01-16T00:37:06.642Z,1736987826.642 [DAT](INFO): DAT read: LocalAddr | 2 2025-01-16T00:37:06.643Z,1736987826.643 [DAT](INFO): set local address to 2 2025-01-16T00:37:06.643Z,1736987826.643 [DAT](INFO): Setting time to: 0:37:6 And date to:1/16/2025 2025-01-16T00:37:06.893Z,1736987826.893 [DAT](INFO): DAT read: user:5> 2025-01-16T00:37:06.894Z,1736987826.894 [DAT](INFO): DAT read: Thu Jan 16, 2025 00:37:06 2025-01-16T00:37:06.894Z,1736987826.894 [DAT](INFO): Local DAT time set to Thu Jan 16, 2025 00:37:06 2025-01-16T00:37:24.708Z,1736987844.708 [NAL9602](INFO): SBD MO Status=0, MOMSN=11758, MT Status=0, MTMSN=0 2025-01-16T00:37:24.708Z,1736987844.708 [NAL9602](INFO): No messages in MT queue 2025-01-16T00:37:40.718Z,1736987860.718 [SBIT](IMPORTANT): SBIT PASSED 2025-01-16T00:37:40.718Z,1736987860.718 [SBIT](FAULT): Ignoring configuration overrides from Data/persisted.cfg 2025-01-16T00:37:40.966Z,1736987860.966 [MissionManager](IMPORTANT): Started mission Startup 2025-01-16T00:37:40.966Z,1736987860.966 [Startup] Running Loop=1 2025-01-16T00:37:40.966Z,1736987860.966 [Startup](DEBUG): Aggregate::initialize Startup 2025-01-16T00:37:40.966Z,1736987860.966 [Startup:A.GoToSurface] Running Loop=1 2025-01-16T00:37:40.966Z,1736987860.966 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2025-01-16T00:37:40.967Z,1736987860.967 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2025-01-16T00:37:40.967Z,1736987860.967 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2025-01-16T00:37:40.968Z,1736987860.968 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2025-01-16T00:37:40.968Z,1736987860.968 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2025-01-16T00:37:40.969Z,1736987860.969 [Startup:A.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2025-01-16T00:37:40.969Z,1736987860.969 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2025-01-16T00:37:40.971Z,1736987860.971 [Startup:StartupSatComms] Running Loop=1 2025-01-16T00:37:40.971Z,1736987860.971 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2025-01-16T00:37:40.971Z,1736987860.971 [Startup:StartupSatComms:A] Running Loop=1 2025-01-16T00:37:41.379Z,1736987861.379 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2025-01-16T00:38:22.947Z,1736987902.947 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,003820.00,A,3647.85582,N,12150.66577,W,0.292,0.00,160125,,,A*7B 2025-01-16T00:38:22.950Z,1736987902.950 [NAL9602](INFO): GPS fix at 20250116T003820: (36.797597, -121.844430) 2025-01-16T00:38:22.962Z,1736987902.962 [Startup:StartupSatComms:A] Stopped 2025-01-16T00:38:22.962Z,1736987902.962 [Startup:StartupSatComms:B] Running Loop=1 2025-01-16T00:38:23.398Z,1736987903.398 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2025-01-16T00:38:36.537Z,1736987916.537 [NAL9602](IMPORTANT): SBD MO Status=1, MOMSN=11759, MT Status=1, MTMSN=178 2025-01-16T00:38:36.588Z,1736987916.588 [NAL9602](INFO): Sent 74 bytes from file Logs/20250115T234737/Courier0009.lzma 2025-01-16T00:38:36.588Z,1736987916.588 [NAL9602](INFO): Packets left to send: 0