2023-09-19T01:25:14.369Z,1695086714.369 [Supervisor](DEBUG): Initializing supervisor.
2023-09-19T01:25:14.373Z,1695086714.373 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2023-09-19T01:25:14.374Z,1695086714.374 [SyncHandler](INFO): Protected caller Thread ID is 7221
2023-09-19T01:25:14.374Z,1695086714.374 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2023-09-19T01:25:14.375Z,1695086714.375 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2023-09-19T01:25:14.376Z,1695086714.376 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 7222
2023-09-19T01:25:14.379Z,1695086714.379 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2023-09-19T01:25:14.396Z,1695086714.396 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2023-09-19T01:25:14.397Z,1695086714.397 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2023-09-19T01:25:14.398Z,1695086714.398 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 7223
2023-09-19T01:25:14.402Z,1695086714.402 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2023-09-19T01:25:14.403Z,1695086714.403 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2023-09-19T01:25:14.403Z,1695086714.403 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 7224
2023-09-19T01:25:14.405Z,1695086714.405 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2023-09-19T01:25:14.406Z,1695086714.406 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2023-09-19T01:25:14.406Z,1695086714.406 [logger ThreadHandler](INFO): Protected caller Thread ID is 7225
2023-09-19T01:25:14.410Z,1695086714.410 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2023-09-19T01:25:14.410Z,1695086714.410 [Supervisor](INFO): Looking for Config files in directory: Config/
2023-09-19T01:25:14.412Z,1695086714.412 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2023-09-19T01:25:14.769Z,1695086714.769 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2023-09-19T01:25:14.769Z,1695086714.769 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2023-09-19T01:25:14.852Z,1695086714.852 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2023-09-19T01:25:14.961Z,1695086714.961 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2023-09-19T01:25:14.962Z,1695086714.962 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2023-09-19T01:25:15.093Z,1695086715.093 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2023-09-19T01:25:15.093Z,1695086715.093 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2023-09-19T01:25:15.441Z,1695086715.441 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2023-09-19T01:25:15.441Z,1695086715.441 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2023-09-19T01:25:15.539Z,1695086715.539 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2023-09-19T01:25:15.540Z,1695086715.540 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2023-09-19T01:25:15.957Z,1695086715.957 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2023-09-19T01:25:15.958Z,1695086715.958 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2023-09-19T01:25:16.171Z,1695086716.171 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2023-09-19T01:25:16.171Z,1695086716.171 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2023-09-19T01:25:16.252Z,1695086716.252 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2023-09-19T01:25:16.483Z,1695086716.483 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2023-09-19T01:25:16.484Z,1695086716.484 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2023-09-19T01:25:16.710Z,1695086716.710 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2023-09-19T01:25:16.711Z,1695086716.711 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2023-09-19T01:25:17.245Z,1695086717.245 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2023-09-19T01:25:17.246Z,1695086717.246 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2023-09-19T01:25:17.441Z,1695086717.441 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2023-09-19T01:25:17.442Z,1695086717.442 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2023-09-19T01:25:17.730Z,1695086717.730 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2023-09-19T01:25:17.731Z,1695086717.731 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2023-09-19T01:25:18.570Z,1695086718.570 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2023-09-19T01:25:18.570Z,1695086718.570 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2023-09-19T01:25:19.107Z,1695086719.107 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2023-09-19T01:25:19.110Z,1695086719.110 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-ahi/
2023-09-19T01:25:19.111Z,1695086719.111 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Control.cfg
2023-09-19T01:25:19.222Z,1695086719.222 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Science.cfg
2023-09-19T01:25:19.343Z,1695086719.343 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/secure.cfg
2023-09-19T01:25:19.430Z,1695086719.430 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Servo.cfg
2023-09-19T01:25:19.541Z,1695086719.541 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/BIT.cfg
2023-09-19T01:25:19.642Z,1695086719.642 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Battery.cfg
2023-09-19T01:25:19.910Z,1695086719.910 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2023-09-19T01:25:19.910Z,1695086719.910 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/vehicle.cfg
2023-09-19T01:25:20.021Z,1695086720.021 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/logger.cfg
2023-09-19T01:25:20.118Z,1695086720.118 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Navigation.cfg
2023-09-19T01:25:20.225Z,1695086720.225 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Sensor.cfg
2023-09-19T01:25:20.350Z,1695086720.350 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Simulator.cfg
2023-09-19T01:25:20.438Z,1695086720.438 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2023-09-19T01:25:20.444Z,1695086720.444 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2023-09-19T01:25:20.551Z,1695086720.551 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2023-09-19T01:25:20.552Z,1695086720.552 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2023-09-19T01:25:20.605Z,1695086720.605 [VerticalControl](DEBUG): Construct VerticalControl.
2023-09-19T01:25:20.664Z,1695086720.664 [VerticalControl] Loaded
2023-09-19T01:25:20.664Z,1695086720.664 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2023-09-19T01:25:20.667Z,1695086720.667 [HorizontalControl](DEBUG): Construct HorizontalControl.
2023-09-19T01:25:20.707Z,1695086720.707 [HorizontalControl] Loaded
2023-09-19T01:25:20.707Z,1695086720.707 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2023-09-19T01:25:20.709Z,1695086720.709 [SpeedControl](DEBUG): Construct SpeedControl.
2023-09-19T01:25:20.712Z,1695086720.712 [SpeedControl] Loaded
2023-09-19T01:25:20.713Z,1695086720.713 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2023-09-19T01:25:20.715Z,1695086720.715 [LoopControl](DEBUG): Construct LoopControl.
2023-09-19T01:25:20.716Z,1695086720.716 [LoopControl] Loaded
2023-09-19T01:25:20.716Z,1695086720.716 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2023-09-19T01:25:20.716Z,1695086720.716 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2023-09-19T01:25:20.717Z,1695086720.717 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2023-09-19T01:25:20.776Z,1695086720.776 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2023-09-19T01:25:20.777Z,1695086720.777 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2023-09-19T01:25:21.236Z,1695086721.236 [AHRS_M2] Loaded
2023-09-19T01:25:21.236Z,1695086721.236 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2023-09-19T01:25:21.271Z,1695086721.271 [BackseatComponent] Loaded
2023-09-19T01:25:21.272Z,1695086721.272 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread.
2023-09-19T01:25:21.273Z,1695086721.273 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 4087F4E0
2023-09-19T01:25:21.273Z,1695086721.273 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 7307
2023-09-19T01:25:21.276Z,1695086721.276 [LcmUniversalReporter] Loaded
2023-09-19T01:25:21.276Z,1695086721.276 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread.
2023-09-19T01:25:22.102Z,1695086722.102 [BPC1] Loaded
2023-09-19T01:25:22.102Z,1695086722.102 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2023-09-19T01:25:22.175Z,1695086722.175 [DataOverHttps] Loaded
2023-09-19T01:25:22.176Z,1695086722.176 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2023-09-19T01:25:22.177Z,1695086722.177 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 408AF4E0
2023-09-19T01:25:22.177Z,1695086722.177 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 7308
2023-09-19T01:25:22.198Z,1695086722.198 [Depth_Keller] Loaded
2023-09-19T01:25:22.199Z,1695086722.199 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2023-09-19T01:25:22.204Z,1695086722.204 [DropWeight] Loaded
2023-09-19T01:25:22.204Z,1695086722.204 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2023-09-19T01:25:22.267Z,1695086722.267 [NAL9602] Loaded
2023-09-19T01:25:22.268Z,1695086722.268 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2023-09-19T01:25:22.298Z,1695086722.298 [Onboard] Loaded
2023-09-19T01:25:22.299Z,1695086722.299 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2023-09-19T01:25:22.300Z,1695086722.300 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 408DF4E0
2023-09-19T01:25:22.300Z,1695086722.300 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 7309
2023-09-19T01:25:22.312Z,1695086722.312 [Power24vConverter] Loaded
2023-09-19T01:25:22.312Z,1695086722.312 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2023-09-19T01:25:22.326Z,1695086722.326 [Radio_Surface] Loaded
2023-09-19T01:25:22.326Z,1695086722.326 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2023-09-19T01:25:22.327Z,1695086722.327 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 4090F4E0
2023-09-19T01:25:22.327Z,1695086722.327 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 7310
2023-09-19T01:25:22.328Z,1695086722.328 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2023-09-19T01:25:22.329Z,1695086722.329 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2023-09-19T01:25:22.339Z,1695086722.339 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2023-09-19T01:25:22.340Z,1695086722.340 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2023-09-19T01:25:22.375Z,1695086722.375 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2023-09-19T01:25:22.376Z,1695086722.376 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2023-09-19T01:25:22.556Z,1695086722.556 [SBIT](DEBUG): Construct Startup Built In Test.
2023-09-19T01:25:22.565Z,1695086722.565 [SBIT] Loaded
2023-09-19T01:25:22.566Z,1695086722.566 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2023-09-19T01:25:22.569Z,1695086722.569 [IBIT](DEBUG): Construct Initiated Built In Test.
2023-09-19T01:25:22.581Z,1695086722.581 [IBIT] Loaded
2023-09-19T01:25:22.581Z,1695086722.581 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2023-09-19T01:25:22.587Z,1695086722.587 [CBIT](DEBUG): Construct Continuous Built In Test.
2023-09-19T01:25:22.689Z,1695086722.689 [CBIT] Loaded
2023-09-19T01:25:22.689Z,1695086722.689 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2023-09-19T01:25:22.689Z,1695086722.689 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2023-09-19T01:25:22.690Z,1695086722.690 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2023-09-19T01:25:23.068Z,1695086723.068 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2023-09-19T01:25:23.069Z,1695086723.069 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2023-09-19T01:25:23.140Z,1695086723.140 [DepthRateCalculator] Loaded
2023-09-19T01:25:23.140Z,1695086723.140 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2023-09-19T01:25:23.145Z,1695086723.145 [PitchRateCalculator] Loaded
2023-09-19T01:25:23.146Z,1695086723.146 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2023-09-19T01:25:23.156Z,1695086723.156 [SpeedCalculator] Loaded
2023-09-19T01:25:23.156Z,1695086723.156 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2023-09-19T01:25:23.161Z,1695086723.161 [YawRateCalculator] Loaded
2023-09-19T01:25:23.161Z,1695086723.161 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2023-09-19T01:25:23.179Z,1695086723.179 [ElevatorOffsetCalculator] Loaded
2023-09-19T01:25:23.180Z,1695086723.180 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2023-09-19T01:25:23.180Z,1695086723.180 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2023-09-19T01:25:23.181Z,1695086723.181 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2023-09-19T01:25:23.370Z,1695086723.370 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2023-09-19T01:25:23.371Z,1695086723.371 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2023-09-19T01:25:23.509Z,1695086723.509 [DeadReckonUsingMultipleVelocitySources] Loaded
2023-09-19T01:25:23.509Z,1695086723.509 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2023-09-19T01:25:23.551Z,1695086723.551 [DeadReckonUsingSpeedCalculator] Loaded
2023-09-19T01:25:23.552Z,1695086723.552 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2023-09-19T01:25:23.594Z,1695086723.594 [DeadReckonWithRespectToSeafloor] Loaded
2023-09-19T01:25:23.595Z,1695086723.595 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToSeafloor" handled in the control thread.
2023-09-19T01:25:23.608Z,1695086723.608 [NavChart] Loaded
2023-09-19T01:25:23.609Z,1695086723.609 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2023-09-19T01:25:23.615Z,1695086723.615 [UniversalFixResidualReporter] Loaded
2023-09-19T01:25:23.615Z,1695086723.615 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2023-09-19T01:25:23.616Z,1695086723.616 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2023-09-19T01:25:23.617Z,1695086723.617 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2023-09-19T01:25:23.781Z,1695086723.781 [BuoyancyServo] Loaded
2023-09-19T01:25:23.782Z,1695086723.782 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2023-09-19T01:25:23.802Z,1695086723.802 [ElevatorServo] Loaded
2023-09-19T01:25:23.803Z,1695086723.803 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2023-09-19T01:25:23.822Z,1695086723.822 [MassServo] Loaded
2023-09-19T01:25:23.823Z,1695086723.823 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2023-09-19T01:25:23.843Z,1695086723.843 [RudderServo] Loaded
2023-09-19T01:25:23.843Z,1695086723.843 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2023-09-19T01:25:23.858Z,1695086723.858 [ThrusterHE] Loaded
2023-09-19T01:25:23.859Z,1695086723.859 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread.
2023-09-19T01:25:23.859Z,1695086723.859 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2023-09-19T01:25:23.860Z,1695086723.860 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2023-09-19T01:25:24.089Z,1695086724.089 [CTD_Seabird] Loaded
2023-09-19T01:25:24.089Z,1695086724.089 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2023-09-19T01:25:24.090Z,1695086724.090 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40B694E0
2023-09-19T01:25:24.091Z,1695086724.091 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 7311
2023-09-19T01:25:24.125Z,1695086724.125 [ESPComponent] Loaded
2023-09-19T01:25:24.125Z,1695086724.125 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread.
2023-09-19T01:25:24.146Z,1695086724.146 [PAR_Licor] Loaded
2023-09-19T01:25:24.146Z,1695086724.146 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2023-09-19T01:25:24.147Z,1695086724.147 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2023-09-19T01:25:24.177Z,1695086724.177 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2023-09-19T01:25:24.184Z,1695086724.184 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2023-09-19T01:25:24.197Z,1695086724.197 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2023-09-19T01:25:24.198Z,1695086724.198 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40B994E0
2023-09-19T01:25:24.198Z,1695086724.198 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 7312
2023-09-19T01:25:24.202Z,1695086724.202 [Supervisor](INFO): Main Thread ID is 7220
2023-09-19T01:25:24.203Z,1695086724.203 [Supervisor](DEBUG): Running supervisor.
2023-09-19T01:25:24.203Z,1695086724.203 [CommandExec ThreadHandler](INFO): Handler Thread ID is 7313
2023-09-19T01:25:24.204Z,1695086724.204 [CommandExec](INFO): Initializing the command executive.
2023-09-19T01:25:24.205Z,1695086724.205 [CommandLine ThreadHandler](INFO): Handler Thread ID is 7314
2023-09-19T01:25:24.207Z,1695086724.207 [controlThread ThreadHandler](INFO): Handler Thread ID is 7315
2023-09-19T01:25:24.208Z,1695086724.208 [controlThread](DEBUG): Initializing ControlThread
2023-09-19T01:25:24.209Z,1695086724.209 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2023-09-19T01:25:24.210Z,1695086724.210 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2023-09-19T01:25:24.211Z,1695086724.211 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2023-09-19T01:25:24.212Z,1695086724.212 [LoopControl](DEBUG): Initialize LoopControlComponent.
2023-09-19T01:25:24.218Z,1695086724.218 [SBIT](INFO): Initialize SBIT Component.
2023-09-19T01:25:24.218Z,1695086724.218 [SBIT](IMPORTANT): git: 2023-08-02
2023-09-19T01:25:24.218Z,1695086724.218 [SBIT](INFO): git hash: 04bff54855c04b79675eb3036915d66bd94ee3d9
2023-09-19T01:25:24.219Z,1695086724.219 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2023-09-19T01:25:24.220Z,1695086724.220 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #639 PREEMPT Wed Mar 12 12:53:33 PDT 2014
Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021
2023-09-19T01:25:24.221Z,1695086724.221 [SBIT](INFO): Beginning SBIT in 71.000000 seconds.
2023-09-19T01:25:24.222Z,1695086724.222 [IBIT](INFO): Initialize IBIT Component.
2023-09-19T01:25:24.222Z,1695086724.222 [CBIT](DEBUG): Initialize CBIT Component.
2023-09-19T01:25:24.223Z,1695086724.223 [logger ThreadHandler](INFO): Handler Thread ID is 7316
2023-09-19T01:25:24.236Z,1695086724.236 [CBIT](DEBUG): Initialized mux pins.
2023-09-19T01:25:24.236Z,1695086724.236 [CBIT](DEBUG): Initializing the watchdog timer.
2023-09-19T01:25:24.240Z,1695086724.240 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 7317
2023-09-19T01:25:24.252Z,1695086724.252 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 7318
2023-09-19T01:25:24.253Z,1695086724.253 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2023-09-19T01:25:24.260Z,1695086724.260 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2023-09-19T01:25:24.260Z,1695086724.260 [CBIT](DEBUG): Initializing heartbeat.
2023-09-19T01:25:24.261Z,1695086724.261 [Onboard ThreadHandler](INFO): Handler Thread ID is 7319
2023-09-19T01:25:24.281Z,1695086724.281 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 7320
2023-09-19T01:25:24.292Z,1695086724.292 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 7321
2023-09-19T01:25:24.293Z,1695086724.293 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2023-09-19T01:25:24.296Z,1695086724.296 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 7323
2023-09-19T01:25:24.306Z,1695086724.306 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2HA05M.000
2023-09-19T01:25:24.306Z,1695086724.306 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2HA05M.000
2023-09-19T01:25:24.306Z,1695086724.306 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3HA20M.000
2023-09-19T01:25:24.306Z,1695086724.306 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3HA20M.000
2023-09-19T01:25:24.306Z,1695086724.306 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4HA51M.000
2023-09-19T01:25:24.306Z,1695086724.306 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4HA51M.000
2023-09-19T01:25:24.307Z,1695086724.307 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4HA51M.000
2023-09-19T01:25:24.307Z,1695086724.307 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4HA51M.000
2023-09-19T01:25:24.307Z,1695086724.307 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5HA53M.000
2023-09-19T01:25:24.307Z,1695086724.307 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5HA53M.000
2023-09-19T01:25:24.307Z,1695086724.307 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5HA55M.000
2023-09-19T01:25:24.307Z,1695086724.307 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5HA55M.000
2023-09-19T01:25:24.332Z,1695086724.332 [CBIT](DEBUG): Deactivating GF circuits.
2023-09-19T01:25:24.332Z,1695086724.332 [CBIT](DEBUG): Deactivating emergency mode.
2023-09-19T01:25:24.372Z,1695086724.372 [CBIT](DEBUG): Backplane powered.
2023-09-19T01:25:24.372Z,1695086724.372 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2023-09-19T01:25:24.373Z,1695086724.373 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2023-09-19T01:25:24.373Z,1695086724.373 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2023-09-19T01:25:24.373Z,1695086724.373 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2023-09-19T01:25:24.374Z,1695086724.374 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2023-09-19T01:25:24.375Z,1695086724.375 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2023-09-19T01:25:24.376Z,1695086724.376 [NavChart](DEBUG): Initialize NavChart Navigation.
2023-09-19T01:25:24.376Z,1695086724.376 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2023-09-19T01:25:24.381Z,1695086724.381 [MissionManager](INFO): Loading Mission from file: Missions/Startup.xml
2023-09-19T01:25:24.403Z,1695086724.403 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2023-09-19T01:25:24.429Z,1695086724.429 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns="Tethys"
       xmlns:Control="Tethys/Control"
       xmlns:Guidance="Tethys/Guidance" 
       xmlns:Units="Tethys/Units"
       xmlns:Universal="Tethys/Universal"
       xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
       xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                           Tethys/Control http://okeanids.mbari.org/tethys/Xml/Control.xsd
                           Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                           Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                           Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
       Id="Startup">

    <Guidance:GoToSurface>
        <Progression/>
    </Guidance:GoToSurface>

    <Aggregate Id="StartupSatComms">

        <Sequence/>

        <ReadDatum>
            <Timeout Duration="P1M" />
            <Universal:latitude_fix/>
        </ReadDatum>

        <ReadDatum>
            <Timeout Duration="P1M" />
            <Universal:platform_communications/>
        </ReadDatum>

    </Aggregate>

