2023-02-13T16:31:49.480Z,1676305909.480 [Supervisor](DEBUG): Initializing supervisor.
2023-02-13T16:31:49.484Z,1676305909.484 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2023-02-13T16:31:49.485Z,1676305909.485 [SyncHandler](INFO): Protected caller Thread ID is 5420
2023-02-13T16:31:49.485Z,1676305909.485 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2023-02-13T16:31:49.486Z,1676305909.486 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2023-02-13T16:31:49.487Z,1676305909.487 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 5421
2023-02-13T16:31:49.490Z,1676305909.490 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2023-02-13T16:31:49.508Z,1676305909.508 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2023-02-13T16:31:49.509Z,1676305909.509 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2023-02-13T16:31:49.509Z,1676305909.509 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 5422
2023-02-13T16:31:49.513Z,1676305909.513 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2023-02-13T16:31:49.514Z,1676305909.514 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2023-02-13T16:31:49.515Z,1676305909.515 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 5423
2023-02-13T16:31:49.517Z,1676305909.517 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2023-02-13T16:31:49.518Z,1676305909.518 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2023-02-13T16:31:49.518Z,1676305909.518 [logger ThreadHandler](INFO): Protected caller Thread ID is 5424
2023-02-13T16:31:49.522Z,1676305909.522 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2023-02-13T16:31:49.522Z,1676305909.522 [Supervisor](INFO): Looking for Config files in directory: Config/
2023-02-13T16:31:49.524Z,1676305909.524 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2023-02-13T16:31:49.798Z,1676305909.798 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2023-02-13T16:31:49.799Z,1676305909.799 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2023-02-13T16:31:49.876Z,1676305909.876 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2023-02-13T16:31:50.328Z,1676305910.328 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2023-02-13T16:31:50.329Z,1676305910.329 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2023-02-13T16:31:50.634Z,1676305910.634 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2023-02-13T16:31:50.635Z,1676305910.635 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2023-02-13T16:31:50.728Z,1676305910.728 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2023-02-13T16:31:50.729Z,1676305910.729 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2023-02-13T16:31:51.100Z,1676305911.100 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2023-02-13T16:31:51.100Z,1676305911.100 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2023-02-13T16:31:51.299Z,1676305911.299 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2023-02-13T16:31:51.300Z,1676305911.300 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2023-02-13T16:31:51.786Z,1676305911.786 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2023-02-13T16:31:51.787Z,1676305911.787 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2023-02-13T16:31:51.919Z,1676305911.919 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2023-02-13T16:31:51.920Z,1676305911.920 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2023-02-13T16:31:51.996Z,1676305911.996 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2023-02-13T16:31:52.709Z,1676305912.709 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2023-02-13T16:31:52.710Z,1676305912.710 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2023-02-13T16:31:53.059Z,1676305913.059 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2023-02-13T16:31:53.060Z,1676305913.060 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2023-02-13T16:31:53.236Z,1676305913.236 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2023-02-13T16:31:53.237Z,1676305913.237 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2023-02-13T16:31:53.343Z,1676305913.343 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2023-02-13T16:31:53.344Z,1676305913.344 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2023-02-13T16:31:53.557Z,1676305913.557 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2023-02-13T16:31:53.557Z,1676305913.557 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2023-02-13T16:31:53.783Z,1676305913.783 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2023-02-13T16:31:53.785Z,1676305913.785 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-daphne/
2023-02-13T16:31:53.786Z,1676305913.786 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Navigation.cfg
2023-02-13T16:31:53.873Z,1676305913.873 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Simulator.cfg
2023-02-13T16:31:53.956Z,1676305913.956 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Control.cfg
2023-02-13T16:31:54.052Z,1676305914.052 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/secure.cfg
2023-02-13T16:31:54.152Z,1676305914.152 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Servo.cfg
2023-02-13T16:31:54.346Z,1676305914.346 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/BIT.cfg
2023-02-13T16:31:54.544Z,1676305914.544 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/vehicle.cfg
2023-02-13T16:31:55.149Z,1676305915.149 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/workSite.cfg
2023-02-13T16:31:55.319Z,1676305915.319 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Sensor.cfg
2023-02-13T16:31:55.512Z,1676305915.512 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Science.cfg
2023-02-13T16:31:55.642Z,1676305915.642 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/logger.cfg
2023-02-13T16:31:55.752Z,1676305915.752 [Supervisor](INFO): Opening Config file at: Config/lrauv-daphne/Battery.cfg
2023-02-13T16:31:56.011Z,1676305916.011 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2023-02-13T16:31:56.012Z,1676305916.012 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2023-02-13T16:31:56.023Z,1676305916.023 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2023-02-13T16:31:56.075Z,1676305916.075 [VerticalControl](DEBUG): Construct VerticalControl.
2023-02-13T16:31:56.134Z,1676305916.134 [VerticalControl] Loaded
2023-02-13T16:31:56.134Z,1676305916.134 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2023-02-13T16:31:56.137Z,1676305916.137 [HorizontalControl](DEBUG): Construct HorizontalControl.
2023-02-13T16:31:56.178Z,1676305916.178 [HorizontalControl] Loaded
2023-02-13T16:31:56.178Z,1676305916.178 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2023-02-13T16:31:56.180Z,1676305916.180 [SpeedControl](DEBUG): Construct SpeedControl.
2023-02-13T16:31:56.183Z,1676305916.183 [SpeedControl] Loaded
2023-02-13T16:31:56.184Z,1676305916.184 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2023-02-13T16:31:56.186Z,1676305916.186 [LoopControl](DEBUG): Construct LoopControl.
2023-02-13T16:31:56.187Z,1676305916.187 [LoopControl] Loaded
2023-02-13T16:31:56.187Z,1676305916.187 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2023-02-13T16:31:56.187Z,1676305916.187 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2023-02-13T16:31:56.188Z,1676305916.188 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2023-02-13T16:31:56.198Z,1676305916.198 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2023-02-13T16:31:56.199Z,1676305916.199 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2023-02-13T16:31:56.353Z,1676305916.353 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2023-02-13T16:31:56.354Z,1676305916.354 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2023-02-13T16:31:56.487Z,1676305916.487 [BuoyancyServo] Loaded
2023-02-13T16:31:56.487Z,1676305916.487 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2023-02-13T16:31:56.507Z,1676305916.507 [ElevatorServo] Loaded
2023-02-13T16:31:56.507Z,1676305916.507 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2023-02-13T16:31:56.526Z,1676305916.526 [MassServo] Loaded
2023-02-13T16:31:56.527Z,1676305916.527 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2023-02-13T16:31:56.545Z,1676305916.545 [RudderServo] Loaded
2023-02-13T16:31:56.545Z,1676305916.545 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2023-02-13T16:31:56.562Z,1676305916.562 [ThrusterServo] Loaded
2023-02-13T16:31:56.563Z,1676305916.563 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2023-02-13T16:31:56.563Z,1676305916.563 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2023-02-13T16:31:56.564Z,1676305916.564 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2023-02-13T16:31:56.677Z,1676305916.677 [DeadReckonUsingMultipleVelocitySources] Loaded
2023-02-13T16:31:56.677Z,1676305916.677 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2023-02-13T16:31:56.692Z,1676305916.692 [NavChart] Loaded
2023-02-13T16:31:56.692Z,1676305916.692 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2023-02-13T16:31:56.698Z,1676305916.698 [UniversalFixResidualReporter] Loaded
2023-02-13T16:31:56.698Z,1676305916.698 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2023-02-13T16:31:56.699Z,1676305916.699 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2023-02-13T16:31:56.699Z,1676305916.699 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2023-02-13T16:31:56.757Z,1676305916.757 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2023-02-13T16:31:56.757Z,1676305916.757 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2023-02-13T16:31:57.188Z,1676305917.188 [AHRS_M2] Loaded
2023-02-13T16:31:57.188Z,1676305917.188 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2023-02-13T16:31:58.008Z,1676305918.008 [BPC1] Loaded
2023-02-13T16:31:58.008Z,1676305918.008 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2023-02-13T16:31:58.081Z,1676305918.081 [DataOverHttps] Loaded
2023-02-13T16:31:58.081Z,1676305918.081 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2023-02-13T16:31:58.082Z,1676305918.082 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 408FD4E0
2023-02-13T16:31:58.082Z,1676305918.082 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 5509
2023-02-13T16:31:58.103Z,1676305918.103 [Depth_Keller] Loaded
2023-02-13T16:31:58.104Z,1676305918.104 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2023-02-13T16:31:58.108Z,1676305918.108 [DropWeight] Loaded
2023-02-13T16:31:58.109Z,1676305918.109 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2023-02-13T16:31:58.127Z,1676305918.127 [MultiRay] Loaded
2023-02-13T16:31:58.128Z,1676305918.128 [ComponentRegistry](DEBUG): SyncComponent "MultiRay" handled in the control thread.
2023-02-13T16:31:58.189Z,1676305918.189 [NAL9602] Loaded
2023-02-13T16:31:58.190Z,1676305918.190 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2023-02-13T16:31:58.220Z,1676305918.220 [Onboard] Loaded
2023-02-13T16:31:58.220Z,1676305918.220 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2023-02-13T16:31:58.221Z,1676305918.221 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 4092D4E0
2023-02-13T16:31:58.221Z,1676305918.221 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 5510
2023-02-13T16:31:58.235Z,1676305918.235 [Power24vConverter] Loaded
2023-02-13T16:31:58.235Z,1676305918.235 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2023-02-13T16:31:58.249Z,1676305918.249 [Radio_Surface] Loaded
2023-02-13T16:31:58.249Z,1676305918.249 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2023-02-13T16:31:58.250Z,1676305918.250 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 4095D4E0
2023-02-13T16:31:58.250Z,1676305918.250 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 5511
2023-02-13T16:31:58.252Z,1676305918.252 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2023-02-13T16:31:58.252Z,1676305918.252 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2023-02-13T16:31:58.305Z,1676305918.305 [DepthRateCalculator] Loaded
2023-02-13T16:31:58.306Z,1676305918.306 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2023-02-13T16:31:58.311Z,1676305918.311 [PitchRateCalculator] Loaded
2023-02-13T16:31:58.311Z,1676305918.311 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2023-02-13T16:31:58.320Z,1676305918.320 [SpeedCalculator] Loaded
2023-02-13T16:31:58.320Z,1676305918.320 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2023-02-13T16:31:58.324Z,1676305918.324 [YawRateCalculator] Loaded
2023-02-13T16:31:58.324Z,1676305918.324 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2023-02-13T16:31:58.343Z,1676305918.343 [ElevatorOffsetCalculator] Loaded
2023-02-13T16:31:58.343Z,1676305918.343 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2023-02-13T16:31:58.344Z,1676305918.344 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2023-02-13T16:31:58.344Z,1676305918.344 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2023-02-13T16:31:58.476Z,1676305918.476 [CANONSampler] Loaded
2023-02-13T16:31:58.477Z,1676305918.477 [ComponentRegistry](DEBUG): SyncComponent "CANONSampler" handled in the control thread.
2023-02-13T16:31:58.536Z,1676305918.536 [CTD_Seabird] Loaded
2023-02-13T16:31:58.536Z,1676305918.536 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2023-02-13T16:31:58.538Z,1676305918.538 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40A164E0
2023-02-13T16:31:58.538Z,1676305918.538 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 5512
2023-02-13T16:31:58.558Z,1676305918.558 [PAR_Licor] Loaded
2023-02-13T16:31:58.558Z,1676305918.558 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2023-02-13T16:31:58.589Z,1676305918.589 [WetLabsBB2FL] Loaded
2023-02-13T16:31:58.590Z,1676305918.590 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2023-02-13T16:31:58.591Z,1676305918.591 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40A464E0
2023-02-13T16:31:58.591Z,1676305918.591 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 5513
2023-02-13T16:31:58.592Z,1676305918.592 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2023-02-13T16:31:58.592Z,1676305918.592 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2023-02-13T16:31:58.619Z,1676305918.619 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2023-02-13T16:31:58.620Z,1676305918.620 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2023-02-13T16:31:58.941Z,1676305918.941 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2023-02-13T16:31:58.942Z,1676305918.942 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2023-02-13T16:31:59.086Z,1676305919.086 [SBIT](DEBUG): Construct Startup Built In Test.
2023-02-13T16:31:59.095Z,1676305919.095 [SBIT] Loaded
2023-02-13T16:31:59.095Z,1676305919.095 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2023-02-13T16:31:59.098Z,1676305919.098 [IBIT](DEBUG): Construct Initiated Built In Test.
2023-02-13T16:31:59.111Z,1676305919.111 [IBIT] Loaded
2023-02-13T16:31:59.111Z,1676305919.111 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2023-02-13T16:31:59.117Z,1676305919.117 [CBIT](DEBUG): Construct Continuous Built In Test.
2023-02-13T16:31:59.221Z,1676305919.221 [CBIT] Loaded
2023-02-13T16:31:59.221Z,1676305919.221 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2023-02-13T16:31:59.222Z,1676305919.222 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2023-02-13T16:31:59.222Z,1676305919.222 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2023-02-13T16:31:59.576Z,1676305919.576 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2023-02-13T16:31:59.601Z,1676305919.601 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2023-02-13T16:31:59.604Z,1676305919.604 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2023-02-13T16:31:59.615Z,1676305919.615 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2023-02-13T16:31:59.616Z,1676305919.616 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40B7E4E0
2023-02-13T16:31:59.616Z,1676305919.616 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 5514
2023-02-13T16:31:59.621Z,1676305919.621 [Supervisor](INFO): Main Thread ID is 5419
2023-02-13T16:31:59.621Z,1676305919.621 [Supervisor](DEBUG): Running supervisor.
2023-02-13T16:31:59.622Z,1676305919.622 [CommandExec ThreadHandler](INFO): Handler Thread ID is 5515
2023-02-13T16:31:59.622Z,1676305919.622 [CommandExec](INFO): Initializing the command executive.
2023-02-13T16:31:59.624Z,1676305919.624 [CommandLine ThreadHandler](INFO): Handler Thread ID is 5516
2023-02-13T16:31:59.626Z,1676305919.626 [controlThread ThreadHandler](INFO): Handler Thread ID is 5517
2023-02-13T16:31:59.626Z,1676305919.626 [controlThread](DEBUG): Initializing ControlThread
2023-02-13T16:31:59.627Z,1676305919.627 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2023-02-13T16:31:59.629Z,1676305919.629 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2023-02-13T16:31:59.630Z,1676305919.630 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2023-02-13T16:31:59.630Z,1676305919.630 [LoopControl](DEBUG): Initialize LoopControlComponent.
2023-02-13T16:31:59.632Z,1676305919.632 [NavChart](DEBUG): Initialize NavChart Navigation.
2023-02-13T16:31:59.632Z,1676305919.632 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2023-02-13T16:31:59.636Z,1676305919.636 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2023-02-13T16:31:59.636Z,1676305919.636 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2023-02-13T16:31:59.637Z,1676305919.637 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2023-02-13T16:31:59.637Z,1676305919.637 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2023-02-13T16:31:59.637Z,1676305919.637 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2023-02-13T16:31:59.642Z,1676305919.642 [SBIT](INFO): Initialize SBIT Component.
2023-02-13T16:31:59.643Z,1676305919.643 [SBIT](IMPORTANT): git: 2023-02-10
2023-02-13T16:31:59.643Z,1676305919.643 [SBIT](INFO): git hash: c406eb0a7e3d06ad2f4805df3abb847da8df30bc
2023-02-13T16:31:59.643Z,1676305919.643 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2023-02-13T16:31:59.644Z,1676305919.644 [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-02-13T16:31:59.645Z,1676305919.645 [SBIT](INFO): Beginning SBIT in 52.000000 seconds.
2023-02-13T16:31:59.646Z,1676305919.646 [IBIT](INFO): Initialize IBIT Component.
2023-02-13T16:31:59.647Z,1676305919.647 [CBIT](DEBUG): Initialize CBIT Component.
2023-02-13T16:31:59.648Z,1676305919.648 [logger ThreadHandler](INFO): Handler Thread ID is 5518
2023-02-13T16:31:59.658Z,1676305919.658 [CBIT](DEBUG): Initialized mux pins.
2023-02-13T16:31:59.658Z,1676305919.658 [CBIT](DEBUG): Initializing the watchdog timer.
2023-02-13T16:31:59.666Z,1676305919.666 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 5519
2023-02-13T16:31:59.667Z,1676305919.667 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2023-02-13T16:31:59.678Z,1676305919.678 [Onboard ThreadHandler](INFO): Handler Thread ID is 5520
2023-02-13T16:31:59.683Z,1676305919.683 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2023-02-13T16:31:59.683Z,1676305919.683 [CBIT](DEBUG): Initializing heartbeat.
2023-02-13T16:31:59.699Z,1676305919.699 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 5521
2023-02-13T16:31:59.714Z,1676305919.714 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 5522
2023-02-13T16:31:59.715Z,1676305919.715 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2023-02-13T16:31:59.720Z,1676305919.720 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 5524
2023-02-13T16:31:59.723Z,1676305919.723 [WetLabsBB2FL](INFO): Powering up
2023-02-13T16:31:59.724Z,1676305919.724 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 5526
2023-02-13T16:31:59.727Z,1676305919.727 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2023-02-13T16:31:59.727Z,1676305919.727 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2023-02-13T16:31:59.728Z,1676305919.728 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2023-02-13T16:31:59.728Z,1676305919.728 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2023-02-13T16:31:59.728Z,1676305919.728 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2023-02-13T16:31:59.728Z,1676305919.728 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2023-02-13T16:31:59.728Z,1676305919.728 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2023-02-13T16:31:59.728Z,1676305919.728 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2023-02-13T16:31:59.754Z,1676305919.754 [CBIT](DEBUG): Deactivating GF circuits.
2023-02-13T16:31:59.754Z,1676305919.754 [CBIT](DEBUG): Deactivating emergency mode.
2023-02-13T16:31:59.790Z,1676305919.790 [CBIT](DEBUG): Backplane powered.
2023-02-13T16:31:59.791Z,1676305919.791 [MissionManager](INFO): Loading Mission from file: Missions/Startup.xml
2023-02-13T16:31:59.803Z,1676305919.803 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2023-02-13T16:31:59.823Z,1676305919.823 [MissionManager](DEBUG):
2023-02-13T16:31:59.831Z,1676305919.831 [MissionManager](INFO): Loading Mission from file: Missions/Default.xml
2023-02-13T16:31:59.904Z,1676305919.904 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2023-02-13T16:31:59.905Z,1676305919.905 [Default:A.Wait](DEBUG): Construct Wait.
2023-02-13T16:31:59.907Z,1676305919.907 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2023-02-13T16:31:59.951Z,1676305919.951 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2023-02-13T16:31:59.953Z,1676305919.953 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2023-02-13T16:31:59.979Z,1676305919.979 [Default:E.Execute](DEBUG): Construct Execute.
2023-02-13T16:32:00.003Z,1676305920.003 [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-02-13T16:32:00.007Z,1676305920.007 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,MultiRay,NAL9602,Power24vConverter,CANONSampler,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2023-02-13T16:32:00.021Z,1676305920.021 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2023-02-13T16:32:00.096Z,1676305920.096 [MultiRay](INFO): Powering up MultiRay Lights
2023-02-13T16:32:00.102Z,1676305920.102 [Radio_Surface](INFO): Powering up
2023-02-13T16:32:00.134Z,1676305920.134 [Power24vConverter](INFO): Powering up.
2023-02-13T16:32:00.135Z,1676305920.135 [CANONSampler](INFO): Powering down
2023-02-13T16:32:00.188Z,1676305920.188 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2023-02-13T16:32:00.195Z,1676305920.195 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2023-02-13T16:32:00.196Z,1676305920.196 [ElevatorServo](DEBUG): Initializing EZServoServo.
2023-02-13T16:32:00.202Z,1676305920.202 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2023-02-13T16:32:00.203Z,1676305920.203 [MassServo](DEBUG): Initializing EZServoServo.
2023-02-13T16:32:00.210Z,1676305920.210 [MassServo](DEBUG): Initializing MassServo.
2023-02-13T16:32:00.211Z,1676305920.211 [RudderServo](DEBUG): Initializing EZServoServo.
2023-02-13T16:32:00.226Z,1676305920.226 [RudderServo](DEBUG): Initializing RudderServo.
2023-02-13T16:32:00.227Z,1676305920.227 [ThrusterServo](DEBUG): Initializing EZServoServo.
2023-02-13T16:32:00.234Z,1676305920.234 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2023-02-13T16:32:01.146Z,1676305921.146 [RudderServo](ERROR): Rudder initialization uart error serial timeout
2023-02-13T16:32:01.146Z,1676305921.146 [RudderServo](FAULT): Rudder failed to initialize
2023-02-13T16:32:01.146Z,1676305921.146 [RudderServo] Communications Fault, FailCount= 1
2023-02-13T16:32:01.146Z,1676305921.146 [RudderServo](ERROR): Communications Fault
2023-02-13T16:32:01.246Z,1676305921.246 [CBIT](ERROR): Communications Fault in component: RudderServo
2023-02-13T16:32:01.627Z,1676305921.627 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2023-02-13T16:32:01.627Z,1676305921.627 [RudderServo](INFO): Powering down
2023-02-13T16:32:02.120Z,1676305922.120 [RudderServo](DEBUG): Initializing EZServoServo.
2023-02-13T16:32:02.239Z,1676305922.239 [RudderServo](DEBUG): Initializing RudderServo.
2023-02-13T16:32:02.243Z,1676305922.243 [CBIT](INFO): Clearing failed state for component RudderServo
2023-02-13T16:32:02.243Z,1676305922.243 [RudderServo] No Fault, FailCount= 1
2023-02-13T16:32:02.334Z,1676305922.334 [WetLabsBB2FL](INFO): Powering down
2023-02-13T16:32:12.532Z,1676305932.532 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004958
2023-02-13T16:32:28.340Z,1676305948.340 [NAL9602](INFO): Powering up NAL9602
2023-02-13T16:32:30.079Z,1676305950.079 [CommandExec](IMPORTANT): got command restart system
2023-02-13T16:32:32.186Z,1676305952.186 [Supervisor](INFO): Stop Mission called by Supervisor::terminate
2023-02-13T16:32:32.186Z,1676305952.186 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread.
2023-02-13T16:32:32.187Z,1676305952.187 [CommandExec](INFO): Uninitializing the command executive.
2023-02-13T16:32:32.187Z,1676305952.187 [CommandExec](INFO): Uninitializing the command scheduler.
2023-02-13T16:32:32.187Z,1676305952.187 [CommandExec ThreadHandler](INFO): Thread cancelled.
2023-02-13T16:32:32.234Z,1676305952.234 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye!
2023-02-13T16:32:32.234Z,1676305952.234 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2023-02-13T16:32:32.234Z,1676305952.234 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2023-02-13T16:32:32.235Z,1676305952.235 [NavChartDb](INFO): Join timeout helper Thread ID is 5540
2023-02-13T16:32:32.273Z,1676305952.273 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2023-02-13T16:32:32.273Z,1676305952.273 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2023-02-13T16:32:32.274Z,1676305952.274 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2023-02-13T16:32:32.274Z,1676305952.274 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2023-02-13T16:32:32.274Z,1676305952.274 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 5541
2023-02-13T16:32:32.494Z,1676305952.494 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2023-02-13T16:32:32.495Z,1676305952.495 [WetLabsBB2FL](INFO): Powering down
2023-02-13T16:32:32.495Z,1676305952.495 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2023-02-13T16:32:32.514Z,1676305952.514 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2023-02-13T16:32:32.514Z,1676305952.514 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2023-02-13T16:32:32.515Z,1676305952.515 [CTD_Seabird](INFO): Join timeout helper Thread ID is 5542
2023-02-13T16:32:32.866Z,1676305952.866 [CTD_Seabird](INFO): Powering down
2023-02-13T16:32:32.878Z,1676305952.878 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2023-02-13T16:32:32.878Z,1676305952.878 [CTD_Seabird](INFO): Powering down
2023-02-13T16:32:32.890Z,1676305952.890 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2023-02-13T16:32:32.910Z,1676305952.910 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2023-02-13T16:32:32.910Z,1676305952.910 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2023-02-13T16:32:32.910Z,1676305952.910 [Radio_Surface](INFO): Join timeout helper Thread ID is 5543
2023-02-13T16:32:33.254Z,1676305953.254 [Radio_Surface](INFO): Powering down
2023-02-13T16:32:33.255Z,1676305953.255 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2023-02-13T16:32:33.255Z,1676305953.255 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2023-02-13T16:32:33.258Z,1676305953.258 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2023-02-13T16:32:33.258Z,1676305953.258 [Onboard ThreadHandler](INFO): Thread cancelled.
2023-02-13T16:32:33.258Z,1676305953.258 [Onboard](INFO): Join timeout helper Thread ID is 5544
2023-02-13T16:32:34.706Z,1676305954.706 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2023-02-13T16:32:34.707Z,1676305954.707 [Onboard ThreadHandler](INFO): Thread cancelled.
2023-02-13T16:32:34.723Z,1676305954.723 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2023-02-13T16:32:34.723Z,1676305954.723 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2023-02-13T16:32:34.723Z,1676305954.723 [DataOverHttps](INFO): Join timeout helper Thread ID is 5545
2023-02-13T16:32:35.867Z,1676305955.867 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2023-02-13T16:32:35.869Z,1676305955.869 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2023-02-13T16:32:35.875Z,1676305955.875 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2023-02-13T16:32:35.875Z,1676305955.875 [logger ThreadHandler](INFO): Thread cancelled.
2023-02-13T16:32:35.875Z,1676305955.875 [logger](INFO): Join timeout helper Thread ID is 5546
2023-02-13T16:32:35.890Z,1676305955.890 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2023-02-13T16:32:35.890Z,1676305955.890 [logger ThreadHandler](INFO): Thread cancelled.
2023-02-13T16:32:35.895Z,1676305955.895 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2023-02-13T16:32:35.895Z,1676305955.895 [CommandLine ThreadHandler](INFO): Thread cancelled.
2023-02-13T16:32:35.895Z,1676305955.895 [CommandLine](INFO): Join timeout helper Thread ID is 5547
2023-02-13T16:32:35.946Z,1676305955.946 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2023-02-13T16:32:35.946Z,1676305955.946 [CommandLine ThreadHandler](INFO): Thread cancelled.
2023-02-13T16:32:35.955Z,1676305955.955 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler
2023-02-13T16:32:35.955Z,1676305955.955 [CommandExec ThreadHandler](INFO): Thread cancelled.
2023-02-13T16:32:35.955Z,1676305955.955 [CommandExec](INFO): Join timeout helper Thread ID is 5548
2023-02-13T16:32:35.957Z,1676305955.957 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2023-02-13T16:32:35.957Z,1676305955.957 [controlThread ThreadHandler](INFO): Thread cancelled.
2023-02-13T16:32:35.957Z,1676305955.957 [controlThread](INFO): Join timeout helper Thread ID is 5549
2023-02-13T16:32:35.990Z,1676305955.990 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2023-02-13T16:32:35.990Z,1676305955.990 [controlThread](DEBUG): Uninitializing ControlThread
2023-02-13T16:32:35.991Z,1676305955.991 [AHRS_M2](INFO): Powering down
2023-02-13T16:32:36.063Z,1676305956.063 [MultiRay](INFO): Powering down.
2023-02-13T16:32:36.064Z,1676305956.064 [NAL9602](INFO): Powering down
2023-02-13T16:32:36.067Z,1676305956.067 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2023-02-13T16:32:36.068Z,1676305956.068 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2023-02-13T16:32:36.068Z,1676305956.068 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2023-02-13T16:32:36.069Z,1676305956.069 [MissionManager](INFO): Uninitializing Mission Default
2023-02-13T16:32:36.072Z,1676305956.072 [MissionManager](INFO): Uninitializing Mission Startup
2023-02-13T16:32:36.074Z,1676305956.074 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2023-02-13T16:32:36.074Z,1676305956.074 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2023-02-13T16:32:36.074Z,1676305956.074 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2023-02-13T16:32:36.075Z,1676305956.075 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2023-02-13T16:32:36.075Z,1676305956.075 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2023-02-13T16:32:36.075Z,1676305956.075 [BuoyancyServo](INFO): Powering down
2023-02-13T16:32:36.090Z,1676305956.090 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2023-02-13T16:32:36.090Z,1676305956.090 [ElevatorServo](INFO): Powering down
2023-02-13T16:32:36.091Z,1676305956.091 [MassServo](DEBUG): Uninitialize Mass Servo.
2023-02-13T16:32:36.091Z,1676305956.091 [MassServo](INFO): Powering down
2023-02-13T16:32:36.092Z,1676305956.092 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2023-02-13T16:32:36.092Z,1676305956.092 [RudderServo](INFO): Powering down
2023-02-13T16:32:36.093Z,1676305956.093 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2023-02-13T16:32:36.093Z,1676305956.093 [ThrusterServo](INFO): Powering down
2023-02-13T16:32:36.094Z,1676305956.094 [SBIT](DEBUG): Uninitialize SBIT Component.
2023-02-13T16:32:36.095Z,1676305956.095 [IBIT](DEBUG): Uninitialize IBIT Component.
2023-02-13T16:32:36.095Z,1676305956.095 [CBIT](DEBUG): Uninitialize CBIT Component.
2023-02-13T16:32:36.095Z,1676305956.095 [CBIT](DEBUG): Powering off loads.
2023-02-13T16:32:36.106Z,1676305956.106 [CBIT](DEBUG): Disabling WDT.
2023-02-13T16:32:36.118Z,1676305956.118 [CBIT](DEBUG): Opening all GF detection circuits.
2023-02-13T16:32:36.119Z,1676305956.119 [controlThread ThreadHandler](INFO): Thread cancelled.
2023-02-13T16:32:36.292Z,1676305956.292 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2023-02-13T16:32:36.295Z,1676305956.295 [Onboard ThreadHandler](INFO): Thread cancelled.
2023-02-13T16:32:36.302Z,1676305956.302 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2023-02-13T16:32:36.377Z,1676305956.377 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2023-02-13T16:32:36.381Z,1676305956.381 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2023-02-13T16:32:36.424Z,1676305956.424 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2023-02-13T16:32:36.493Z,1676305956.493 [logger ThreadHandler](INFO): Thread cancelled.