2023-06-24T03:09:56.095Z,1687576196.095 [Supervisor](DEBUG): Initializing supervisor.
2023-06-24T03:09:56.100Z,1687576196.100 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2023-06-24T03:09:56.100Z,1687576196.100 [SyncHandler](INFO): Protected caller Thread ID is 7225
2023-06-24T03:09:56.101Z,1687576196.101 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2023-06-24T03:09:56.102Z,1687576196.102 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2023-06-24T03:09:56.102Z,1687576196.102 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 7226
2023-06-24T03:09:56.106Z,1687576196.106 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2023-06-24T03:09:56.123Z,1687576196.123 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2023-06-24T03:09:56.124Z,1687576196.124 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2023-06-24T03:09:56.124Z,1687576196.124 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 7227
2023-06-24T03:09:56.128Z,1687576196.128 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2023-06-24T03:09:56.129Z,1687576196.129 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2023-06-24T03:09:56.129Z,1687576196.129 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 7228
2023-06-24T03:09:56.131Z,1687576196.131 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2023-06-24T03:09:56.132Z,1687576196.132 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2023-06-24T03:09:56.133Z,1687576196.133 [logger ThreadHandler](INFO): Protected caller Thread ID is 7229
2023-06-24T03:09:56.136Z,1687576196.136 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2023-06-24T03:09:56.137Z,1687576196.137 [Supervisor](INFO): Looking for Config files in directory: Config/
2023-06-24T03:09:56.138Z,1687576196.138 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2023-06-24T03:09:56.236Z,1687576196.236 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2023-06-24T03:09:56.236Z,1687576196.236 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2023-06-24T03:09:56.450Z,1687576196.450 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2023-06-24T03:09:56.450Z,1687576196.450 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2023-06-24T03:09:56.701Z,1687576196.701 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2023-06-24T03:09:56.701Z,1687576196.701 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2023-06-24T03:09:56.809Z,1687576196.809 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2023-06-24T03:09:56.810Z,1687576196.810 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2023-06-24T03:09:57.545Z,1687576197.545 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2023-06-24T03:09:57.545Z,1687576197.545 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2023-06-24T03:09:58.079Z,1687576198.079 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2023-06-24T03:09:58.079Z,1687576198.079 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2023-06-24T03:09:58.555Z,1687576198.555 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2023-06-24T03:09:58.556Z,1687576198.556 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2023-06-24T03:09:58.963Z,1687576198.963 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2023-06-24T03:09:58.963Z,1687576198.963 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2023-06-24T03:09:59.298Z,1687576199.298 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2023-06-24T03:09:59.298Z,1687576199.298 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2023-06-24T03:09:59.693Z,1687576199.693 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2023-06-24T03:09:59.694Z,1687576199.694 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2023-06-24T03:10:00.167Z,1687576200.167 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2023-06-24T03:10:00.167Z,1687576200.167 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2023-06-24T03:10:00.308Z,1687576200.308 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2023-06-24T03:10:00.309Z,1687576200.309 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2023-06-24T03:10:00.391Z,1687576200.391 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2023-06-24T03:10:00.471Z,1687576200.471 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2023-06-24T03:10:00.652Z,1687576200.652 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2023-06-24T03:10:00.653Z,1687576200.653 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2023-06-24T03:10:00.875Z,1687576200.875 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2023-06-24T03:10:00.877Z,1687576200.877 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/
2023-06-24T03:10:00.878Z,1687576200.878 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/secure.cfg
2023-06-24T03:10:00.962Z,1687576200.962 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Battery.cfg
2023-06-24T03:10:01.227Z,1687576201.227 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2023-06-24T03:10:01.228Z,1687576201.228 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Navigation.cfg
2023-06-24T03:10:01.327Z,1687576201.327 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Sensor.cfg
2023-06-24T03:10:01.484Z,1687576201.484 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/vehicle.cfg
2023-06-24T03:10:01.585Z,1687576201.585 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Simulator.cfg
2023-06-24T03:10:01.671Z,1687576201.671 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Servo.cfg
2023-06-24T03:10:01.781Z,1687576201.781 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Control.cfg
2023-06-24T03:10:01.884Z,1687576201.884 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Science.cfg
2023-06-24T03:10:02.040Z,1687576202.040 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/logger.cfg
2023-06-24T03:10:02.136Z,1687576202.136 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/BIT.cfg
2023-06-24T03:10:02.238Z,1687576202.238 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/root/
2023-06-24T03:10:02.239Z,1687576202.239 [Supervisor](FAULT): Ignoring configuration overrides from Data/persisted.cfg
2023-06-24T03:10:02.240Z,1687576202.240 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2023-06-24T03:10:02.398Z,1687576202.398 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2023-06-24T03:10:02.398Z,1687576202.398 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2023-06-24T03:10:02.537Z,1687576202.537 [BuoyancyServo] Loaded
2023-06-24T03:10:02.537Z,1687576202.537 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2023-06-24T03:10:02.558Z,1687576202.558 [ElevatorServo] Loaded
2023-06-24T03:10:02.558Z,1687576202.558 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2023-06-24T03:10:02.578Z,1687576202.578 [MassServo] Loaded
2023-06-24T03:10:02.578Z,1687576202.578 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2023-06-24T03:10:02.598Z,1687576202.598 [RudderServo] Loaded
2023-06-24T03:10:02.598Z,1687576202.598 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2023-06-24T03:10:02.614Z,1687576202.614 [ThrusterHE] Loaded
2023-06-24T03:10:02.614Z,1687576202.614 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread.
2023-06-24T03:10:02.614Z,1687576202.614 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2023-06-24T03:10:02.615Z,1687576202.615 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2023-06-24T03:10:02.765Z,1687576202.765 [SBIT](DEBUG): Construct Startup Built In Test.
2023-06-24T03:10:02.780Z,1687576202.780 [SBIT] Loaded
2023-06-24T03:10:02.780Z,1687576202.780 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2023-06-24T03:10:02.783Z,1687576202.783 [IBIT](DEBUG): Construct Initiated Built In Test.
2023-06-24T03:10:02.803Z,1687576202.803 [IBIT] Loaded
2023-06-24T03:10:02.803Z,1687576202.803 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2023-06-24T03:10:02.809Z,1687576202.809 [CBIT](DEBUG): Construct Continuous Built In Test.
2023-06-24T03:10:03.027Z,1687576203.027 [CBIT] Loaded
2023-06-24T03:10:03.028Z,1687576203.028 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2023-06-24T03:10:03.028Z,1687576203.028 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2023-06-24T03:10:03.029Z,1687576203.029 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2023-06-24T03:10:03.200Z,1687576203.200 [CTD_Seabird] Loaded
2023-06-24T03:10:03.200Z,1687576203.200 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2023-06-24T03:10:03.201Z,1687576203.201 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 406644E0
2023-06-24T03:10:03.202Z,1687576203.202 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 7312
2023-06-24T03:10:03.233Z,1687576203.233 [ESPComponent] Loaded
2023-06-24T03:10:03.233Z,1687576203.233 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread.
2023-06-24T03:10:03.253Z,1687576203.253 [PAR_Licor] Loaded
2023-06-24T03:10:03.253Z,1687576203.253 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2023-06-24T03:10:03.284Z,1687576203.284 [WetLabsBB2FL] Loaded
2023-06-24T03:10:03.284Z,1687576203.284 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2023-06-24T03:10:03.285Z,1687576203.285 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 406944E0
2023-06-24T03:10:03.286Z,1687576203.286 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 7313
2023-06-24T03:10:03.287Z,1687576203.287 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2023-06-24T03:10:03.287Z,1687576203.287 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2023-06-24T03:10:03.341Z,1687576203.341 [DepthRateCalculator] Loaded
2023-06-24T03:10:03.341Z,1687576203.341 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2023-06-24T03:10:03.346Z,1687576203.346 [PitchRateCalculator] Loaded
2023-06-24T03:10:03.347Z,1687576203.347 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2023-06-24T03:10:03.357Z,1687576203.357 [SpeedCalculator] Loaded
2023-06-24T03:10:03.357Z,1687576203.357 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2023-06-24T03:10:03.361Z,1687576203.361 [YawRateCalculator] Loaded
2023-06-24T03:10:03.362Z,1687576203.362 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2023-06-24T03:10:03.381Z,1687576203.381 [ElevatorOffsetCalculator] Loaded
2023-06-24T03:10:03.381Z,1687576203.381 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2023-06-24T03:10:03.381Z,1687576203.381 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2023-06-24T03:10:03.382Z,1687576203.382 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2023-06-24T03:10:03.487Z,1687576203.487 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2023-06-24T03:10:03.487Z,1687576203.487 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2023-06-24T03:10:03.515Z,1687576203.515 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2023-06-24T03:10:03.516Z,1687576203.516 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2023-06-24T03:10:03.630Z,1687576203.630 [DeadReckonUsingMultipleVelocitySources] Loaded
2023-06-24T03:10:03.630Z,1687576203.630 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2023-06-24T03:10:03.644Z,1687576203.644 [NavChart] Loaded
2023-06-24T03:10:03.644Z,1687576203.644 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2023-06-24T03:10:03.650Z,1687576203.650 [UniversalFixResidualReporter] Loaded
2023-06-24T03:10:03.650Z,1687576203.650 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2023-06-24T03:10:03.650Z,1687576203.650 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2023-06-24T03:10:03.651Z,1687576203.651 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2023-06-24T03:10:04.093Z,1687576204.093 [AHRS_M2] Loaded
2023-06-24T03:10:04.093Z,1687576204.093 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2023-06-24T03:10:04.128Z,1687576204.128 [BackseatComponent] Loaded
2023-06-24T03:10:04.128Z,1687576204.128 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread.
2023-06-24T03:10:04.129Z,1687576204.129 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 40A294E0
2023-06-24T03:10:04.130Z,1687576204.130 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 7314
2023-06-24T03:10:04.133Z,1687576204.133 [LcmUniversalReporter] Loaded
2023-06-24T03:10:04.133Z,1687576204.133 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread.
2023-06-24T03:10:04.887Z,1687576204.887 [BPC1] Loaded
2023-06-24T03:10:04.887Z,1687576204.887 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2023-06-24T03:10:04.974Z,1687576204.974 [DataOverHttps] Loaded
2023-06-24T03:10:04.974Z,1687576204.974 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2023-06-24T03:10:04.975Z,1687576204.975 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 40A594E0
2023-06-24T03:10:04.976Z,1687576204.976 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 7315
2023-06-24T03:10:04.996Z,1687576204.996 [Depth_Keller] Loaded
2023-06-24T03:10:04.996Z,1687576204.996 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2023-06-24T03:10:05.001Z,1687576205.001 [DropWeight] Loaded
2023-06-24T03:10:05.002Z,1687576205.002 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2023-06-24T03:10:05.040Z,1687576205.040 [DVL_micro] Loaded
2023-06-24T03:10:05.041Z,1687576205.041 [ComponentRegistry](DEBUG): SyncComponent "DVL_micro" handled in the control thread.
2023-06-24T03:10:05.102Z,1687576205.102 [NAL9602] Loaded
2023-06-24T03:10:05.102Z,1687576205.102 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2023-06-24T03:10:05.129Z,1687576205.129 [Onboard] Loaded
2023-06-24T03:10:05.129Z,1687576205.129 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2023-06-24T03:10:05.130Z,1687576205.130 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 40A894E0
2023-06-24T03:10:05.131Z,1687576205.131 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 7316
2023-06-24T03:10:05.143Z,1687576205.143 [Power24vConverter] Loaded
2023-06-24T03:10:05.143Z,1687576205.143 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2023-06-24T03:10:05.157Z,1687576205.157 [Radio_Surface] Loaded
2023-06-24T03:10:05.157Z,1687576205.157 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2023-06-24T03:10:05.158Z,1687576205.158 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 40AB94E0
2023-06-24T03:10:05.158Z,1687576205.158 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 7317
2023-06-24T03:10:05.253Z,1687576205.253 [DAT] Loaded
2023-06-24T03:10:05.253Z,1687576205.253 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread.
2023-06-24T03:10:05.254Z,1687576205.254 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 40AE94E0
2023-06-24T03:10:05.254Z,1687576205.254 [DAT ThreadHandler](INFO): Protected caller Thread ID is 7318
2023-06-24T03:10:05.255Z,1687576205.255 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2023-06-24T03:10:05.255Z,1687576205.255 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2023-06-24T03:10:05.459Z,1687576205.459 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2023-06-24T03:10:05.460Z,1687576205.460 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2023-06-24T03:10:05.541Z,1687576205.541 [VerticalControl](DEBUG): Construct VerticalControl.
2023-06-24T03:10:05.630Z,1687576205.630 [VerticalControl] Loaded
2023-06-24T03:10:05.630Z,1687576205.630 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2023-06-24T03:10:05.633Z,1687576205.633 [HorizontalControl](DEBUG): Construct HorizontalControl.
2023-06-24T03:10:05.670Z,1687576205.670 [HorizontalControl] Loaded
2023-06-24T03:10:05.671Z,1687576205.671 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2023-06-24T03:10:05.673Z,1687576205.673 [SpeedControl](DEBUG): Construct SpeedControl.
2023-06-24T03:10:05.675Z,1687576205.675 [SpeedControl] Loaded
2023-06-24T03:10:05.675Z,1687576205.675 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2023-06-24T03:10:05.678Z,1687576205.678 [LoopControl](DEBUG): Construct LoopControl.
2023-06-24T03:10:05.678Z,1687576205.678 [LoopControl] Loaded
2023-06-24T03:10:05.678Z,1687576205.678 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2023-06-24T03:10:05.679Z,1687576205.679 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2023-06-24T03:10:05.679Z,1687576205.679 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2023-06-24T03:10:05.690Z,1687576205.690 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2023-06-24T03:10:05.690Z,1687576205.690 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2023-06-24T03:10:06.142Z,1687576206.142 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2023-06-24T03:10:06.148Z,1687576206.148 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2023-06-24T03:10:06.150Z,1687576206.150 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2023-06-24T03:10:06.161Z,1687576206.161 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2023-06-24T03:10:06.162Z,1687576206.162 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40BF44E0
2023-06-24T03:10:06.163Z,1687576206.163 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 7319
2023-06-24T03:10:06.167Z,1687576206.167 [Supervisor](INFO): Main Thread ID is 7224
2023-06-24T03:10:06.167Z,1687576206.167 [Supervisor](DEBUG): Running supervisor.
2023-06-24T03:10:06.168Z,1687576206.168 [CommandExec ThreadHandler](INFO): Handler Thread ID is 7320
2023-06-24T03:10:06.168Z,1687576206.168 [CommandExec](INFO): Initializing the command executive.
2023-06-24T03:10:06.170Z,1687576206.170 [CommandLine ThreadHandler](INFO): Handler Thread ID is 7321
2023-06-24T03:10:06.173Z,1687576206.173 [controlThread ThreadHandler](INFO): Handler Thread ID is 7322
2023-06-24T03:10:06.174Z,1687576206.174 [controlThread](DEBUG): Initializing ControlThread
2023-06-24T03:10:06.176Z,1687576206.176 [SBIT](INFO): Initialize SBIT Component.
2023-06-24T03:10:06.176Z,1687576206.176 [SBIT](IMPORTANT): git: 2023-06-23
2023-06-24T03:10:06.176Z,1687576206.176 [SBIT](INFO): git hash: 7a60da20fabe8c9ff022aa19d24605a06cff26a2
2023-06-24T03:10:06.177Z,1687576206.177 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2023-06-24T03:10:06.178Z,1687576206.178 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018
Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021
2023-06-24T03:10:06.179Z,1687576206.179 [SBIT](INFO): Beginning SBIT in 107.000000 seconds.
2023-06-24T03:10:06.180Z,1687576206.180 [IBIT](INFO): Initialize IBIT Component.
2023-06-24T03:10:06.181Z,1687576206.181 [CBIT](DEBUG): Initialize CBIT Component.
2023-06-24T03:10:06.181Z,1687576206.181 [logger ThreadHandler](INFO): Handler Thread ID is 7323
2023-06-24T03:10:06.192Z,1687576206.192 [CBIT](DEBUG): Initialized mux pins.
2023-06-24T03:10:06.192Z,1687576206.192 [CBIT](FAULT): LAST RESTART WAS UNINTENTIONAL.
2023-06-24T03:10:06.192Z,1687576206.192 [CBIT](DEBUG): Initializing the watchdog timer.
2023-06-24T03:10:06.200Z,1687576206.200 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 7324
2023-06-24T03:10:06.201Z,1687576206.201 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2023-06-24T03:10:06.206Z,1687576206.206 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 7326
2023-06-24T03:10:06.208Z,1687576206.208 [WetLabsBB2FL](INFO): Powering up
2023-06-24T03:10:06.209Z,1687576206.209 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 7328
2023-06-24T03:10:06.216Z,1687576206.216 [CBIT](CRITICAL): Watchdog Timer failed to initialize.
2023-06-24T03:10:06.216Z,1687576206.216 [CBIT] Hardware Fault, FailCount= 1
2023-06-24T03:10:06.216Z,1687576206.216 [CBIT](ERROR): Hardware Fault
2023-06-24T03:10:06.216Z,1687576206.216 [CBIT](DEBUG): Initializing heartbeat.
2023-06-24T03:10:06.217Z,1687576206.217 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 7329
2023-06-24T03:10:06.218Z,1687576206.218 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2023-06-24T03:10:06.232Z,1687576206.232 [Onboard ThreadHandler](INFO): Handler Thread ID is 7330
2023-06-24T03:10:06.249Z,1687576206.249 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 7331
2023-06-24T03:10:06.268Z,1687576206.268 [DAT ThreadHandler](INFO): Handler Thread ID is 7332
2023-06-24T03:10:06.269Z,1687576206.269 [DAT](INFO): Powering up
2023-06-24T03:10:06.269Z,1687576206.269 [DAT](DEBUG): Initializing DAT.
2023-06-24T03:10:06.273Z,1687576206.273 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 7334
2023-06-24T03:10:06.276Z,1687576206.276 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2MI01M.000
2023-06-24T03:10:06.276Z,1687576206.276 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2MI01M.000
2023-06-24T03:10:06.277Z,1687576206.277 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MI89M.000
2023-06-24T03:10:06.277Z,1687576206.277 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI89M.000
2023-06-24T03:10:06.277Z,1687576206.277 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MI11M.000
2023-06-24T03:10:06.277Z,1687576206.277 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4MI11M.000
2023-06-24T03:10:06.277Z,1687576206.277 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5MI07M.000
2023-06-24T03:10:06.277Z,1687576206.277 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5MI07M.000
2023-06-24T03:10:06.278Z,1687576206.278 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5OH07M.000
2023-06-24T03:10:06.278Z,1687576206.278 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5OH07M.000
2023-06-24T03:10:06.278Z,1687576206.278 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5OH31M.000
2023-06-24T03:10:06.278Z,1687576206.278 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5OH31M.000
2023-06-24T03:10:06.288Z,1687576206.288 [CBIT](DEBUG): Deactivating GF circuits.
2023-06-24T03:10:06.288Z,1687576206.288 [CBIT](DEBUG): Deactivating emergency mode.
2023-06-24T03:10:06.328Z,1687576206.328 [CBIT](DEBUG): Backplane powered.
2023-06-24T03:10:06.332Z,1687576206.332 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2023-06-24T03:10:06.333Z,1687576206.333 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2023-06-24T03:10:06.333Z,1687576206.333 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2023-06-24T03:10:06.333Z,1687576206.333 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2023-06-24T03:10:06.334Z,1687576206.334 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2023-06-24T03:10:06.335Z,1687576206.335 [NavChart](DEBUG): Initialize NavChart Navigation.
2023-06-24T03:10:06.335Z,1687576206.335 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2023-06-24T03:10:06.350Z,1687576206.350 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2023-06-24T03:10:06.360Z,1687576206.360 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2023-06-24T03:10:06.361Z,1687576206.361 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2023-06-24T03:10:06.361Z,1687576206.361 [LoopControl](DEBUG): Initialize LoopControlComponent.
2023-06-24T03:10:06.362Z,1687576206.362 [MissionManager](INFO): Loading Mission from file: Missions/Startup.xml
2023-06-24T03:10:06.399Z,1687576206.399 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2023-06-24T03:10:06.439Z,1687576206.439 [MissionManager](DEBUG):
2023-06-24T03:10:06.439Z,1687576206.439 [MissionManager](INFO): Loading Mission from file: Missions/Default.xml
2023-06-24T03:10:06.538Z,1687576206.538 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2023-06-24T03:10:06.539Z,1687576206.539 [Default:A.Wait](DEBUG): Construct Wait.
2023-06-24T03:10:06.557Z,1687576206.557 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2023-06-24T03:10:06.581Z,1687576206.581 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2023-06-24T03:10:06.608Z,1687576206.608 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2023-06-24T03:10:06.614Z,1687576206.614 [Default:E.Execute](DEBUG): Construct Execute.
2023-06-24T03:10:06.641Z,1687576206.641 [MissionManager](DEBUG):
0
Wait a moment to see if the scheduler starts a new mission before
starting to actually run Default.
13
Burn on
Dropped weight due to communications timeout.
5
Default mission has been running for
Restarting logs and Default mission.
restart logs
2023-06-24T03:10:06.646Z,1687576206.646 [controlThread](DEBUG): Component order: CycleStarter,ESPComponent,PAR_Licor,AHRS_M2,BPC1,Depth_Keller,DropWeight,DVL_micro,NAL9602,Power24vConverter,PAR_Licor,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter,
2023-06-24T03:10:06.656Z,1687576206.656 [Radio_Surface](INFO): Powering up
2023-06-24T03:10:06.682Z,1687576206.682 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2023-06-24T03:10:06.761Z,1687576206.761 [Depth_Keller](ERROR): Pressure or depth reading out of range: 1895.894409 decibar, 0.000000 m
2023-06-24T03:10:06.769Z,1687576206.769 [Power24vConverter](INFO): Powering up.
2023-06-24T03:10:06.781Z,1687576206.781 [DepthRateCalculator](ERROR): Depth measurement is not active
2023-06-24T03:10:06.815Z,1687576206.815 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2023-06-24T03:10:06.832Z,1687576206.832 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2023-06-24T03:10:06.833Z,1687576206.833 [ElevatorServo](DEBUG): Initializing EZServoServo.
2023-06-24T03:10:06.840Z,1687576206.840 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2023-06-24T03:10:06.841Z,1687576206.841 [MassServo](DEBUG): Initializing EZServoServo.
2023-06-24T03:10:06.848Z,1687576206.848 [MassServo](DEBUG): Initializing MassServo.
2023-06-24T03:10:06.849Z,1687576206.849 [RudderServo](DEBUG): Initializing EZServoServo.
2023-06-24T03:10:06.856Z,1687576206.856 [RudderServo](DEBUG): Initializing RudderServo.
2023-06-24T03:10:06.857Z,1687576206.857 [ThrusterHE](DEBUG): Initializing EZServoServo.
2023-06-24T03:10:06.864Z,1687576206.864 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2023-06-24T03:10:06.865Z,1687576206.865 [CBIT](DEBUG): Uninitialize CBIT Component.
2023-06-24T03:10:06.865Z,1687576206.865 [CBIT](DEBUG): Powering off loads.
2023-06-24T03:10:06.876Z,1687576206.876 [CBIT](DEBUG): Disabling WDT.
2023-06-24T03:10:06.888Z,1687576206.888 [CBIT](DEBUG): Opening all GF detection circuits.
2023-06-24T03:10:08.208Z,1687576208.208 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout
2023-06-24T03:10:08.208Z,1687576208.208 [BuoyancyServo](FAULT): Buoyancy failed to initialize
2023-06-24T03:10:08.208Z,1687576208.208 [BuoyancyServo] Communications Fault, FailCount= 1
2023-06-24T03:10:08.208Z,1687576208.208 [BuoyancyServo](ERROR): Communications Fault
2023-06-24T03:10:08.520Z,1687576208.520 [ElevatorServo](ERROR): Elevator initialization uart error I:serial timeout
2023-06-24T03:10:08.520Z,1687576208.520 [ElevatorServo](FAULT): Elevator failed to initialize
2023-06-24T03:10:08.520Z,1687576208.520 [ElevatorServo] Communications Fault, FailCount= 1
2023-06-24T03:10:08.520Z,1687576208.520 [ElevatorServo](ERROR): Communications Fault
2023-06-24T03:10:08.828Z,1687576208.828 [RudderServo](ERROR): Rudder initialization uart error serial timeout
2023-06-24T03:10:08.828Z,1687576208.828 [RudderServo](FAULT): Rudder failed to initialize
2023-06-24T03:10:08.828Z,1687576208.828 [RudderServo] Communications Fault, FailCount= 1
2023-06-24T03:10:08.828Z,1687576208.828 [RudderServo](ERROR): Communications Fault
2023-06-24T03:10:08.886Z,1687576208.886 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2023-06-24T03:10:08.887Z,1687576208.887 [ElevatorServo](INFO): Powering down
2023-06-24T03:10:08.897Z,1687576208.897 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2023-06-24T03:10:08.897Z,1687576208.897 [RudderServo](INFO): Powering down
2023-06-24T03:10:08.898Z,1687576208.898 [ThrusterHE](FAULT): Thruster failed to initialize
2023-06-24T03:10:08.898Z,1687576208.898 [ThrusterHE] Communications Fault, FailCount= 1
2023-06-24T03:10:08.898Z,1687576208.898 [ThrusterHE](ERROR): Communications Fault
2023-06-24T03:10:09.259Z,1687576209.259 [ElevatorServo](FAULT): LCB fault: Current Limiter Activated.
2023-06-24T03:10:09.259Z,1687576209.259 [ElevatorServo] Hardware Fault, FailCount= 1
2023-06-24T03:10:09.259Z,1687576209.259 [ElevatorServo](ERROR): Hardware Fault
2023-06-24T03:10:09.260Z,1687576209.260 [RudderServo](FAULT): LCB fault: Current Limiter Activated.
2023-06-24T03:10:09.260Z,1687576209.260 [RudderServo] Hardware Fault, FailCount= 1
2023-06-24T03:10:09.260Z,1687576209.260 [RudderServo](ERROR): Hardware Fault
2023-06-24T03:10:09.261Z,1687576209.261 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2023-06-24T03:10:09.261Z,1687576209.261 [ThrusterHE](INFO): Powering down
2023-06-24T03:10:09.663Z,1687576209.663 [ElevatorServo](DEBUG): Initializing EZServoServo.
2023-06-24T03:10:09.781Z,1687576209.781 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2023-06-24T03:10:10.084Z,1687576210.084 [MassServo](FAULT): Mass shifter EEPROM initialization uart error serial timeout
2023-06-24T03:10:10.084Z,1687576210.084 [MassServo] Communications Fault, FailCount= 1
2023-06-24T03:10:10.084Z,1687576210.084 [MassServo](ERROR): Communications Fault
2023-06-24T03:10:10.085Z,1687576210.085 [RudderServo](DEBUG): Initializing EZServoServo.
2023-06-24T03:10:10.205Z,1687576210.205 [RudderServo](DEBUG): Initializing RudderServo.
2023-06-24T03:10:10.206Z,1687576210.206 [ThrusterHE](FAULT): LCB fault: Current Limiter Activated.
2023-06-24T03:10:10.206Z,1687576210.206 [ThrusterHE] Hardware Fault, FailCount= 1
2023-06-24T03:10:10.206Z,1687576210.206 [ThrusterHE](ERROR): Hardware Fault
2023-06-24T03:10:10.324Z,1687576210.324 [MassServo](DEBUG): Uninitialize Mass Servo.
2023-06-24T03:10:10.324Z,1687576210.324 [MassServo](INFO): Powering down
2023-06-24T03:10:10.686Z,1687576210.686 [MassServo](FAULT): LCB fault: Hardware Overcurrent Shutdown. Current Limiter Activated.
2023-06-24T03:10:10.686Z,1687576210.686 [MassServo] Hardware Fault, FailCount= 1
2023-06-24T03:10:10.686Z,1687576210.686 [MassServo](ERROR): Hardware Fault
2023-06-24T03:10:11.091Z,1687576211.091 [MassServo](DEBUG): Initializing EZServoServo.
2023-06-24T03:10:11.209Z,1687576211.209 [MassServo](DEBUG): Initializing MassServo.
2023-06-24T03:10:11.500Z,1687576211.500 [WetLabsBB2FL] Communications Fault, FailCount= 1
2023-06-24T03:10:11.500Z,1687576211.500 [WetLabsBB2FL](ERROR): Communications Fault
2023-06-24T03:10:11.000Z,1687576212.000 [WetLabsBB2FL](INFO): Powering down
2023-06-24T03:10:12.404Z,1687576212.404 [WetLabsBB2FL](FAULT): LCB fault: Current Limiter Activated.
2023-06-24T03:10:12.404Z,1687576212.404 [WetLabsBB2FL] Hardware Fault, FailCount= 1
2023-06-24T03:10:12.404Z,1687576212.404 [WetLabsBB2FL](ERROR): Hardware Fault
2023-06-24T03:10:13.120Z,1687576213.120 [Radio_Surface](FAULT): LCB fault: Current Limiter Activated.
2023-06-24T03:10:13.120Z,1687576213.120 [Radio_Surface] Hardware Fault, FailCount= 1
2023-06-24T03:10:13.120Z,1687576213.120 [Radio_Surface](ERROR): Hardware Fault
2023-06-24T03:10:13.524Z,1687576213.524 [Radio_Surface](INFO): Powering down
2023-06-24T03:10:13.928Z,1687576213.928 [Radio_Surface](FAULT): LCB fault: Current Limiter Activated.
2023-06-24T03:10:16.277Z,1687576216.277 [AHRS_M2](FAULT): LCB fault: Hardware Overcurrent Shutdown. Current Limiter Activated.
2023-06-24T03:10:16.277Z,1687576216.277 [AHRS_M2] Hardware Fault, FailCount= 1
2023-06-24T03:10:16.277Z,1687576216.277 [AHRS_M2](ERROR): Hardware Fault
2023-06-24T03:10:16.680Z,1687576216.680 [AHRS_M2](INFO): Powering down
2023-06-24T03:10:17.085Z,1687576217.085 [AHRS_M2](FAULT): LCB fault: Hardware Overcurrent Shutdown. Current Limiter Activated.
2023-06-24T03:10:19.252Z,1687576219.252 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2023-06-24T03:10:19.252Z,1687576219.252 [CTD_Seabird] Communications Fault, FailCount= 1
2023-06-24T03:10:19.252Z,1687576219.252 [CTD_Seabird](ERROR): Communications Fault
2023-06-24T03:10:19.657Z,1687576219.657 [CTD_Seabird](INFO): Powering down
2023-06-24T03:10:20.192Z,1687576220.192 [CTD_Seabird](FAULT): LCB fault: Current Limiter Activated.
2023-06-24T03:10:20.192Z,1687576220.192 [CTD_Seabird] Hardware Fault, FailCount= 1
2023-06-24T03:10:20.192Z,1687576220.192 [CTD_Seabird](ERROR): Hardware Fault
2023-06-24T03:10:23.957Z,1687576223.957 [DVL_micro](FAULT): Failed to initialize within timeout.
2023-06-24T03:10:23.957Z,1687576223.957 [DVL_micro] Communications Fault, FailCount= 1
2023-06-24T03:10:23.957Z,1687576223.957 [DVL_micro](ERROR): Communications Fault
2023-06-24T03:10:24.433Z,1687576224.433 [DVL_micro](INFO): Powering down
2023-06-24T03:10:35.269Z,1687576235.269 [NAL9602](INFO): Powering up NAL9602
2023-06-24T03:10:37.340Z,1687576237.340 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2023-06-24T03:10:55.868Z,1687576255.868 [NAL9602](ERROR): NAL9602 initialization error.
2023-06-24T03:10:55.868Z,1687576255.868 [NAL9602] Communications Fault, FailCount= 1
2023-06-24T03:10:55.868Z,1687576255.868 [NAL9602](ERROR): Communications Fault
2023-06-24T03:10:56.293Z,1687576256.293 [NAL9602](INFO): Powering down
2023-06-24T03:11:06.500Z,1687576266.500 [DAT](FAULT): failed to initialize, no bytes available on serial interface
2023-06-24T03:11:06.500Z,1687576266.500 [DAT] Communications Fault, FailCount= 1
2023-06-24T03:11:06.500Z,1687576266.500 [DAT](ERROR): Communications Fault
2023-06-24T03:11:06.904Z,1687576266.904 [DAT](INFO): Powering down
2023-06-24T03:11:07.380Z,1687576267.380 [DAT](FAULT): LCB fault: Hardware Overcurrent Shutdown. Current Limiter Activated.
2023-06-24T03:11:07.380Z,1687576267.380 [DAT] Hardware Fault, FailCount= 1
2023-06-24T03:11:07.380Z,1687576267.380 [DAT](ERROR): Hardware Fault
2023-06-24T03:11:53.715Z,1687576313.715 [SBIT](IMPORTANT): Beginning Startup BIT
2023-06-24T03:12:06.579Z,1687576326.579 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2023-06-24T03:12:06.579Z,1687576326.579 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2023-06-24T03:12:06.579Z,1687576326.579 [DeadReckonUsingMultipleVelocit