</Mission>


2023-09-19T01:25:24.430Z,1695086724.430 [MissionManager](INFO): Loading Mission from file: Missions/Default.xml
2023-09-19T01:25:24.478Z,1695086724.478 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2023-09-19T01:25:24.479Z,1695086724.479 [Default:A.Wait](DEBUG): Construct Wait.
2023-09-19T01:25:24.482Z,1695086724.482 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2023-09-19T01:25:24.514Z,1695086724.514 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2023-09-19T01:25:24.518Z,1695086724.518 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2023-09-19T01:25:24.523Z,1695086724.523 [Default:E.Execute](DEBUG): Construct Execute.
2023-09-19T01:25:24.527Z,1695086724.527 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
         xmlns="Tethys"
         xmlns:Units="Tethys/Units"
         xmlns:Guidance="Tethys/Guidance"
         xmlns:Universal="Tethys/Universal"
         xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                             Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                             Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                             Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
         Id="Default">

    <DefineArg Name="ElapsedSinceDefaultStarted"><Units:minute/><Value>0</Value></DefineArg>

    <Guidance:Wait>
        <Description>
            Wait a moment to see if the scheduler starts a new mission before
            starting to actually run Default.
        </Description>
        <Sequence/>
        <Setting><Guidance:Wait.duration/><Units:second/><Value>13</Value></Setting>
    </Guidance:Wait>

    <Guidance:GoToSurface>
        <Progression/>
    </Guidance:GoToSurface>

    <Aggregate Id="CheckIn">

        <Sequence Repeat="288"/>

        <ReadDatum Id="Read_GPS">
            <Timeout Duration="P5M"/>
            <Universal:time_fix/>
        </ReadDatum>

        <ReadDatum Id="Read_Iridium">
            <Timeout Duration="P4H">
                <Guidance:Execute>
                    <Sequence/>
                    <Setting><Guidance:Execute.command/><String>Burn on</String></Setting>
                </Guidance:Execute>
                <Syslog Severity="Critical">Dropped weight due to communications timeout.</Syslog>
            </Timeout>
            <Universal:platform_communications/>
        </ReadDatum>

        <Guidance:Wait>
            <Sequence/>
            <Setting><Guidance:Wait.duration/><Units:minute/><Value>5</Value></Setting>
        </Guidance:Wait>

        <Assign><Sequence/><Arg Name="ElapsedSinceDefaultStarted"/><Elapsed><Universal:mission_started/></Elapsed></Assign>

        <Syslog Severity="Important">Default mission has been running for <Arg Name="ElapsedSinceDefaultStarted"/><Units:minute/></Syslog>

    </Aggregate>

    <Syslog Severity="Important">Restarting logs and Default mission.</Syslog>

    <Guidance:Execute>
        <Sequence/>
        <Setting><Guidance:Execute.command/><String>restart logs</String></Setting>
    </Guidance:Execute>

