2024-03-11T18:49:19.520Z,1710182959.520 [Supervisor](DEBUG): Initializing supervisor. 2024-03-11T18:49:19.524Z,1710182959.524 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2024-03-11T18:49:19.525Z,1710182959.525 [SyncHandler](INFO): Protected caller Thread ID is 1007 2024-03-11T18:49:19.525Z,1710182959.525 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2024-03-11T18:49:19.527Z,1710182959.527 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2024-03-11T18:49:19.527Z,1710182959.527 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 1008 2024-03-11T18:49:19.532Z,1710182959.532 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2024-03-11T18:49:19.549Z,1710182959.549 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2024-03-11T18:49:19.550Z,1710182959.550 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2024-03-11T18:49:19.551Z,1710182959.551 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 1009 2024-03-11T18:49:19.555Z,1710182959.555 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2024-03-11T18:49:19.556Z,1710182959.556 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2024-03-11T18:49:19.556Z,1710182959.556 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 1010 2024-03-11T18:49:19.558Z,1710182959.558 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2024-03-11T18:49:19.559Z,1710182959.559 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2024-03-11T18:49:19.560Z,1710182959.560 [logger ThreadHandler](INFO): Protected caller Thread ID is 1011 2024-03-11T18:49:19.563Z,1710182959.563 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2024-03-11T18:49:19.564Z,1710182959.564 [Supervisor](INFO): Looking for Config files in directory: Config/ 2024-03-11T18:49:19.565Z,1710182959.565 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2024-03-11T18:49:19.895Z,1710182959.895 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2024-03-11T18:49:19.896Z,1710182959.896 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2024-03-11T18:49:20.632Z,1710182960.632 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2024-03-11T18:49:20.633Z,1710182960.633 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2024-03-11T18:49:20.742Z,1710182960.742 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2024-03-11T18:49:20.742Z,1710182960.742 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2024-03-11T18:49:21.249Z,1710182961.249 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2024-03-11T18:49:21.249Z,1710182961.249 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2024-03-11T18:49:21.347Z,1710182961.347 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2024-03-11T18:49:21.347Z,1710182961.347 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2024-03-11T18:49:21.429Z,1710182961.429 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2024-03-11T18:49:21.863Z,1710182961.863 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2024-03-11T18:49:21.864Z,1710182961.864 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2024-03-11T18:49:22.088Z,1710182962.088 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2024-03-11T18:49:22.089Z,1710182962.089 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2024-03-11T18:49:22.227Z,1710182962.227 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2024-03-11T18:49:22.228Z,1710182962.228 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2024-03-11T18:49:22.473Z,1710182962.473 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2024-03-11T18:49:22.473Z,1710182962.473 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2024-03-11T18:49:23.019Z,1710182963.019 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2024-03-11T18:49:23.020Z,1710182963.020 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2024-03-11T18:49:23.404Z,1710182963.404 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2024-03-11T18:49:23.405Z,1710182963.405 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2024-03-11T18:49:23.484Z,1710182963.484 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2024-03-11T18:49:23.689Z,1710182963.689 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2024-03-11T18:49:23.689Z,1710182963.689 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2024-03-11T18:49:24.317Z,1710182964.317 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2024-03-11T18:49:24.317Z,1710182964.317 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2024-03-11T18:49:24.622Z,1710182964.622 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2024-03-11T18:49:24.624Z,1710182964.624 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-brizo/ 2024-03-11T18:49:24.625Z,1710182964.625 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Control.cfg 2024-03-11T18:49:24.736Z,1710182964.736 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Sensor.cfg 2024-03-11T18:49:24.888Z,1710182964.888 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Simulator.cfg 2024-03-11T18:49:24.975Z,1710182964.975 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/secure.cfg 2024-03-11T18:49:25.058Z,1710182965.058 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Servo.cfg 2024-03-11T18:49:25.170Z,1710182965.170 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/vehicle.cfg 2024-03-11T18:49:25.281Z,1710182965.281 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Battery.cfg 2024-03-11T18:49:25.549Z,1710182965.549 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2024-03-11T18:49:25.550Z,1710182965.550 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Science.cfg 2024-03-11T18:49:25.684Z,1710182965.684 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/logger.cfg 2024-03-11T18:49:25.778Z,1710182965.778 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/BIT.cfg 2024-03-11T18:49:25.884Z,1710182965.884 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Navigation.cfg 2024-03-11T18:49:25.987Z,1710182965.987 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-brizo/root/ 2024-03-11T18:49:25.987Z,1710182965.987 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg 2024-03-11T18:49:26.016Z,1710182966.016 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2024-03-11T18:49:26.139Z,1710182966.139 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2024-03-11T18:49:26.139Z,1710182966.139 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2024-03-11T18:49:26.149Z,1710182966.149 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2024-03-11T18:49:26.150Z,1710182966.150 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2024-03-11T18:49:26.203Z,1710182966.203 [DepthRateCalculator] Loaded 2024-03-11T18:49:26.203Z,1710182966.203 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2024-03-11T18:49:26.209Z,1710182966.209 [PitchRateCalculator] Loaded 2024-03-11T18:49:26.209Z,1710182966.209 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2024-03-11T18:49:26.220Z,1710182966.220 [SpeedCalculator] Loaded 2024-03-11T18:49:26.221Z,1710182966.221 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2024-03-11T18:49:26.225Z,1710182966.225 [YawRateCalculator] Loaded 2024-03-11T18:49:26.226Z,1710182966.226 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2024-03-11T18:49:26.247Z,1710182966.247 [ElevatorOffsetCalculator] Loaded 2024-03-11T18:49:26.248Z,1710182966.248 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2024-03-11T18:49:26.248Z,1710182966.248 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2024-03-11T18:49:26.249Z,1710182966.249 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2024-03-11T18:49:26.302Z,1710182966.302 [VerticalControl](DEBUG): Construct VerticalControl. 2024-03-11T18:49:26.358Z,1710182966.358 [VerticalControl] Loaded 2024-03-11T18:49:26.359Z,1710182966.359 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2024-03-11T18:49:26.361Z,1710182966.361 [HorizontalControl](DEBUG): Construct HorizontalControl. 2024-03-11T18:49:26.405Z,1710182966.405 [HorizontalControl] Loaded 2024-03-11T18:49:26.405Z,1710182966.405 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2024-03-11T18:49:26.407Z,1710182966.407 [SpeedControl](DEBUG): Construct SpeedControl. 2024-03-11T18:49:26.410Z,1710182966.410 [SpeedControl] Loaded 2024-03-11T18:49:26.410Z,1710182966.410 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2024-03-11T18:49:26.413Z,1710182966.413 [LoopControl](DEBUG): Construct LoopControl. 2024-03-11T18:49:26.414Z,1710182966.414 [LoopControl] Loaded 2024-03-11T18:49:26.414Z,1710182966.414 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2024-03-11T18:49:26.414Z,1710182966.414 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2024-03-11T18:49:26.415Z,1710182966.415 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2024-03-11T18:49:26.530Z,1710182966.530 [DeadReckonUsingMultipleVelocitySources] Loaded 2024-03-11T18:49:26.530Z,1710182966.530 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2024-03-11T18:49:26.544Z,1710182966.544 [NavChart] Loaded 2024-03-11T18:49:26.545Z,1710182966.545 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2024-03-11T18:49:26.550Z,1710182966.550 [UniversalFixResidualReporter] Loaded 2024-03-11T18:49:26.551Z,1710182966.551 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2024-03-11T18:49:26.551Z,1710182966.551 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2024-03-11T18:49:26.552Z,1710182966.552 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2024-03-11T18:49:26.709Z,1710182966.709 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2024-03-11T18:49:26.709Z,1710182966.709 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2024-03-11T18:49:27.159Z,1710182967.159 [BackseatComponent] Loaded 2024-03-11T18:49:27.160Z,1710182967.160 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2024-03-11T18:49:27.161Z,1710182967.161 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 4090F4E0 2024-03-11T18:49:27.161Z,1710182967.161 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 1093 2024-03-11T18:49:27.164Z,1710182967.164 [LcmUniversalReporter] Loaded 2024-03-11T18:49:27.164Z,1710182967.164 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread. 2024-03-11T18:49:27.999Z,1710182967.999 [BPC1] Loaded 2024-03-11T18:49:27.999Z,1710182967.999 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2024-03-11T18:49:28.081Z,1710182968.081 [DataOverHttps] Loaded 2024-03-11T18:49:28.081Z,1710182968.081 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2024-03-11T18:49:28.082Z,1710182968.082 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 4093F4E0 2024-03-11T18:49:28.083Z,1710182968.083 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 1094 2024-03-11T18:49:28.104Z,1710182968.104 [Depth_Keller] Loaded 2024-03-11T18:49:28.105Z,1710182968.105 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2024-03-11T18:49:28.167Z,1710182968.167 [NAL9602] Loaded 2024-03-11T18:49:28.167Z,1710182968.167 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2024-03-11T18:49:28.197Z,1710182968.197 [Onboard] Loaded 2024-03-11T18:49:28.197Z,1710182968.197 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2024-03-11T18:49:28.198Z,1710182968.198 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 4096F4E0 2024-03-11T18:49:28.199Z,1710182968.199 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 1095 2024-03-11T18:49:28.211Z,1710182968.211 [Power24vConverter] Loaded 2024-03-11T18:49:28.211Z,1710182968.211 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2024-03-11T18:49:28.225Z,1710182968.225 [Radio_Surface] Loaded 2024-03-11T18:49:28.225Z,1710182968.225 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2024-03-11T18:49:28.226Z,1710182968.226 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 4099F4E0 2024-03-11T18:49:28.226Z,1710182968.226 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 1096 2024-03-11T18:49:28.321Z,1710182968.321 [DAT] Loaded 2024-03-11T18:49:28.322Z,1710182968.322 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread. 2024-03-11T18:49:28.323Z,1710182968.323 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 409CF4E0 2024-03-11T18:49:28.323Z,1710182968.323 [DAT ThreadHandler](INFO): Protected caller Thread ID is 1097 2024-03-11T18:49:28.324Z,1710182968.324 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2024-03-11T18:49:28.324Z,1710182968.324 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2024-03-11T18:49:28.459Z,1710182968.459 [BuoyancyServo] Loaded 2024-03-11T18:49:28.460Z,1710182968.460 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2024-03-11T18:49:28.480Z,1710182968.480 [ElevatorServo] Loaded 2024-03-11T18:49:28.481Z,1710182968.481 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2024-03-11T18:49:28.501Z,1710182968.501 [MassServo] Loaded 2024-03-11T18:49:28.501Z,1710182968.501 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2024-03-11T18:49:28.520Z,1710182968.520 [RudderServo] Loaded 2024-03-11T18:49:28.520Z,1710182968.520 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2024-03-11T18:49:28.535Z,1710182968.535 [ThrusterHE] Loaded 2024-03-11T18:49:28.535Z,1710182968.535 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread. 2024-03-11T18:49:28.536Z,1710182968.536 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2024-03-11T18:49:28.536Z,1710182968.536 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2024-03-11T18:49:28.597Z,1710182968.597 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2024-03-11T18:49:28.597Z,1710182968.597 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2024-03-11T18:49:28.625Z,1710182968.625 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2024-03-11T18:49:28.625Z,1710182968.625 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2024-03-11T18:49:28.981Z,1710182968.981 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2024-03-11T18:49:28.982Z,1710182968.982 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2024-03-11T18:49:29.388Z,1710182969.388 [ESPComponent] Loaded 2024-03-11T18:49:29.388Z,1710182969.388 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread. 2024-03-11T18:49:29.412Z,1710182969.412 [PAR_Licor] Loaded 2024-03-11T18:49:29.412Z,1710182969.412 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2024-03-11T18:49:29.413Z,1710182969.413 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2024-03-11T18:49:29.414Z,1710182969.414 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2024-03-11T18:49:29.804Z,1710182969.804 [SBIT](DEBUG): Construct Startup Built In Test. 2024-03-11T18:49:29.813Z,1710182969.813 [SBIT] Loaded 2024-03-11T18:49:29.814Z,1710182969.814 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2024-03-11T18:49:29.817Z,1710182969.817 [IBIT](DEBUG): Construct Initiated Built In Test. 2024-03-11T18:49:29.830Z,1710182969.830 [IBIT] Loaded 2024-03-11T18:49:29.830Z,1710182969.830 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2024-03-11T18:49:29.836Z,1710182969.836 [CBIT](DEBUG): Construct Continuous Built In Test. 2024-03-11T18:49:29.943Z,1710182969.943 [CBIT] Loaded 2024-03-11T18:49:29.943Z,1710182969.943 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2024-03-11T18:49:29.944Z,1710182969.944 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2024-03-11T18:49:29.950Z,1710182969.950 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2024-03-11T18:49:29.953Z,1710182969.953 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2024-03-11T18:49:29.964Z,1710182969.964 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2024-03-11T18:49:29.965Z,1710182969.965 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40BBB4E0 2024-03-11T18:49:29.966Z,1710182969.966 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 1098 2024-03-11T18:49:29.970Z,1710182969.970 [Supervisor](INFO): Main Thread ID is 826 2024-03-11T18:49:29.970Z,1710182969.970 [Supervisor](DEBUG): Running supervisor. 2024-03-11T18:49:29.971Z,1710182969.971 [CommandExec ThreadHandler](INFO): Handler Thread ID is 1099 2024-03-11T18:49:29.971Z,1710182969.971 [CommandExec](INFO): Initializing the command executive. 2024-03-11T18:49:29.973Z,1710182969.973 [CommandLine ThreadHandler](INFO): Handler Thread ID is 1100 2024-03-11T18:49:29.975Z,1710182969.975 [controlThread ThreadHandler](INFO): Handler Thread ID is 1101 2024-03-11T18:49:29.975Z,1710182969.975 [controlThread](DEBUG): Initializing ControlThread 2024-03-11T18:49:29.976Z,1710182969.976 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2024-03-11T18:49:29.977Z,1710182969.977 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2024-03-11T18:49:29.977Z,1710182969.977 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2024-03-11T18:49:29.977Z,1710182969.977 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2024-03-11T18:49:29.977Z,1710182969.977 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2024-03-11T18:49:29.978Z,1710182969.978 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2024-03-11T18:49:29.980Z,1710182969.980 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2024-03-11T18:49:29.980Z,1710182969.980 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2024-03-11T18:49:29.981Z,1710182969.981 [LoopControl](DEBUG): Initialize LoopControlComponent. 2024-03-11T18:49:29.982Z,1710182969.982 [NavChart](DEBUG): Initialize NavChart Navigation. 2024-03-11T18:49:29.982Z,1710182969.982 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2024-03-11T18:49:29.992Z,1710182969.992 [SBIT](INFO): Initialize SBIT Component. 2024-03-11T18:49:29.992Z,1710182969.992 [SBIT](IMPORTANT): git: 2024-02-28-17-g4f75234a9 2024-03-11T18:49:29.992Z,1710182969.992 [SBIT](INFO): git hash: 4f75234a965187dd794fe24c8347fa55f83c72b3 2024-03-11T18:49:29.993Z,1710182969.993 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2024-03-11T18:49:29.994Z,1710182969.994 [SBIT](INFO): Kernel Reporting Different Version From Configuration. Kernel Expected: #1 PREEMPT Tue Sep 24 11:12:27 PDT 2019 Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021 2024-03-11T18:49:29.995Z,1710182969.995 [SBIT](INFO): Beginning SBIT in 104.000000 seconds. 2024-03-11T18:49:29.996Z,1710182969.996 [IBIT](INFO): Initialize IBIT Component. 2024-03-11T18:49:29.996Z,1710182969.996 [CBIT](DEBUG): Initialize CBIT Component. 2024-03-11T18:49:29.997Z,1710182969.997 [logger ThreadHandler](INFO): Handler Thread ID is 1102 2024-03-11T18:49:30.007Z,1710182970.007 [CBIT](DEBUG): Initialized mux pins. 2024-03-11T18:49:30.008Z,1710182970.008 [CBIT](DEBUG): Initializing the watchdog timer. 2024-03-11T18:49:30.016Z,1710182970.016 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 1103 2024-03-11T18:49:30.028Z,1710182970.028 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 1104 2024-03-11T18:49:30.030Z,1710182970.030 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2024-03-11T18:49:30.031Z,1710182970.031 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2024-03-11T18:49:30.032Z,1710182970.032 [CBIT](DEBUG): Initializing heartbeat. 2024-03-11T18:49:30.040Z,1710182970.040 [Onboard ThreadHandler](INFO): Handler Thread ID is 1105 2024-03-11T18:49:30.057Z,1710182970.057 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 1106 2024-03-11T18:49:30.076Z,1710182970.076 [DAT ThreadHandler](INFO): Handler Thread ID is 1107 2024-03-11T18:49:30.077Z,1710182970.077 [DAT](INFO): Powering up 2024-03-11T18:49:30.077Z,1710182970.077 [DAT](DEBUG): Initializing DAT. 2024-03-11T18:49:30.081Z,1710182970.081 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 1109 2024-03-11T18:49:30.084Z,1710182970.084 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2024-03-11T18:49:30.084Z,1710182970.084 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2024-03-11T18:49:30.084Z,1710182970.084 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2024-03-11T18:49:30.084Z,1710182970.084 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2024-03-11T18:49:30.084Z,1710182970.084 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2024-03-11T18:49:30.085Z,1710182970.085 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2024-03-11T18:49:30.085Z,1710182970.085 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2024-03-11T18:49:30.085Z,1710182970.085 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2024-03-11T18:49:30.103Z,1710182970.103 [CBIT](DEBUG): Deactivating GF circuits. 2024-03-11T18:49:30.104Z,1710182970.104 [CBIT](DEBUG): Deactivating emergency mode. 2024-03-11T18:49:30.143Z,1710182970.143 [CBIT](DEBUG): Backplane powered. 2024-03-11T18:49:30.145Z,1710182970.145 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl 2024-03-11T18:49:30.145Z,1710182970.145 [MissionManager](IMPORTANT): Loading Compiled TethysL script from file Missions/Startup.tx 2024-03-11T18:49:30.157Z,1710182970.157 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2024-03-11T18:49:30.188Z,1710182970.188 [MissionManager](DEBUG): mission Startup { behavior Guidance:GoToSurface { run in progression } aggregate StartupSatComms { run in sequence readDatum { timeout duration=P1M Universal:latitude_fix } readDatum { timeout duration=P1M Universal:platform_communications } } } 2024-03-11T18:49:30.188Z,1710182970.188 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl 2024-03-11T18:49:30.189Z,1710182970.189 [MissionManager](IMPORTANT): Loading Compiled TethysL script from file Missions/Default.tx 2024-03-11T18:49:30.254Z,1710182970.254 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2024-03-11T18:49:30.255Z,1710182970.255 [Default:A.Wait](DEBUG): Construct Wait. 2024-03-11T18:49:30.257Z,1710182970.257 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2024-03-11T18:49:30.319Z,1710182970.319 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2024-03-11T18:49:30.331Z,1710182970.331 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2024-03-11T18:49:30.353Z,1710182970.353 [Default:E.Execute](DEBUG): Construct Execute. 2024-03-11T18:49:30.356Z,1710182970.356 [MissionManager](DEBUG): 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" } } 2024-03-11T18:49:30.376Z,1710182970.376 [controlThread](DEBUG): Component order: CycleStarter,BPC1,Depth_Keller,NAL9602,Power24vConverter,ESPComponent,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, 2024-03-11T18:49:30.426Z,1710182970.426 [Power24vConverter](INFO): Powering up. 2024-03-11T18:49:30.464Z,1710182970.464 [Radio_Surface](INFO): Powering up 2024-03-11T18:49:30.540Z,1710182970.540 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2024-03-11T18:49:30.548Z,1710182970.548 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2024-03-11T18:49:30.549Z,1710182970.549 [ElevatorServo](DEBUG): Initializing EZServoServo. 2024-03-11T18:49:30.556Z,1710182970.556 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2024-03-11T18:49:30.557Z,1710182970.557 [MassServo](DEBUG): Initializing EZServoServo. 2024-03-11T18:49:30.564Z,1710182970.564 [MassServo](DEBUG): Initializing MassServo. 2024-03-11T18:49:30.565Z,1710182970.565 [RudderServo](DEBUG): Initializing EZServoServo. 2024-03-11T18:49:30.572Z,1710182970.572 [RudderServo](DEBUG): Initializing RudderServo. 2024-03-11T18:49:30.573Z,1710182970.573 [ThrusterHE](DEBUG): Initializing EZServoServo. 2024-03-11T18:49:30.580Z,1710182970.580 [ThrusterHE](DEBUG): Initializing ThrusterHE. 2024-03-11T18:49:36.085Z,1710182976.085 [ThrusterHE](ERROR): Zero Speed Commanded. 2024-03-11T18:49:44.694Z,1710182984.694 [DAT](INFO): commRate: 800 2024-03-11T18:49:46.759Z,1710182986.759 [DAT](INFO): entering command mode 2024-03-11T18:49:46.960Z,1710182986.960 [DAT](INFO): setting verbose to 3 2024-03-11T18:49:47.213Z,1710182987.213 [DAT](INFO): set verbose to 3 2024-03-11T18:49:47.213Z,1710182987.213 [DAT](INFO): setting DatVerbose to 27440 2024-03-11T18:49:47.465Z,1710182987.465 [DAT](INFO): set DatVerbose to 27440 2024-03-11T18:49:47.465Z,1710182987.465 [DAT](INFO): setting transmit power to 8 2024-03-11T18:49:47.717Z,1710182987.717 [DAT](INFO): set transmit power to 8 2024-03-11T18:49:47.717Z,1710182987.717 [DAT](INFO): setting local address to 11 2024-03-11T18:49:47.969Z,1710182987.969 [DAT](INFO): set local address to 11 2024-03-11T18:49:47.970Z,1710182987.970 [DAT](INFO): Setting time to: 18:49:47 And date to:3/11/2024 2024-03-11T18:49:48.221Z,1710182988.221 [DAT](INFO): Local DAT time set to Mon Mar 11, 2024 18:49:47 2024-03-11T18:49:58.261Z,1710182998.261 [NAL9602](INFO): Powering up NAL9602 2024-03-11T18:49:59.853Z,1710182999.853 [CommandExec](IMPORTANT): got command restart system 2024-03-11T18:50:01.952Z,1710183001.952 [Supervisor](INFO): Stop Mission called by Supervisor::terminate 2024-03-11T18:50:01.952Z,1710183001.952 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2024-03-11T18:50:01.952Z,1710183001.952 [CommandExec](INFO): Uninitializing the command executive. 2024-03-11T18:50:01.952Z,1710183001.952 [CommandExec](INFO): Uninitializing the command scheduler. 2024-03-11T18:50:01.953Z,1710183001.953 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-03-11T18:50:02.143Z,1710183002.143 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2024-03-11T18:50:02.144Z,1710183002.144 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2024-03-11T18:50:02.144Z,1710183002.144 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-03-11T18:50:02.145Z,1710183002.145 [NavChartDb](INFO): Join timeout helper Thread ID is 1118 2024-03-11T18:50:02.461Z,1710183002.461 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2024-03-11T18:50:02.462Z,1710183002.462 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-03-11T18:50:02.471Z,1710183002.471 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler 2024-03-11T18:50:02.472Z,1710183002.472 [DAT ThreadHandler](INFO): Thread cancelled. 2024-03-11T18:50:02.472Z,1710183002.472 [DAT](INFO): Join timeout helper Thread ID is 1119 2024-03-11T18:50:02.584Z,1710183002.584 [DAT](INFO): Powering down 2024-03-11T18:50:02.656Z,1710183002.656 [DAT ThreadHandler](INFO): Uninitializing protected caller thread. 2024-03-11T18:50:02.657Z,1710183002.657 [DAT](INFO): Powering down 2024-03-11T18:50:02.658Z,1710183002.658 [DAT ThreadHandler](INFO): Thread cancelled. 2024-03-11T18:50:02.671Z,1710183002.671 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2024-03-11T18:50:02.672Z,1710183002.672 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-03-11T18:50:02.672Z,1710183002.672 [Radio_Surface](INFO): Join timeout helper Thread ID is 1120 2024-03-11T18:50:02.796Z,1710183002.796 [Radio_Surface](INFO): Powering down 2024-03-11T18:50:02.797Z,1710183002.797 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2024-03-11T18:50:02.797Z,1710183002.797 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-03-11T18:50:02.816Z,1710183002.816 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2024-03-11T18:50:02.816Z,1710183002.816 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-03-11T18:50:02.816Z,1710183002.816 [Onboard](INFO): Join timeout helper Thread ID is 1121 2024-03-11T18:50:03.173Z,1710183003.173 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2024-03-11T18:50:05.068Z,1710183005.068 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2024-03-11T18:50:05.068Z,1710183005.068 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-03-11T18:50:05.087Z,1710183005.087 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2024-03-11T18:50:05.088Z,1710183005.088 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-03-11T18:50:05.088Z,1710183005.088 [DataOverHttps](INFO): Join timeout helper Thread ID is 1122 2024-03-11T18:50:05.168Z,1710183005.168 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2024-03-11T18:50:05.169Z,1710183005.169 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-03-11T18:50:05.172Z,1710183005.172 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2024-03-11T18:50:05.172Z,1710183005.172 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-03-11T18:50:05.173Z,1710183005.173 [BackseatComponent](INFO): Join timeout helper Thread ID is 1123 2024-03-11T18:50:05.332Z,1710183005.332 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2024-03-11T18:50:05.332Z,1710183005.332 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-03-11T18:50:05.336Z,1710183005.336 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2024-03-11T18:50:05.336Z,1710183005.336 [logger ThreadHandler](INFO): Thread cancelled. 2024-03-11T18:50:05.337Z,1710183005.337 [logger](INFO): Join timeout helper Thread ID is 1124 2024-03-11T18:50:05.352Z,1710183005.352 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2024-03-11T18:50:05.352Z,1710183005.352 [logger ThreadHandler](INFO): Thread cancelled. 2024-03-11T18:50:05.356Z,1710183005.356 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2024-03-11T18:50:05.356Z,1710183005.356 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-03-11T18:50:05.357Z,1710183005.357 [CommandLine](INFO): Join timeout helper Thread ID is 1125 2024-03-11T18:50:05.420Z,1710183005.420 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2024-03-11T18:50:05.420Z,1710183005.420 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-03-11T18:50:05.436Z,1710183005.436 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2024-03-11T18:50:05.436Z,1710183005.436 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-03-11T18:50:05.437Z,1710183005.437 [CommandExec](INFO): Join timeout helper Thread ID is 1126 2024-03-11T18:50:05.438Z,1710183005.438 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2024-03-11T18:50:05.438Z,1710183005.438 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-03-11T18:50:05.438Z,1710183005.438 [controlThread](INFO): Join timeout helper Thread ID is 1127 2024-03-11T18:50:05.524Z,1710183005.524 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2024-03-11T18:50:05.524Z,1710183005.524 [controlThread](DEBUG): Uninitializing ControlThread 2024-03-11T18:50:05.525Z,1710183005.525 [NAL9602](INFO): Powering down 2024-03-11T18:50:05.529Z,1710183005.529 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2024-03-11T18:50:05.529Z,1710183005.529 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2024-03-11T18:50:05.529Z,1710183005.529 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2024-03-11T18:50:05.530Z,1710183005.530 [MissionManager](INFO): Uninitializing Mission Default 2024-03-11T18:50:05.533Z,1710183005.533 [MissionManager](INFO): Uninitializing Mission Startup 2024-03-11T18:50:05.534Z,1710183005.534 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2024-03-11T18:50:05.535Z,1710183005.535 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2024-03-11T18:50:05.535Z,1710183005.535 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2024-03-11T18:50:05.535Z,1710183005.535 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2024-03-11T18:50:05.536Z,1710183005.536 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2024-03-11T18:50:05.536Z,1710183005.536 [BuoyancyServo](INFO): Powering down 2024-03-11T18:50:05.548Z,1710183005.548 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2024-03-11T18:50:05.548Z,1710183005.548 [ElevatorServo](INFO): Powering down 2024-03-11T18:50:05.549Z,1710183005.549 [MassServo](DEBUG): Uninitialize Mass Servo. 2024-03-11T18:50:05.549Z,1710183005.549 [MassServo](INFO): Powering down 2024-03-11T18:50:05.549Z,1710183005.549 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2024-03-11T18:50:05.550Z,1710183005.550 [RudderServo](INFO): Powering down 2024-03-11T18:50:05.550Z,1710183005.550 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2024-03-11T18:50:05.551Z,1710183005.551 [ThrusterHE](INFO): Powering down 2024-03-11T18:50:05.552Z,1710183005.552 [SBIT](DEBUG): Uninitialize SBIT Component. 2024-03-11T18:50:05.552Z,1710183005.552 [IBIT](DEBUG): Uninitialize IBIT Component. 2024-03-11T18:50:05.552Z,1710183005.552 [CBIT](DEBUG): Uninitialize CBIT Component. 2024-03-11T18:50:05.552Z,1710183005.552 [CBIT](DEBUG): Powering off loads. 2024-03-11T18:50:05.563Z,1710183005.563 [CBIT](DEBUG): Disabling WDT. 2024-03-11T18:50:05.575Z,1710183005.575 [CBIT](DEBUG): Opening all GF detection circuits. 2024-03-11T18:50:05.576Z,1710183005.576 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-03-11T18:50:05.634Z,1710183005.634 [DAT ThreadHandler](INFO): Thread cancelled. 2024-03-11T18:50:05.639Z,1710183005.639 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-03-11T18:50:05.641Z,1710183005.641 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-03-11T18:50:05.647Z,1710183005.647 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-03-11T18:50:05.694Z,1710183005.694 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-03-11T18:50:06.005Z,1710183006.005 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-03-11T18:50:06.070Z,1710183006.070 [logger ThreadHandler](INFO): Thread cancelled.