</Mission>


2023-09-19T01:25:24.544Z,1695086724.544 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,NAL9602,Power24vConverter,ESPComponent,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,DeadReckonWithRespectToSeafloor,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter,
2023-09-19T01:25:24.551Z,1695086724.551 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2023-09-19T01:25:24.597Z,1695086724.597 [Depth_Keller](ERROR): Pressure or depth reading out of range: -1.140412 decibar, -1.132002 m
2023-09-19T01:25:24.599Z,1695086724.599 [Power24vConverter](INFO): Powering up.
2023-09-19T01:25:24.602Z,1695086724.602 [DepthRateCalculator](ERROR): Depth measurement is not active
2023-09-19T01:25:24.636Z,1695086724.636 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2023-09-19T01:25:24.644Z,1695086724.644 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2023-09-19T01:25:24.645Z,1695086724.645 [ElevatorServo](DEBUG): Initializing EZServoServo.
2023-09-19T01:25:24.652Z,1695086724.652 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2023-09-19T01:25:24.653Z,1695086724.653 [MassServo](DEBUG): Initializing EZServoServo.
2023-09-19T01:25:24.660Z,1695086724.660 [MassServo](DEBUG): Initializing MassServo.
2023-09-19T01:25:24.661Z,1695086724.661 [RudderServo](DEBUG): Initializing EZServoServo.
2023-09-19T01:25:24.668Z,1695086724.668 [RudderServo](DEBUG): Initializing RudderServo.
2023-09-19T01:25:24.669Z,1695086724.669 [ThrusterHE](DEBUG): Initializing EZServoServo.
2023-09-19T01:25:24.676Z,1695086724.676 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2023-09-19T01:25:24.684Z,1695086724.684 [Radio_Surface](INFO): Powering up
2023-09-19T01:25:25.012Z,1695086725.012 [DropWeight](CRITICAL): DROP WEIGHT MISSING.

2023-09-19T01:25:25.012Z,1695086725.012 [DropWeight] Hardware Fault, FailCount= 1
2023-09-19T01:25:25.013Z,1695086725.013 [DropWeight](ERROR): Hardware Fault
2023-09-19T01:25:25.043Z,1695086725.043 [CommandExec](FAULT): Scheduling is paused
2023-09-19T01:25:25.048Z,1695086725.048 [CBIT](INFO): Critical error at 20230919T012525
2023-09-19T01:25:25.048Z,1695086725.048 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2023-09-19T01:25:25.051Z,1695086725.051 [CBIT](ERROR): Hardware Fault in component: DropWeight
2023-09-19T01:25:25.051Z,1695086725.051 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2023-09-19T01:25:25.382Z,1695086725.382 [CBIT](INFO): Critical error at 20230919T012525
2023-09-19T01:25:27.782Z,1695086727.782 [AHRS_M2](DEBUG): boresightMatrix m[ decimal 0 0 2 2 f0.0 f0.0 f-1.0 f0.0 f-1.0 f0.0 f-1.0 f0.0 f0.0 ]m set drop

2023-09-19T01:25:28.185Z,1695086728.185 [AHRS_M2](DEBUG): chan0Format 2 set drop

2023-09-19T01:25:28.590Z,1695086728.590 [AHRS_M2](DEBUG): chan0Trigger 5 set drop

2023-09-19T01:25:28.993Z,1695086728.993 [AHRS_M2](DEBUG): chan0Enables array[ 0 15 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 ]array set drop

2023-09-19T01:25:28.993Z,1695086728.993 [AHRS_M2](DEBUG): chan0EnableBit pitch dvid@ set drop

2023-09-19T01:25:29.397Z,1695086729.397 [AHRS_M2](DEBUG): chan0EnableBit roll dvid@ set drop

2023-09-19T01:25:29.801Z,1695086729.801 [AHRS_M2](DEBUG): chan0EnableBit yaw dvid@ set drop

2023-09-19T01:25:30.205Z,1695086730.205 [AHRS_M2](DEBUG): chan0EnableBit magp dvid@ set drop

2023-09-19T01:25:30.385Z,1695086730.385 [ThrusterHE](ERROR): Zero Speed Commanded.
2023-09-19T01:25:30.609Z,1695086730.609 [AHRS_M2](DEBUG): chan0EnableBit accelp dvid@ set drop

2023-09-19T01:25:31.013Z,1695086731.013 [AHRS_M2](DEBUG): chan0EnableBit gyrop dvid@ set drop

2023-09-19T01:25:31.417Z,1695086731.417 [AHRS_M2](DEBUG): chan0EnableBit yawErrEst dvid@ set drop

2023-09-19T01:25:31.821Z,1695086731.821 [AHRS_M2](DEBUG): chan0EnableBit temperature dvid@ set drop

2023-09-19T01:25:32.225Z,1695086732.225 [AHRS_M2](DEBUG): chan0EnableBit magBufferActiveIndex dvid@ set drop

2023-09-19T01:25:32.629Z,1695086732.629 [AHRS_M2](DEBUG): chan0TriggerDivisor 40 set drop

2023-09-19T01:25:34.333Z,1695086734.333 [CBIT](CRITICAL): Environmental Failure. Press:14.711939 PSI. Humidity:53%. Temp:24 C. ABORTING MISSION
2023-09-19T01:25:34.494Z,1695086734.494 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004688
2023-09-19T01:25:34.706Z,1695086734.706 [CBIT](INFO): Critical error at 20230919T012534
2023-09-19T01:25:42.729Z,1695086742.729 [AHRS_M2](FAULT): Failed to acquire valid data within timeout.
2023-09-19T01:25:42.729Z,1695086742.729 [AHRS_M2] Data Fault, FailCount= 1
2023-09-19T01:25:42.729Z,1695086742.729 [AHRS_M2](ERROR): Data Fault
2023-09-19T01:25:42.800Z,1695086742.800 [CBIT](ERROR): Data Fault in component: AHRS_M2
2023-09-19T01:25:42.800Z,1695086742.800 [CBIT](CRITICAL): Data Fault in component: AHRS_M2
2023-09-19T01:25:43.174Z,1695086743.174 [CBIT](INFO): Critical error at 20230919T012542
2023-09-19T01:25:52.433Z,1695086752.433 [NAL9602](INFO): Powering up NAL9602
2023-09-19T01:26:03.343Z,1695086763.343 [NAL9602](INFO): NAL9602 initialized
2023-09-19T01:26:31.210Z,1695086791.210 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2023-09-19T01:26:35.675Z,1695086795.675 [SBIT](IMPORTANT): Beginning Startup BIT
2023-09-19T01:26:35.680Z,1695086795.680 [CBIT](IMPORTANT): Beginning ground fault scan
2023-09-19T01:26:44.945Z,1695086804.945 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2023-09-19T01:26:46.641Z,1695086806.641 [CBIT](IMPORTANT): Ground fault detected
mA:
CHAN A0 (Batt): 0.025287
CHAN A1 (24V): 0.051876
CHAN A2 (12V): -0.000399
CHAN A3 (5V): -0.001562
CHAN B0 (3.3V): 0.000535
CHAN B1 (3.15aV): 0.000214
CHAN B2 (3.15bV): -0.000122
CHAN B3 (GND): 0.002166
OPEN: 0.007093
Full Scale: +/- 1 mA
2023-09-19T01:26:59.085Z,1695086819.085 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2023-09-19T01:27:13.225Z,1695086833.225 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2023-09-19T01:27:24.551Z,1695086844.551 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2023-09-19T01:27:24.551Z,1695086844.551 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2023-09-19T01:27:24.551Z,1695086844.551 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-09-19T01:27:24.553Z,1695086844.553 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2023-09-19T01:27:24.553Z,1695086844.553 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1
2023-09-19T01:27:24.553Z,1695086844.553 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2023-09-19T01:27:24.554Z,1695086844.554 [DeadReckonWithRespectToSeafloor](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2023-09-19T01:27:24.554Z,1695086844.554 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1
2023-09-19T01:27:24.554Z,1695086844.554 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2023-09-19T01:27:24.565Z,1695086844.565 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-09-19T01:27:24.565Z,1695086844.565 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2023-09-19T01:27:24.566Z,1695086844.566 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2023-09-19T01:27:24.986Z,1695086844.986 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-09-19T01:27:24.986Z,1695086844.986 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2023-09-19T01:27:24.987Z,1695086844.987 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2023-09-19T01:27:24.987Z,1695086844.987 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1
2023-09-19T01:27:24.987Z,1695086844.987 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2023-09-19T01:27:24.987Z,1695086844.987 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1
2023-09-19T01:27:25.376Z,1695086845.376 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2023-09-19T01:27:27.365Z,1695086847.365 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2023-09-19T01:27:29.831Z,1695086849.831 [SBIT](IMPORTANT): SBIT PASSED
2023-09-19T01:27:29.836Z,1695086849.836 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2023-09-19T01:27:29.837Z,1695086849.837 [SBIT](IMPORTANT): BackseatComponent.loadAtStartup=1 bool;

2023-09-19T01:27:29.837Z,1695086849.837 [SBIT](IMPORTANT): DAT.loadAtStartup=0 bool;

2023-09-19T01:27:29.837Z,1695086849.837 [SBIT](IMPORTANT): PowerOnly.sampleTime1=1 second;

2023-09-19T01:27:29.837Z,1695086849.837 [SBIT](IMPORTANT): Rowe_600.loadAtStartup=0 bool;

2023-09-19T01:27:29.837Z,1695086849.837 [SBIT](IMPORTANT): WetLabsBB2FL.loadAtStartup=0 bool;

2023-09-19T01:27:30.243Z,1695086850.243 [MissionManager](IMPORTANT): Started mission Startup
2023-09-19T01:27:30.244Z,1695086850.244 [Startup] Running Loop=1
2023-09-19T01:27:30.244Z,1695086850.244 [Startup](DEBUG): Aggregate::initialize Startup
2023-09-19T01:27:30.244Z,1695086850.244 [Startup:A.GoToSurface] Running Loop=1
2023-09-19T01:27:30.244Z,1695086850.244 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2023-09-19T01:27:30.245Z,1695086850.245 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2023-09-19T01:27:30.245Z,1695086850.245 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2023-09-19T01:27:30.245Z,1695086850.245 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2023-09-19T01:27:30.246Z,1695086850.246 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2023-09-19T01:27:30.246Z,1695086850.246 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2023-09-19T01:27:30.247Z,1695086850.247 [Startup:StartupSatComms] Running Loop=1
2023-09-19T01:27:30.248Z,1695086850.248 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2023-09-19T01:27:30.248Z,1695086850.248 [Startup:StartupSatComms:A] Running Loop=1
2023-09-19T01:27:30.632Z,1695086850.632 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2023-09-19T01:27:41.505Z,1695086861.505 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2023-09-19T01:27:55.244Z,1695086875.244 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2023-09-19T01:28:24.789Z,1695086904.789 [CommandExec](IMPORTANT): got command strobe off
2023-09-19T01:28:24.789Z,1695086904.789 [CommandExec](IMPORTANT): Deactivating strobe
2023-09-19T01:28:30.418Z,1695086910.418 [Startup:StartupSatComms:A](INFO): Timed out from 2023-09-19T01:27:30.2Z
2023-09-19T01:28:30.418Z,1695086910.418 [Startup:StartupSatComms:A] Stopped
2023-09-19T01:28:30.418Z,1695086910.418 [Startup:StartupSatComms:B] Running Loop=1
2023-09-19T01:28:30.821Z,1695086910.821 [CommandExec](IMPORTANT): got command strobe on
2023-09-19T01:28:30.821Z,1695086910.821 [CommandExec](IMPORTANT): Activating strobe
2023-09-19T01:28:30.822Z,1695086910.822 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2023-09-19T01:28:31.584Z,1695086911.584 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230915T221947/Courier0022.lzma
2023-09-19T01:28:32.298Z,1695086912.298 [DataOverHttps](INFO): Moved sent file to Logs/20230915T221947/Courier0022.lzma.bak
2023-09-19T01:28:32.298Z,1695086912.298 [DataOverHttps](INFO): SBD MOMSN=18783314
2023-09-19T01:28:35.713Z,1695086915.713 [CommandExec](IMPORTANT): got command strobe off
2023-09-19T01:28:35.713Z,1695086915.713 [CommandExec](IMPORTANT): Deactivating strobe
2023-09-19T01:28:40.601Z,1695086920.601 [CommandExec](IMPORTANT): got command quit
2023-09-19T01:28:41.604Z,1695086921.604 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread.
2023-09-19T01:28:41.604Z,1695086921.604 [CommandExec](INFO): Uninitializing the command executive.
2023-09-19T01:28:41.604Z,1695086921.604 [CommandExec](INFO): Uninitializing the command scheduler.
2023-09-19T01:28:41.605Z,1695086921.605 [CommandExec ThreadHandler](INFO): Thread cancelled.
2023-09-19T01:28:41.760Z,1695086921.760 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2023-09-19T01:28:41.760Z,1695086921.760 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2023-09-19T01:28:41.760Z,1695086921.760 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2023-09-19T01:28:41.761Z,1695086921.761 [NavChartDb](INFO): Join timeout helper Thread ID is 7341
2023-09-19T01:28:41.968Z,1695086921.968 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2023-09-19T01:28:41.968Z,1695086921.968 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2023-09-19T01:28:41.984Z,1695086921.984 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2023-09-19T01:28:41.984Z,1695086921.984 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2023-09-19T01:28:41.985Z,1695086921.985 [CTD_Seabird](INFO): Join timeout helper Thread ID is 7342
2023-09-19T01:28:42.136Z,1695086922.136 [CTD_Seabird](INFO): Powering down
2023-09-19T01:28:42.148Z,1695086922.148 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2023-09-19T01:28:42.148Z,1695086922.148 [CTD_Seabird](INFO): Powering down
2023-09-19T01:28:42.160Z,1695086922.160 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2023-09-19T01:28:42.164Z,1695086922.164 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2023-09-19T01:28:42.164Z,1695086922.164 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2023-09-19T01:28:42.164Z,1695086922.164 [Radio_Surface](INFO): Join timeout helper Thread ID is 7343
2023-09-19T01:28:42.252Z,1695086922.252 [Radio_Surface](INFO): Powering down
2023-09-19T01:28:42.253Z,1695086922.253 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2023-09-19T01:28:42.253Z,1695086922.253 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2023-09-19T01:28:42.256Z,1695086922.256 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2023-09-19T01:28:42.256Z,1695086922.256 [Onboard ThreadHandler](INFO): Thread cancelled.
2023-09-19T01:28:42.256Z,1695086922.256 [Onboard](INFO): Join timeout helper Thread ID is 7344
2023-09-19T01:28:44.464Z,1695086924.464 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2023-09-19T01:28:44.464Z,1695086924.464 [Onboard ThreadHandler](INFO): Thread cancelled.
2023-09-19T01:28:44.484Z,1695086924.484 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2023-09-19T01:28:44.484Z,1695086924.484 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2023-09-19T01:28:44.484Z,1695086924.484 [DataOverHttps](INFO): Join timeout helper Thread ID is 7345
2023-09-19T01:28:45.388Z,1695086925.388 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2023-09-19T01:28:45.389Z,1695086925.389 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2023-09-19T01:28:45.405Z,1695086925.405 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler
2023-09-19T01:28:45.405Z,1695086925.405 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2023-09-19T01:28:45.405Z,1695086925.405 [BackseatComponent](INFO): Join timeout helper Thread ID is 7346
2023-09-19T01:28:45.460Z,1695086925.460 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread.
2023-09-19T01:28:45.460Z,1695086925.460 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2023-09-19T01:28:45.473Z,1695086925.473 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2023-09-19T01:28:45.473Z,1695086925.473 [logger ThreadHandler](INFO): Thread cancelled.
2023-09-19T01:28:45.473Z,1695086925.473 [logger](INFO): Join timeout helper Thread ID is 7347
2023-09-19T01:28:45.476Z,1695086925.476 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2023-09-19T01:28:45.476Z,1695086925.476 [logger ThreadHandler](INFO): Thread cancelled.
2023-09-19T01:28:45.481Z,1695086925.481 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2023-09-19T01:28:45.481Z,1695086925.481 [CommandLine ThreadHandler](INFO): Thread cancelled.
2023-09-19T01:28:45.482Z,1695086925.482 [CommandLine](INFO): Join timeout helper Thread ID is 7348
2023-09-19T01:28:45.504Z,1695086925.504 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2023-09-19T01:28:45.504Z,1695086925.504 [CommandLine ThreadHandler](INFO): Thread cancelled.
2023-09-19T01:28:45.512Z,1695086925.512 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler
2023-09-19T01:28:45.513Z,1695086925.513 [CommandExec ThreadHandler](INFO): Thread cancelled.
2023-09-19T01:28:45.513Z,1695086925.513 [CommandExec](INFO): Join timeout helper Thread ID is 7349
2023-09-19T01:28:45.514Z,1695086925.514 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2023-09-19T01:28:45.514Z,1695086925.514 [controlThread ThreadHandler](INFO): Thread cancelled.
2023-09-19T01:28:45.515Z,1695086925.515 [controlThread](INFO): Join timeout helper Thread ID is 7350
2023-09-19T01:28:45.868Z,1695086925.868 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2023-09-19T01:28:45.868Z,1695086925.868 [controlThread](DEBUG): Uninitializing ControlThread
2023-09-19T01:28:45.870Z,1695086925.870 [NAL9602](INFO): Powering down
2023-09-19T01:28:45.872Z,1695086925.872 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2023-09-19T01:28:45.873Z,1695086925.873 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2023-09-19T01:28:45.873Z,1695086925.873 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2023-09-19T01:28:45.874Z,1695086925.874 [MissionManager](INFO): Uninitializing Mission Default
2023-09-19T01:28:45.876Z,1695086925.876 [MissionManager](INFO): Uninitializing Mission Startup
2023-09-19T01:28:45.876Z,1695086925.876 [Startup] Stopped
2023-09-19T01:28:45.876Z,1695086925.876 [Startup](DEBUG): Aggregate::uninitialize Startup
2023-09-19T01:28:45.877Z,1695086925.877 [Startup:A.GoToSurface] Stopped
2023-09-19T01:28:45.877Z,1695086925.877 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2023-09-19T01:28:45.877Z,1695086925.877 [Startup:StartupSatComms] Stopped
2023-09-19T01:28:45.877Z,1695086925.877 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2023-09-19T01:28:45.877Z,1695086925.877 [Startup:StartupSatComms:B] Stopped
2023-09-19T01:28:45.878Z,1695086925.878 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2023-09-19T01:28:45.878Z,1695086925.878 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2023-09-19T01:28:45.879Z,1695086925.879 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2023-09-19T01:28:45.879Z,1695086925.879 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2023-09-19T01:28:45.879Z,1695086925.879 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2023-09-19T01:28:45.879Z,1695086925.879 [BuoyancyServo](INFO): Powering down
2023-09-19T01:28:45.892Z,1695086925.892 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2023-09-19T01:28:45.892Z,1695086925.892 [ElevatorServo](INFO): Powering down
2023-09-19T01:28:45.893Z,1695086925.893 [MassServo](DEBUG): Uninitialize Mass Servo.
2023-09-19T01:28:45.893Z,1695086925.893 [MassServo](INFO): Powering down
2023-09-19T01:28:45.894Z,1695086925.894 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2023-09-19T01:28:45.894Z,1695086925.894 [RudderServo](INFO): Powering down
2023-09-19T01:28:45.895Z,1695086925.895 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2023-09-19T01:28:45.895Z,1695086925.895 [ThrusterHE](INFO): Powering down
2023-09-19T01:28:45.896Z,1695086925.896 [SBIT](DEBUG): Uninitialize SBIT Component.
2023-09-19T01:28:45.896Z,1695086925.896 [IBIT](DEBUG): Uninitialize IBIT Component.
2023-09-19T01:28:45.897Z,1695086925.897 [CBIT](DEBUG): Uninitialize CBIT Component.
2023-09-19T01:28:45.897Z,1695086925.897 [CBIT](DEBUG): Powering off loads.
2023-09-19T01:28:45.908Z,1695086925.908 [CBIT](DEBUG): Disabling WDT.
2023-09-19T01:28:45.920Z,1695086925.920 [CBIT](DEBUG): Opening all GF detection circuits.
2023-09-19T01:28:45.921Z,1695086925.921 [controlThread ThreadHandler](INFO): Thread cancelled.
2023-09-19T01:28:45.959Z,1695086925.959 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2023-09-19T01:28:45.962Z,1695086925.962 [Onboard ThreadHandler](INFO): Thread cancelled.
2023-09-19T01:28:45.967Z,1695086925.967 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2023-09-19T01:28:46.011Z,1695086926.011 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2023-09-19T01:28:46.099Z,1695086926.099 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2023-09-19T01:28:46.107Z,1695086926.107 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2023-09-19T01:28:46.153Z,1695086926.153 [logger ThreadHandler](INFO): Thread cancelled.