2024-02-27T21:42:55.921Z,1709070175.921 [Supervisor](DEBUG): Initializing supervisor.
2024-02-27T21:42:55.925Z,1709070175.925 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2024-02-27T21:42:55.926Z,1709070175.926 [SyncHandler](INFO): Protected caller Thread ID is 9164
2024-02-27T21:42:55.926Z,1709070175.926 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2024-02-27T21:42:55.927Z,1709070175.927 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2024-02-27T21:42:55.927Z,1709070175.927 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 9165
2024-02-27T21:42:55.931Z,1709070175.931 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2024-02-27T21:42:55.948Z,1709070175.948 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2024-02-27T21:42:55.949Z,1709070175.949 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2024-02-27T21:42:55.950Z,1709070175.950 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 9166
2024-02-27T21:42:55.954Z,1709070175.954 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2024-02-27T21:42:55.955Z,1709070175.955 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2024-02-27T21:42:55.955Z,1709070175.955 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 9167
2024-02-27T21:42:55.957Z,1709070175.957 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2024-02-27T21:42:55.958Z,1709070175.958 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2024-02-27T21:42:55.958Z,1709070175.958 [logger ThreadHandler](INFO): Protected caller Thread ID is 9168
2024-02-27T21:42:55.962Z,1709070175.962 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2024-02-27T21:42:55.962Z,1709070175.962 [Supervisor](INFO): Looking for Config files in directory: Config/
2024-02-27T21:42:55.964Z,1709070175.964 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2024-02-27T21:42:56.174Z,1709070176.174 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2024-02-27T21:42:56.175Z,1709070176.175 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2024-02-27T21:42:56.284Z,1709070176.284 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2024-02-27T21:42:56.285Z,1709070176.285 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2024-02-27T21:42:56.382Z,1709070176.382 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2024-02-27T21:42:56.382Z,1709070176.382 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2024-02-27T21:42:56.861Z,1709070176.861 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2024-02-27T21:42:56.861Z,1709070176.861 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2024-02-27T21:42:57.212Z,1709070177.212 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2024-02-27T21:42:57.212Z,1709070177.212 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2024-02-27T21:42:57.545Z,1709070177.545 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2024-02-27T21:42:57.546Z,1709070177.546 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2024-02-27T21:42:57.738Z,1709070177.738 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2024-02-27T21:42:57.738Z,1709070177.738 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2024-02-27T21:42:57.819Z,1709070177.819 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2024-02-27T21:42:57.901Z,1709070177.901 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2024-02-27T21:42:58.306Z,1709070178.306 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2024-02-27T21:42:58.306Z,1709070178.306 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2024-02-27T21:42:58.587Z,1709070178.587 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2024-02-27T21:42:58.588Z,1709070178.588 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2024-02-27T21:42:59.101Z,1709070179.101 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2024-02-27T21:42:59.101Z,1709070179.101 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2024-02-27T21:42:59.326Z,1709070179.326 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2024-02-27T21:42:59.327Z,1709070179.327 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2024-02-27T21:42:59.576Z,1709070179.576 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2024-02-27T21:42:59.576Z,1709070179.576 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2024-02-27T21:42:59.719Z,1709070179.719 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2024-02-27T21:42:59.719Z,1709070179.719 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2024-02-27T21:43:00.550Z,1709070180.550 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2024-02-27T21:43:00.552Z,1709070180.552 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-galene/
2024-02-27T21:43:00.553Z,1709070180.553 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/secure.cfg
2024-02-27T21:43:00.705Z,1709070180.705 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/vehicle.cfg
2024-02-27T21:43:01.265Z,1709070181.265 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Battery.cfg
2024-02-27T21:43:01.723Z,1709070181.723 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2024-02-27T21:43:01.723Z,1709070181.723 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Science.cfg
2024-02-27T21:43:01.850Z,1709070181.850 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Control.cfg
2024-02-27T21:43:01.951Z,1709070181.951 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/logger.cfg
2024-02-27T21:43:02.045Z,1709070182.045 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Servo.cfg
2024-02-27T21:43:02.153Z,1709070182.153 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Navigation.cfg
2024-02-27T21:43:02.249Z,1709070182.249 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Simulator.cfg
2024-02-27T21:43:02.336Z,1709070182.336 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/BIT.cfg
2024-02-27T21:43:02.436Z,1709070182.436 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/workSite.cfg
2024-02-27T21:43:02.521Z,1709070182.521 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Sensor.cfg
2024-02-27T21:43:02.693Z,1709070182.693 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2024-02-27T21:43:02.702Z,1709070182.702 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2024-02-27T21:43:02.756Z,1709070182.756 [DepthRateCalculator] Loaded
2024-02-27T21:43:02.756Z,1709070182.756 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2024-02-27T21:43:02.762Z,1709070182.762 [PitchRateCalculator] Loaded
2024-02-27T21:43:02.762Z,1709070182.762 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2024-02-27T21:43:02.773Z,1709070182.773 [SpeedCalculator] Loaded
2024-02-27T21:43:02.773Z,1709070182.773 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2024-02-27T21:43:02.778Z,1709070182.778 [YawRateCalculator] Loaded
2024-02-27T21:43:02.778Z,1709070182.778 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2024-02-27T21:43:02.799Z,1709070182.799 [ElevatorOffsetCalculator] Loaded
2024-02-27T21:43:02.800Z,1709070182.800 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2024-02-27T21:43:02.800Z,1709070182.800 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2024-02-27T21:43:02.801Z,1709070182.801 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2024-02-27T21:43:02.828Z,1709070182.828 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2024-02-27T21:43:02.829Z,1709070182.829 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2024-02-27T21:43:02.839Z,1709070182.839 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2024-02-27T21:43:02.840Z,1709070182.840 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2024-02-27T21:43:03.289Z,1709070183.289 [AHRS_M2] Loaded
2024-02-27T21:43:03.289Z,1709070183.289 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2024-02-27T21:43:03.326Z,1709070183.326 [BackseatComponent] Loaded
2024-02-27T21:43:03.326Z,1709070183.326 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread.
2024-02-27T21:43:03.327Z,1709070183.327 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 4084F4E0
2024-02-27T21:43:03.327Z,1709070183.327 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 9253
2024-02-27T21:43:03.330Z,1709070183.330 [LcmUniversalReporter] Loaded
2024-02-27T21:43:03.331Z,1709070183.331 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread.
2024-02-27T21:43:04.161Z,1709070184.161 [BPC1] Loaded
2024-02-27T21:43:04.161Z,1709070184.161 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2024-02-27T21:43:04.235Z,1709070184.235 [DataOverHttps] Loaded
2024-02-27T21:43:04.235Z,1709070184.235 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2024-02-27T21:43:04.236Z,1709070184.236 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 4087F4E0
2024-02-27T21:43:04.236Z,1709070184.236 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 9254
2024-02-27T21:43:04.257Z,1709070184.257 [Depth_Keller] Loaded
2024-02-27T21:43:04.257Z,1709070184.257 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2024-02-27T21:43:04.262Z,1709070184.262 [DropWeight] Loaded
2024-02-27T21:43:04.263Z,1709070184.263 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2024-02-27T21:43:04.281Z,1709070184.281 [MultiRay] Loaded
2024-02-27T21:43:04.282Z,1709070184.282 [ComponentRegistry](DEBUG): SyncComponent "MultiRay" handled in the control thread.
2024-02-27T21:43:04.345Z,1709070184.345 [NAL9602] Loaded
2024-02-27T21:43:04.345Z,1709070184.345 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2024-02-27T21:43:04.375Z,1709070184.375 [Onboard] Loaded
2024-02-27T21:43:04.375Z,1709070184.375 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2024-02-27T21:43:04.376Z,1709070184.376 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 408AF4E0
2024-02-27T21:43:04.377Z,1709070184.377 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 9255
2024-02-27T21:43:04.383Z,1709070184.383 [PowerOnly](INFO): Adding load control power supply at /dev/loadC3
2024-02-27T21:43:04.394Z,1709070184.394 [PowerOnly] Loaded
2024-02-27T21:43:04.395Z,1709070184.395 [ComponentRegistry](DEBUG): SyncComponent "PowerOnly" handled in the control thread.
2024-02-27T21:43:04.406Z,1709070184.406 [Power24vConverter] Loaded
2024-02-27T21:43:04.407Z,1709070184.407 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2024-02-27T21:43:04.421Z,1709070184.421 [Radio_Surface] Loaded
2024-02-27T21:43:04.422Z,1709070184.422 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2024-02-27T21:43:04.423Z,1709070184.423 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 408DF4E0
2024-02-27T21:43:04.423Z,1709070184.423 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 9256
2024-02-27T21:43:04.517Z,1709070184.517 [DAT] Loaded
2024-02-27T21:43:04.517Z,1709070184.517 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread.
2024-02-27T21:43:04.518Z,1709070184.518 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 4090F4E0
2024-02-27T21:43:04.518Z,1709070184.518 [DAT ThreadHandler](INFO): Protected caller Thread ID is 9257
2024-02-27T21:43:04.519Z,1709070184.519 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2024-02-27T21:43:04.519Z,1709070184.519 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2024-02-27T21:43:04.635Z,1709070184.635 [DeadReckonUsingMultipleVelocitySources] Loaded
2024-02-27T21:43:04.635Z,1709070184.635 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2024-02-27T21:43:04.678Z,1709070184.678 [DeadReckonUsingSpeedCalculator] Loaded
2024-02-27T21:43:04.678Z,1709070184.678 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2024-02-27T21:43:04.692Z,1709070184.692 [NavChart] Loaded
2024-02-27T21:43:04.692Z,1709070184.692 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2024-02-27T21:43:04.698Z,1709070184.698 [UniversalFixResidualReporter] Loaded
2024-02-27T21:43:04.698Z,1709070184.698 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2024-02-27T21:43:04.698Z,1709070184.698 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2024-02-27T21:43:04.699Z,1709070184.699 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2024-02-27T21:43:04.849Z,1709070184.849 [SBIT](DEBUG): Construct Startup Built In Test.
2024-02-27T21:43:04.863Z,1709070184.863 [SBIT] Loaded
2024-02-27T21:43:04.864Z,1709070184.864 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2024-02-27T21:43:04.867Z,1709070184.867 [IBIT](DEBUG): Construct Initiated Built In Test.
2024-02-27T21:43:04.880Z,1709070184.880 [IBIT] Loaded
2024-02-27T21:43:04.880Z,1709070184.880 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2024-02-27T21:43:04.886Z,1709070184.886 [CBIT](DEBUG): Construct Continuous Built In Test.
2024-02-27T21:43:04.991Z,1709070184.991 [CBIT] Loaded
2024-02-27T21:43:04.991Z,1709070184.991 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2024-02-27T21:43:04.992Z,1709070184.992 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2024-02-27T21:43:04.992Z,1709070184.992 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2024-02-27T21:43:05.177Z,1709070185.177 [CTD_Seabird] Loaded
2024-02-27T21:43:05.177Z,1709070185.177 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2024-02-27T21:43:05.178Z,1709070185.178 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40A164E0
2024-02-27T21:43:05.178Z,1709070185.178 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 9258
2024-02-27T21:43:05.198Z,1709070185.198 [PAR_Licor] Loaded
2024-02-27T21:43:05.199Z,1709070185.199 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2024-02-27T21:43:05.241Z,1709070185.241 [WetLabsBB2FL] Loaded
2024-02-27T21:43:05.242Z,1709070185.242 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2024-02-27T21:43:05.243Z,1709070185.243 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40A464E0
2024-02-27T21:43:05.243Z,1709070185.243 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 9259
2024-02-27T21:43:05.244Z,1709070185.244 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2024-02-27T21:43:05.244Z,1709070185.244 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2024-02-27T21:43:05.386Z,1709070185.386 [BuoyancyServo] Loaded
2024-02-27T21:43:05.386Z,1709070185.386 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2024-02-27T21:43:05.408Z,1709070185.408 [ElevatorServo] Loaded
2024-02-27T21:43:05.409Z,1709070185.409 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2024-02-27T21:43:05.430Z,1709070185.430 [MassServo] Loaded
2024-02-27T21:43:05.430Z,1709070185.430 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2024-02-27T21:43:05.453Z,1709070185.453 [RudderServo] Loaded
2024-02-27T21:43:05.454Z,1709070185.454 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2024-02-27T21:43:05.469Z,1709070185.469 [ThrusterHE] Loaded
2024-02-27T21:43:05.470Z,1709070185.470 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread.
2024-02-27T21:43:05.470Z,1709070185.470 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2024-02-27T21:43:05.471Z,1709070185.471 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2024-02-27T21:43:05.524Z,1709070185.524 [VerticalControl](DEBUG): Construct VerticalControl.
2024-02-27T21:43:05.575Z,1709070185.575 [VerticalControl] Loaded
2024-02-27T21:43:05.575Z,1709070185.575 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2024-02-27T21:43:05.578Z,1709070185.578 [HorizontalControl](DEBUG): Construct HorizontalControl.
2024-02-27T21:43:05.616Z,1709070185.616 [HorizontalControl] Loaded
2024-02-27T21:43:05.616Z,1709070185.616 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2024-02-27T21:43:05.618Z,1709070185.618 [SpeedControl](DEBUG): Construct SpeedControl.
2024-02-27T21:43:05.620Z,1709070185.620 [SpeedControl] Loaded
2024-02-27T21:43:05.620Z,1709070185.620 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2024-02-27T21:43:05.623Z,1709070185.623 [LoopControl](DEBUG): Construct LoopControl.
2024-02-27T21:43:05.624Z,1709070185.624 [LoopControl] Loaded
2024-02-27T21:43:05.624Z,1709070185.624 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2024-02-27T21:43:05.624Z,1709070185.624 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2024-02-27T21:43:05.625Z,1709070185.625 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2024-02-27T21:43:05.746Z,1709070185.746 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2024-02-27T21:43:05.747Z,1709070185.747 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2024-02-27T21:43:06.184Z,1709070186.184 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2024-02-27T21:43:06.185Z,1709070186.185 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2024-02-27T21:43:06.740Z,1709070186.740 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2024-02-27T21:43:06.740Z,1709070186.740 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2024-02-27T21:43:06.802Z,1709070186.802 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2024-02-27T21:43:06.808Z,1709070186.808 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2024-02-27T21:43:06.811Z,1709070186.811 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2024-02-27T21:43:06.822Z,1709070186.822 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2024-02-27T21:43:06.823Z,1709070186.823 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C114E0
2024-02-27T21:43:06.823Z,1709070186.823 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 9261
2024-02-27T21:43:06.828Z,1709070186.828 [Supervisor](INFO): Main Thread ID is 9163
2024-02-27T21:43:06.828Z,1709070186.828 [Supervisor](DEBUG): Running supervisor.
2024-02-27T21:43:06.828Z,1709070186.828 [CommandExec ThreadHandler](INFO): Handler Thread ID is 9262
2024-02-27T21:43:06.829Z,1709070186.829 [CommandExec](INFO): Initializing the command executive.
2024-02-27T21:43:06.830Z,1709070186.830 [CommandLine ThreadHandler](INFO): Handler Thread ID is 9263
2024-02-27T21:43:06.834Z,1709070186.834 [controlThread ThreadHandler](INFO): Handler Thread ID is 9264
2024-02-27T21:43:06.834Z,1709070186.834 [controlThread](DEBUG): Initializing ControlThread
2024-02-27T21:43:06.835Z,1709070186.835 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2024-02-27T21:43:06.836Z,1709070186.836 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2024-02-27T21:43:06.836Z,1709070186.836 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2024-02-27T21:43:06.836Z,1709070186.836 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2024-02-27T21:43:06.837Z,1709070186.837 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2024-02-27T21:43:06.843Z,1709070186.843 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2024-02-27T21:43:06.843Z,1709070186.843 [NavChart](DEBUG): Initialize NavChart Navigation.
2024-02-27T21:43:06.844Z,1709070186.844 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2024-02-27T21:43:06.844Z,1709070186.844 [SBIT](INFO): Initialize SBIT Component.
2024-02-27T21:43:06.845Z,1709070186.845 [SBIT](IMPORTANT): git: 2024-02-15-11-g938a8443c
2024-02-27T21:43:06.845Z,1709070186.845 [SBIT](INFO): git hash: 938a8443c99493f6074473dd0552d31c6d48c406
2024-02-27T21:43:06.845Z,1709070186.845 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2024-02-27T21:43:06.846Z,1709070186.846 [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
2024-02-27T21:43:06.847Z,1709070186.847 [SBIT](INFO): Beginning SBIT in 21.000000 seconds.
2024-02-27T21:43:06.848Z,1709070186.848 [IBIT](INFO): Initialize IBIT Component.
2024-02-27T21:43:06.849Z,1709070186.849 [CBIT](DEBUG): Initialize CBIT Component.
2024-02-27T21:43:06.850Z,1709070186.850 [logger ThreadHandler](INFO): Handler Thread ID is 9265
2024-02-27T21:43:06.860Z,1709070186.860 [CBIT](DEBUG): Initialized mux pins.
2024-02-27T21:43:06.860Z,1709070186.860 [CBIT](DEBUG): Initializing the watchdog timer.
2024-02-27T21:43:06.869Z,1709070186.869 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 9266
2024-02-27T21:43:06.880Z,1709070186.880 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 9267
2024-02-27T21:43:06.882Z,1709070186.882 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2024-02-27T21:43:06.884Z,1709070186.884 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2024-02-27T21:43:06.885Z,1709070186.885 [CBIT](DEBUG): Initializing heartbeat.
2024-02-27T21:43:06.893Z,1709070186.893 [Onboard ThreadHandler](INFO): Handler Thread ID is 9268
2024-02-27T21:43:06.910Z,1709070186.910 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 9269
2024-02-27T21:43:06.933Z,1709070186.933 [DAT ThreadHandler](INFO): Handler Thread ID is 9270
2024-02-27T21:43:06.934Z,1709070186.934 [DAT](INFO): Powering up
2024-02-27T21:43:06.934Z,1709070186.934 [DAT](DEBUG): Initializing DAT.
2024-02-27T21:43:06.937Z,1709070186.937 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 9272
2024-02-27T21:43:06.938Z,1709070186.938 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2024-02-27T21:43:06.941Z,1709070186.941 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 9274
2024-02-27T21:43:06.945Z,1709070186.945 [WetLabsBB2FL](INFO): Powering up
2024-02-27T21:43:06.946Z,1709070186.946 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 9276
2024-02-27T21:43:06.949Z,1709070186.949 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2024-02-27T21:43:06.949Z,1709070186.949 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2024-02-27T21:43:06.949Z,1709070186.949 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2024-02-27T21:43:06.949Z,1709070186.949 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2024-02-27T21:43:06.949Z,1709070186.949 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2024-02-27T21:43:06.949Z,1709070186.949 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2024-02-27T21:43:06.950Z,1709070186.950 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2024-02-27T21:43:06.950Z,1709070186.950 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2024-02-27T21:43:06.956Z,1709070186.956 [CBIT](DEBUG): Deactivating GF circuits.
2024-02-27T21:43:06.956Z,1709070186.956 [CBIT](DEBUG): Deactivating emergency mode.
2024-02-27T21:43:06.996Z,1709070186.996 [CBIT](DEBUG): Backplane powered.
2024-02-27T21:43:07.001Z,1709070187.001 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2024-02-27T21:43:07.003Z,1709070187.003 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2024-02-27T21:43:07.004Z,1709070187.004 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2024-02-27T21:43:07.004Z,1709070187.004 [LoopControl](DEBUG): Initialize LoopControlComponent.
2024-02-27T21:43:07.005Z,1709070187.005 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser
2024-02-27T21:43:07.006Z,1709070187.006 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl
2024-02-27T21:43:07.006Z,1709070187.006 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl
2024-02-27T21:43:07.007Z,1709070187.007 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl
2024-02-27T21:43:07.068Z,1709070187.068 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into:
2024-02-27T21:43:07.089Z,1709070187.089 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2024-02-27T21:43:07.112Z,1709070187.112 [MissionManager](DEBUG):
mission Startup {
behavior Guidance:GoToSurface {
run in progression
}
aggregate StartupSatComms {
run in sequence
readDatum {
timeout duration=P1M
Universal:latitude_fix
}
readDatum {
timeout duration=P1M
Universal:platform_communications
}
}
}
2024-02-27T21:43:07.113Z,1709070187.113 [MissionManager](INFO): Loading Mission from file: Missions/Default.xml
2024-02-27T21:43:07.174Z,1709070187.174 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2024-02-27T21:43:07.175Z,1709070187.175 [Default:A.Wait](DEBUG): Construct Wait.
2024-02-27T21:43:07.178Z,1709070187.178 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2024-02-27T21:43:07.195Z,1709070187.195 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2024-02-27T21:43:07.229Z,1709070187.229 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2024-02-27T21:43:07.239Z,1709070187.239 [Default:E.Execute](DEBUG): Construct Execute.
2024-02-27T21:43:07.242Z,1709070187.242 [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
2024-02-27T21:43:07.249Z,1709070187.249 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,MultiRay,NAL9602,PowerOnly,Power24vConverter,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter,
2024-02-27T21:43:07.262Z,1709070187.262 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2024-02-27T21:43:07.314Z,1709070187.314 [Depth_Keller](ERROR): Pressure or depth reading out of range: 1629.131348 decibar, 0.000000 m
2024-02-27T21:43:07.315Z,1709070187.315 [MultiRay](INFO): Powering up MultiRay Lights
2024-02-27T21:43:07.316Z,1709070187.316 [Radio_Surface](INFO): Powering up
2024-02-27T21:43:07.349Z,1709070187.349 [PowerOnly](INFO): Powering up loadControl
2024-02-27T21:43:07.369Z,1709070187.369 [Power24vConverter](INFO): Powering up.
2024-02-27T21:43:07.396Z,1709070187.396 [DepthRateCalculator](ERROR): Depth measurement is not active
2024-02-27T21:43:07.407Z,1709070187.407 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2024-02-27T21:43:07.412Z,1709070187.412 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2024-02-27T21:43:07.413Z,1709070187.413 [ElevatorServo](DEBUG): Initializing EZServoServo.
2024-02-27T21:43:07.420Z,1709070187.420 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2024-02-27T21:43:07.421Z,1709070187.421 [MassServo](DEBUG): Initializing EZServoServo.
2024-02-27T21:43:07.428Z,1709070187.428 [MassServo](DEBUG): Initializing MassServo.
2024-02-27T21:43:07.429Z,1709070187.429 [RudderServo](DEBUG): Initializing EZServoServo.
2024-02-27T21:43:07.437Z,1709070187.437 [RudderServo](DEBUG): Initializing RudderServo.
2024-02-27T21:43:07.438Z,1709070187.438 [ThrusterHE](DEBUG): Initializing EZServoServo.
2024-02-27T21:43:07.445Z,1709070187.445 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2024-02-27T21:43:07.702Z,1709070187.702 [DropWeight](CRITICAL): DROP WEIGHT MISSING.
2024-02-27T21:43:07.702Z,1709070187.702 [DropWeight] Hardware Fault, FailCount= 1
2024-02-27T21:43:07.702Z,1709070187.702 [DropWeight](ERROR): Hardware Fault
2024-02-27T21:43:07.762Z,1709070187.762 [CommandExec](FAULT): Scheduling is paused
2024-02-27T21:43:07.762Z,1709070187.762 [CBIT](INFO): Critical error at 20240227T214307
2024-02-27T21:43:07.763Z,1709070187.763 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2024-02-27T21:43:07.769Z,1709070187.769 [CBIT](ERROR): Hardware Fault in component: DropWeight
2024-02-27T21:43:07.770Z,1709070187.770 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2024-02-27T21:43:08.091Z,1709070188.091 [CBIT](INFO): Critical error at 20240227T214307
2024-02-27T21:43:09.556Z,1709070189.556 [WetLabsBB2FL](INFO): Powering down
2024-02-27T21:43:13.165Z,1709070193.165 [ThrusterHE](ERROR): Zero Speed Commanded.
2024-02-27T21:43:13.969Z,1709070193.969 [CTD_Seabird](ERROR): Device message queue exceeded the allowed limit.
2024-02-27T21:43:17.579Z,1709070197.579 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004822
2024-02-27T21:43:19.533Z,1709070199.533 [DAT](INFO): DAT read:
2024-02-27T21:43:19.534Z,1709070199.534 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series
2024-02-27T21:43:21.297Z,1709070201.297 [DAT](INFO): DAT read: MF Frequency Band
2024-02-27T21:43:21.298Z,1709070201.298 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.15.0
2024-02-27T21:43:21.299Z,1709070201.299 [DAT](INFO): DAT read: Feb 27 2024 21:24:47
2024-02-27T21:43:22.305Z,1709070202.305 [DAT](INFO): DAT read: Features enabled [Bearing]
2024-02-27T21:43:22.306Z,1709070202.306 [DAT](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP
2024-02-27T21:43:22.307Z,1709070202.307 [DAT](INFO): commRate: 800
2024-02-27T21:43:24.372Z,1709070204.372 [DAT](INFO): entering command mode
2024-02-27T21:43:24.575Z,1709070204.575 [DAT](INFO): DAT read:
2024-02-27T21:43:24.577Z,1709070204.577 [DAT](INFO): DAT read: user:1>
2024-02-27T21:43:24.578Z,1709070204.578 [DAT](INFO): setting verbose to 3
2024-02-27T21:43:24.825Z,1709070204.825 [DAT](INFO): DAT read: user:1>
2024-02-27T21:43:24.826Z,1709070204.826 [DAT](INFO): DAT read: Verbose | 3
2024-02-27T21:43:24.826Z,1709070204.826 [DAT](INFO): set verbose to 3
2024-02-27T21:43:24.826Z,1709070204.826 [DAT](INFO): setting DatVerbose to 27440
2024-02-27T21:43:25.077Z,1709070205.077 [DAT](INFO): DAT read: user:2>
2024-02-27T21:43:25.078Z,1709070205.078 [DAT](INFO): DAT read: DatVerbose | 27440
2024-02-27T21:43:25.078Z,1709070205.078 [DAT](INFO): set DatVerbose to 27440
2024-02-27T21:43:25.078Z,1709070205.078 [DAT](INFO): setting transmit power to 8
2024-02-27T21:43:25.329Z,1709070205.329 [DAT](INFO): DAT read: user:3>
2024-02-27T21:43:25.329Z,1709070205.329 [DAT](INFO): DAT read: TxPower | 8 (Max)
2024-02-27T21:43:25.330Z,1709070205.330 [DAT](INFO): set transmit power to 8
2024-02-27T21:43:25.330Z,1709070205.330 [DAT](INFO): setting local address to 9
2024-02-27T21:43:25.581Z,1709070205.581 [DAT](INFO): DAT read: user:4>
2024-02-27T21:43:25.582Z,1709070205.582 [DAT](INFO): DAT read: LocalAddr | 9
2024-02-27T21:43:25.582Z,1709070205.582 [DAT](INFO): set local address to 9
2024-02-27T21:43:25.583Z,1709070205.583 [DAT](INFO): Setting time to: 21:43:25 And date to:2/27/2024
2024-02-27T21:43:25.833Z,1709070205.833 [DAT](INFO): DAT read: user:5>
2024-02-27T21:43:25.833Z,1709070205.833 [DAT](INFO): DAT read: Tue Feb 27, 2024 21:43:25
2024-02-27T21:43:25.834Z,1709070205.834 [DAT](INFO): Local DAT time set to Tue Feb 27, 2024 21:43:25
2024-02-27T21:43:28.340Z,1709070208.340 [SBIT](IMPORTANT): Beginning Startup BIT
2024-02-27T21:43:28.360Z,1709070208.360 [CBIT](IMPORTANT): Beginning ground fault scan
2024-02-27T21:43:33.759Z,1709070213.759 [CBIT](INFO): A/D timeout, 6 tries over 135 ms
2024-02-27T21:43:34.386Z,1709070214.386 [NAL9602](INFO): Powering up NAL9602
2024-02-27T21:43:39.303Z,1709070219.303 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.003385
CHAN A1 (24V): 0.000724
CHAN A2 (12V): -0.005073
CHAN A3 (5V): nan
CHAN B0 (3.3V): 0.010254
CHAN B1 (3.15aV): -0.001499
CHAN B2 (3.15bV): -0.001178
CHAN B3 (GND): -0.000394
OPEN: 0.004873
Full Scale: +/- 1 mA
2024-02-27T21:43:45.290Z,1709070225.290 [NAL9602](INFO): NAL9602 initialized
2024-02-27T21:44:13.174Z,1709070253.174 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T21:44:13.594Z,1709070253.594 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T21:44:22.096Z,1709070262.096 [SBIT](IMPORTANT): SBIT PASSED
2024-02-27T21:44:22.096Z,1709070262.096 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2024-02-27T21:44:22.097Z,1709070262.097 [SBIT](IMPORTANT): CBIT.runNavErrorCritical=1 bool;
2024-02-27T21:44:22.097Z,1709070262.097 [SBIT](IMPORTANT): DAT.loadAtStartup=1 bool;
2024-02-27T21:44:22.097Z,1709070262.097 [SBIT](IMPORTANT): DAT.missionCritical=1 bool;
2024-02-27T21:44:22.097Z,1709070262.097 [SBIT](IMPORTANT): MultiRay.loadAtStartup=1 bool;
2024-02-27T21:44:22.097Z,1709070262.097 [SBIT](IMPORTANT): PowerOnly.sampleTime1=0 second;
2024-02-27T21:44:22.098Z,1709070262.098 [SBIT](IMPORTANT): Vehicle.useTlLoader=1 bool;
2024-02-27T21:44:22.098Z,1709070262.098 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=276.938122 cubic_centimeter;
2024-02-27T21:44:22.098Z,1709070262.098 [SBIT](IMPORTANT): VerticalControl.massDefault=-0.304479 millimeter;
2024-02-27T21:44:22.482Z,1709070262.482 [MissionManager](IMPORTANT): Started mission Startup
2024-02-27T21:44:22.482Z,1709070262.482 [Startup] Running Loop=1
2024-02-27T21:44:22.482Z,1709070262.482 [Startup](DEBUG): Aggregate::initialize Startup
2024-02-27T21:44:22.482Z,1709070262.482 [Startup:A.GoToSurface] Running Loop=1
2024-02-27T21:44:22.482Z,1709070262.482 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2024-02-27T21:44:22.483Z,1709070262.483 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2024-02-27T21:44:22.483Z,1709070262.483 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2024-02-27T21:44:22.483Z,1709070262.483 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2024-02-27T21:44:22.488Z,1709070262.488 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2024-02-27T21:44:22.488Z,1709070262.488 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2024-02-27T21:44:22.490Z,1709070262.490 [Startup:StartupSatComms] Running Loop=1
2024-02-27T21:44:22.490Z,1709070262.490 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2024-02-27T21:44:22.490Z,1709070262.490 [Startup:StartupSatComms:A] Running Loop=1
2024-02-27T21:44:22.887Z,1709070262.887 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2024-02-27T21:44:24.140Z,1709070264.140 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T21:44:24.544Z,1709070264.544 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T21:44:35.047Z,1709070275.047 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T21:44:35.854Z,1709070275.854 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T21:44:45.951Z,1709070285.951 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T21:44:46.027Z,1709070286.027 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T21:44:56.916Z,1709070296.916 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T21:44:57.082Z,1709070297.082 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T21:45:07.771Z,1709070307.771 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T21:45:07.854Z,1709070307.854 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T21:45:18.681Z,1709070318.681 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T21:45:18.756Z,1709070318.756 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T21:45:22.687Z,1709070322.687 [Startup:StartupSatComms:A](INFO): Timed out from 2024-02-27T21:44:22.5Z
2024-02-27T21:45:22.687Z,1709070322.687 [Startup:StartupSatComms:A] Stopped
2024-02-27T21:45:22.687Z,1709070322.687 [Startup:StartupSatComms:B] Running Loop=1
2024-02-27T21:45:23.091Z,1709070323.091 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2024-02-27T21:45:29.587Z,1709070329.587 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T21:45:29.667Z,1709070329.667 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T21:45:29.937Z,1709070329.937 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240227T205113/Courier0007.lzma
2024-02-27T21:45:30.938Z,1709070330.938 [DataOverHttps](INFO): Moved sent file to Logs/20240227T205113/Courier0007.lzma.bak
2024-02-27T21:45:30.938Z,1709070330.938 [DataOverHttps](INFO): SBD MOMSN=19295558
2024-02-27T21:45:40.496Z,1709070340.496 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T21:45:40.899Z,1709070340.899 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T21:45:46.556Z,1709070346.556 [DataOverHttps](INFO): Sending 243 bytes from file Logs/20240227T214255/Courier0000.lzma
2024-02-27T21:45:47.547Z,1709070347.547 [DataOverHttps](INFO): Moved sent file to Logs/20240227T214255/Courier0000.lzma.bak
2024-02-27T21:45:47.547Z,1709070347.547 [DataOverHttps](INFO): SBD MOMSN=19295560
2024-02-27T21:45:51.857Z,1709070351.857 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T21:45:52.009Z,1709070352.009 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T21:46:02.345Z,1709070362.345 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T21:46:03.119Z,1709070363.119 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T21:46:03.364Z,1709070363.364 [DataOverHttps](INFO): Sending 230 bytes from file Logs/20240227T205113/Express0008.lzma
2024-02-27T21:46:04.366Z,1709070364.366 [DataOverHttps](INFO): Moved sent file to Logs/20240227T205113/Express0008.lzma.bak
2024-02-27T21:46:04.366Z,1709070364.366 [DataOverHttps](INFO): SBD MOMSN=19295565
2024-02-27T21:46:07.109Z,1709070367.109 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2024-02-27T21:46:07.109Z,1709070367.109 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-02-27T21:46:07.110Z,1709070367.110 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1
2024-02-27T21:46:07.110Z,1709070367.110 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2024-02-27T21:46:07.121Z,1709070367.121 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-02-27T21:46:07.121Z,1709070367.121 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2024-02-27T21:46:07.542Z,1709070367.542 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-02-27T21:46:07.542Z,1709070367.542 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2024-02-27T21:46:07.542Z,1709070367.542 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2024-02-27T21:46:07.542Z,1709070367.542 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1
2024-02-27T21:46:07.920Z,1709070367.920 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2024-02-27T21:46:13.219Z,1709070373.219 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T21:46:14.191Z,1709070374.191 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T21:46:19.962Z,1709070379.962 [DataOverHttps](INFO): Sending 828 bytes from file Logs/20240227T214255/Express0001.lzma
2024-02-27T21:46:20.962Z,1709070380.962 [DataOverHttps](INFO): Moved sent file to Logs/20240227T214255/Express0001.lzma.bak
2024-02-27T21:46:20.962Z,1709070380.962 [DataOverHttps](INFO): SBD MOMSN=19295573
2024-02-27T21:46:22.455Z,1709070382.455 [Startup:StartupSatComms:B] Stopped
2024-02-27T21:46:22.455Z,1709070382.455 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2024-02-27T21:46:22.455Z,1709070382.455 [Startup:StartupSatComms] Stopped
2024-02-27T21:46:22.455Z,1709070382.455 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2024-02-27T21:46:22.456Z,1709070382.456 [Startup](INFO): Completed Startup
2024-02-27T21:46:22.456Z,1709070382.456 [MissionManager](INFO): Startup is completed.
2024-02-27T21:46:22.456Z,1709070382.456 [MissionManager](INFO): Uninitializing Mission Startup
2024-02-27T21:46:22.456Z,1709070382.456 [Startup] Stopped
2024-02-27T21:46:22.457Z,1709070382.457 [Startup](DEBUG): Aggregate::uninitialize Startup
2024-02-27T21:46:22.457Z,1709070382.457 [Startup:A.GoToSurface] Stopped
2024-02-27T21:46:22.457Z,1709070382.457 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2024-02-27T21:46:22.862Z,1709070382.862 [MissionManager](IMPORTANT): Started mission Default
2024-02-27T21:46:22.862Z,1709070382.862 [Default] Running Loop=1
2024-02-27T21:46:22.862Z,1709070382.862 [Default](DEBUG): Aggregate::initialize Default
2024-02-27T21:46:22.862Z,1709070382.862 [Default:B.GoToSurface] Running Loop=1
2024-02-27T21:46:22.863Z,1709070382.863 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2024-02-27T21:46:22.863Z,1709070382.863 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2024-02-27T21:46:22.863Z,1709070382.863 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2024-02-27T21:46:22.863Z,1709070382.863 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2024-02-27T21:46:22.864Z,1709070382.864 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2024-02-27T21:46:22.865Z,1709070382.865 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2024-02-27T21:46:22.866Z,1709070382.866 [Default:A.Wait] Running Loop=1
2024-02-27T21:46:22.866Z,1709070382.866 [Default:A.Wait](DEBUG): Initialize Wait Component.
2024-02-27T21:46:24.189Z,1709070384.189 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T21:46:24.581Z,1709070384.581 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T21:46:35.037Z,1709070395.037 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T21:46:35.439Z,1709070395.439 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T21:46:36.230Z,1709070396.230 [Default:A.Wait](INFO): Done Waiting.
2024-02-27T21:46:36.231Z,1709070396.231 [Default:A.Wait] Stopped
2024-02-27T21:46:36.231Z,1709070396.231 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2024-02-27T21:46:36.627Z,1709070396.626 [Default:CheckIn] Running Loop=1
2024-02-27T21:46:36.627Z,1709070396.627 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-02-27T21:46:36.627Z,1709070396.627 [Default:CheckIn:Read_GPS] Running Loop=1
2024-02-27T21:46:37.033Z,1709070397.033 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2024-02-27T21:46:45.537Z,1709070405.537 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T21:46:46.354Z,1709070406.354 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T21:46:56.851Z,1709070416.851 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T21:46:57.257Z,1709070417.257 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T21:47:07.351Z,1709070427.351 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T21:47:08.165Z,1709070428.165 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T21:47:18.268Z,1709070438.268 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T21:47:19.077Z,1709070439.077 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T21:47:29.171Z,1709070449.171 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T21:47:30.383Z,1709070450.383 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T21:47:40.484Z,1709070460.484 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T21:47:41.693Z,1709070461.693 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T21:47:52.602Z,1709070472.602 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T21:48:03.108Z,1709070483.108 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T21:48:13.646Z,1709070493.646 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T21:48:24.923Z,1709070504.923 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T21:48:35.831Z,1709070515.831 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T21:48:46.790Z,1709070526.790 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T21:48:49.191Z,1709070529.191 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2024-02-27T21:48:53.371Z,1709070533.371 [CommandExec](IMPORTANT): got command load ./Missions/Engineering/lab_test_optim.tl
2024-02-27T21:48:53.372Z,1709070533.372 [MissionManager](INFO): Loading Mission from file: ./Missions/Engineering/lab_test_optim.tl
2024-02-27T21:48:53.372Z,1709070533.372 [MissionManager](DEBUG): TethyslAPI: loading: ./Missions/Engineering/lab_test_optim.tl
2024-02-27T21:48:53.375Z,1709070533.375 [MissionManager](DEBUG): TethyslAPI: mission file loaded: ./Missions/Engineering/lab_test_optim.tl
2024-02-27T21:48:53.873Z,1709070533.873 [MissionManager](DEBUG): TethyslAPI: ./Missions/Engineering/lab_test_optim.tl translated into:
15
1
30
1
3
2
100
100
0
Waiting
for backseat to start up...
Disabling Optim recording after
Powering up Optim to try to tide over gap to handoff...
! echo 1 > /dev/loadC3
Optim power on. Spinning for
cycles.
1
! echo 0 > /dev/loadC3
Optim power off. Spinning again.
1
! echo 1 > /dev/loadC3
Optim power on. Handing off to mission.
! echo 1 > /dev/loadC3; sleep 1; echo 0 > /dev/loadC3; sleep 1; echo 1 > dev/loadC3
Hardcoded Optim command sent. Good luck.
Trying to run Optim and Multiray forreal
1
Setting multiray red brightness to
2
Setting muliray white brightness to
Recording for
2024-02-27T21:48:53.880Z,1709070533.880 [MissionManager](INFO): DefineArg lab_test_optim.MissionTimeout = 15.000000 min
2024-02-27T21:48:53.883Z,1709070533.883 [MissionManager](INFO): DefineArg lab_test_optim.RecordTime = 1.000000 min
2024-02-27T21:48:53.886Z,1709070533.886 [MissionManager](INFO): DefineArg lab_test_optim.BackseatWait = 30.000000 s
2024-02-27T21:48:53.917Z,1709070533.917 [MissionManager](INFO): DefineArg lab_test_optim.UseMission = 1 bool
2024-02-27T21:48:53.924Z,1709070533.924 [MissionManager](INFO): DefineArg lab_test_optim.UseHardcode = 0 bool
2024-02-27T21:48:53.927Z,1709070533.927 [MissionManager](INFO): DefineArg lab_test_optim.InitialSampleTime = 1.000000 s
2024-02-27T21:48:53.930Z,1709070533.930 [MissionManager](INFO): DefineArg lab_test_optim.SleepCycles = 3.000000 count
2024-02-27T21:48:53.989Z,1709070533.989 [MissionManager](INFO): DefineArg lab_test_optim.LightMode = 2.000000 count
2024-02-27T21:48:53.992Z,1709070533.992 [MissionManager](INFO): DefineArg lab_test_optim.BrightnessWhite = 100.000000 n/a int32
2024-02-27T21:48:53.999Z,1709070533.999 [MissionManager](INFO): DefineArg lab_test_optim.BrightnessRed = 100.000000 n/a int32
2024-02-27T21:48:54.022Z,1709070534.022 [MissionManager](INFO): DefineOutput lab_test_optim.CyclesWaited = 0.000000 count
2024-02-27T21:48:54.036Z,1709070534.036 [MissionManager](INFO): DefineOutput lab_test_optim.RecordingEnabled = 0 bool
2024-02-27T21:48:54.047Z,1709070534.047 [MissionManager](INFO): DefineOutput lab_test_optim.LightsEnabled = 0 bool
2024-02-27T21:48:54.047Z,1709070534.047 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/BackseatDriver.tl
2024-02-27T21:48:54.047Z,1709070534.047 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/BackseatDriver.tl
2024-02-27T21:48:54.060Z,1709070534.060 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/BackseatDriver.tl
2024-02-27T21:48:54.115Z,1709070534.115 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/BackseatDriver.tl translated into:
2024-02-27T21:48:54.123Z,1709070534.123 [MissionManager](INFO): DefineArg lab_test_optim:BackseatDriver.EnableBackseat = 0 bool
2024-02-27T21:48:54.130Z,1709070534.130 [lab_test_optim:BackseatDriver:A.BackseatDriver](DEBUG): Construct BackseatDriver.
2024-02-27T21:48:54.168Z,1709070534.168 [lab_test_optim:Startup:B.Wait](DEBUG): Construct Wait.
2024-02-27T21:48:54.201Z,1709070534.201 [lab_test_optim:Startup:UseMission:E.Wait](DEBUG): Construct Wait.
2024-02-27T21:48:54.218Z,1709070534.218 [lab_test_optim:Startup:UseBackdoor:A.Execute](DEBUG): Construct Execute.
2024-02-27T21:48:54.225Z,1709070534.225 [lab_test_optim:Startup:UseBackdoor:D.Execute](DEBUG): Construct Execute.
2024-02-27T21:48:54.234Z,1709070534.234 [lab_test_optim:Startup:UseBackdoor:G.Execute](DEBUG): Construct Execute.
2024-02-27T21:48:54.242Z,1709070534.242 [lab_test_optim:Startup:UseHardcode:A.Execute](DEBUG): Construct Execute.
2024-02-27T21:48:54.297Z,1709070534.297 [lab_test_optim:Run:H.Wait](DEBUG): Construct Wait.
2024-02-27T21:48:54.299Z,1709070534.299 [lab_test_optim:G.Wait](DEBUG): Construct Wait.
2024-02-27T21:48:54.331Z,1709070534.331 [MissionManager](DEBUG):
mission lab_test_optim {
arguments {
MissionTimeout = 15 minute
"""
Backseat will stay on for this duration, independent of Optim state
"""
RecordTime = 1 minute
"""
How long to record after startup sequence (hopefully) turns on Optim camera
"""
BackseatWait = 30 second
"""
How long to wait for the backseat to power up before attempting to power the Optim
"""
UseMission = true
"""
If true, tries to go through the application and use components/behaviors for commands.
Set InitialSampleTime to change delays. If false, backdoors app. Use SleepCycles to change delays.
Optim must be on C3.
"""
UseHardcode = false
"""
If true, backdoors app with a powercycle and a hardcoded sleep 1. Try the two other modes first?
Optim must be on C3.
"""
InitialSampleTime = 1 second
"""
PowerOnly sample time for initial record. Will go back to continuous after startup.
"""
SleepCycles = 3 count
"""
How many vehicle computation cycles to wait before commanding the Optim off on initial record
"""
LightMode = 2 count
"""
Mode for Multiray lights. 0 is off, 1 is red, 2 is white
"""
BrightnessWhite = 100 none_int
"""
White Multiray LED brightness, 0-100
"""
BrightnessRed = 100 none_int
"""
Red Multiray LED brightness, 0-100
"""
}
output {
CyclesWaited = 0 count
RecordingEnabled = false
LightsEnabled = false
}
timeout duration=MissionTimeout
insert Insert/BackseatDriver.tl
assign in parallel BackseatDriver:EnableBackseat = true
readData strategy="MinError" {
while ( RecordingEnabled )
Sensor:PowerOnly.sampleLoad1
}
readData strategy="MinError" {
while ( LightsEnabled )
Sensor:MultiRay.lightModeLog
}
aggregate Startup {
run in sequence
syslog important "Waiting " + BackseatWait~s + " for backseat to start up..."
behavior Guidance:Wait {
run in sequence
set duration = BackseatWait
}
aggregate UseMission {
run in sequence
break if (
not UseMission
or UseHardcode
)
assign in parallel Sensor:PowerOnly.sampleTime1 = InitialSampleTime
assign in sequence RecordingEnabled = true
syslog important "Disabling Optim recording after " + InitialSampleTime~s
assign in sequence RecordingEnabled = false
behavior Guidance:Wait {
run in sequence
set duration = InitialSampleTime
}
assign in sequence RecordingEnabled = true
syslog important "Powering up Optim to try to tide over gap to handoff..."
}
aggregate UseBackdoor {
run in sequence
break if (
UseMission
or UseHardcode
)
behavior Guidance:Execute {
run in sequence
set command = "! echo 1 > /dev/loadC3"
}
syslog important "Optim power on. Spinning for " + SleepCycles~count + " cycles."
aggregate WaitForStop {
run in sequence repeat=SleepCycles
assign in sequence CyclesWaited = CyclesWaited + 1 count
}
behavior Guidance:Execute {
run in sequence
set command = "! echo 0 > /dev/loadC3"
}
syslog important "Optim power off. Spinning again."
aggregate WaitForStart {
run in sequence repeat=SleepCycles
assign in sequence CyclesWaited = CyclesWaited + 1 count
}
behavior Guidance:Execute {
run in sequence
set command = "! echo 1 > /dev/loadC3"
}
syslog important "Optim power on. Handing off to mission."
}
aggregate UseHardcode {
run in sequence
break if ( not UseHardcode )
behavior Guidance:Execute {
run in sequence
set command = "! echo 1 > /dev/loadC3; sleep 1; echo 0 > /dev/loadC3; sleep 1; echo 1 > dev/loadC3"
}
syslog important "Hardcoded Optim command sent. Good luck."
}
}
aggregate Run {
run in sequence
syslog important "Trying to run Optim and Multiray forreal"
assign in sequence RecordingEnabled = true
assign in sequence LightsEnabled = true
assign in sequence Sensor:MultiRay.lightModeCommand = LightMode
aggregate setRed {
run in sequence
break if ( LightMode != 1 count )
assign in sequence Sensor:MultiRay.brightnessRed = BrightnessRed
syslog info "Setting multiray red brightness to" + BrightnessRed~count
}
aggregate setWhite {
run in sequence
break if ( LightMode != 2 count )
assign in sequence Sensor:MultiRay.brightnessWhite = BrightnessWhite
syslog info "Setting muliray white brightness to" + BrightnessWhite~count
}
syslog important "Recording for " + RecordTime~min
behavior Guidance:Wait {
run in sequence
set duration = RecordTime
}
}
behavior Guidance:Wait {
run in sequence
set duration = MissionTimeout
}
}
2024-02-27T21:48:54.331Z,1709070534.331 [CommandExec](IMPORTANT): Loaded ./Missions/Engineering/lab_test_optim.tl id=lab_test_optim
2024-02-27T21:48:57.646Z,1709070537.646 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T21:49:01.937Z,1709070541.937 [CommandExec](IMPORTANT): got command run
2024-02-27T21:49:01.939Z,1709070541.939 [CommandExec](IMPORTANT): Running
2024-02-27T21:49:02.050Z,1709070542.050 [Default] Stopped
2024-02-27T21:49:02.050Z,1709070542.050 [Default](DEBUG): Aggregate::uninitialize Default
2024-02-27T21:49:02.051Z,1709070542.051 [Default:B.GoToSurface] Stopped
2024-02-27T21:49:02.051Z,1709070542.051 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2024-02-27T21:49:02.051Z,1709070542.051 [Default:CheckIn] Stopped
2024-02-27T21:49:02.051Z,1709070542.051 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-02-27T21:49:02.051Z,1709070542.051 [Default:CheckIn:Read_GPS] Stopped
2024-02-27T21:49:02.051Z,1709070542.051 [MissionManager](IMPORTANT): Started mission lab_test_optim
2024-02-27T21:49:02.051Z,1709070542.051 [lab_test_optim] Running Loop=1
2024-02-27T21:49:02.051Z,1709070542.051 [lab_test_optim](DEBUG): Aggregate::initialize lab_test_optim
2024-02-27T21:49:02.051Z,1709070542.051 [lab_test_optim:BackseatDriver] Running Loop=1
2024-02-27T21:49:02.052Z,1709070542.052 [lab_test_optim:BackseatDriver](DEBUG): Aggregate::initialize lab_test_optim:BackseatDriver
2024-02-27T21:49:02.052Z,1709070542.052 [lab_test_optim:BackseatDriver:A.BackseatDriver] Running Loop=1
2024-02-27T21:49:02.052Z,1709070542.052 [lab_test_optim:B] Running Loop=1
2024-02-27T21:49:02.052Z,1709070542.052 [lab_test_optim:C] Running Loop=1
2024-02-27T21:49:02.052Z,1709070542.052 [lab_test_optim:D] Running Loop=1
2024-02-27T21:49:02.052Z,1709070542.052 [lab_test_optim:Startup] Running Loop=1
2024-02-27T21:49:02.052Z,1709070542.052 [lab_test_optim:Startup](DEBUG): Aggregate::initialize lab_test_optim:Startup
2024-02-27T21:49:02.052Z,1709070542.052 [lab_test_optim:Startup:A] Running Loop=1
2024-02-27T21:49:02.053Z,1709070542.053 [lab_test_optim:Startup:A](IMPORTANT): Waiting 30.000000 s for backseat to start up...
2024-02-27T21:49:02.053Z,1709070542.053 [lab_test_optim:Startup:A] Stopped
2024-02-27T21:49:02.053Z,1709070542.053 [lab_test_optim:Startup:B.Wait] Running Loop=1
2024-02-27T21:49:02.053Z,1709070542.053 [lab_test_optim:Startup:B.Wait](DEBUG): Initialize Wait Component.
2024-02-27T21:49:02.053Z,1709070542.053 [lab_test_optim:D] Stopped
2024-02-27T21:49:02.053Z,1709070542.053 [lab_test_optim:C] Stopped
2024-02-27T21:49:02.054Z,1709070542.054 [lab_test_optim:B] Running Loop=1
2024-02-27T21:49:02.054Z,1709070542.054 [lab_test_optim:BackseatDriver] Running Loop=1
2024-02-27T21:49:02.054Z,1709070542.054 [lab_test_optim:BackseatDriver:A.BackseatDriver](INFO): Initializing backseat
2024-02-27T21:49:02.201Z,1709070542.201 [BackseatComponent](INFO): Powering up
2024-02-27T21:49:02.202Z,1709070542.202 [BackseatComponent](INFO): Subscribing to LCM channels.
2024-02-27T21:49:08.097Z,1709070548.097 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2024-02-27T21:49:08.097Z,1709070548.097 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-02-27T21:49:08.098Z,1709070548.098 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 2
2024-02-27T21:49:08.098Z,1709070548.098 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2024-02-27T21:49:08.129Z,1709070548.129 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-02-27T21:49:08.129Z,1709070548.129 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2024-02-27T21:49:08.508Z,1709070548.508 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-02-27T21:49:08.508Z,1709070548.508 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2024-02-27T21:49:08.509Z,1709070548.509 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2024-02-27T21:49:08.509Z,1709070548.509 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 2
2024-02-27T21:49:08.959Z,1709070548.959 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T21:49:08.969Z,1709070548.969 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2024-02-27T21:49:14.195Z,1709070554.195 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T21:49:20.276Z,1709070560.276 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T21:49:31.585Z,1709070571.585 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T21:49:32.739Z,1709070572.739 [lab_test_optim:Startup:B.Wait](INFO): Done Waiting.
2024-02-27T21:49:32.739Z,1709070572.739 [lab_test_optim:Startup:B.Wait] Stopped
2024-02-27T21:49:32.739Z,1709070572.739 [lab_test_optim:Startup:B.Wait](DEBUG): Uninitialize Wait Component.
2024-02-27T21:49:32.739Z,1709070572.739 [lab_test_optim:Startup:UseMission] Running Loop=1
2024-02-27T21:49:32.739Z,1709070572.739 [lab_test_optim:Startup:UseMission](DEBUG): Aggregate::initialize lab_test_optim:Startup:UseMission
2024-02-27T21:49:32.739Z,1709070572.739 [lab_test_optim:Startup:UseMission:A] Running Loop=1
2024-02-27T21:49:32.739Z,1709070572.739 [lab_test_optim:Startup:UseMission:B] Running Loop=1
2024-02-27T21:49:33.231Z,1709070573.231 [lab_test_optim:Startup:UseMission:B] Stopped
2024-02-27T21:49:33.231Z,1709070573.231 [lab_test_optim:Startup:UseMission:C] Running Loop=1
2024-02-27T21:49:33.231Z,1709070573.231 [lab_test_optim:Startup:UseMission:A] Running Loop=1
2024-02-27T21:49:33.575Z,1709070573.575 [lab_test_optim:Startup:UseMission:C](IMPORTANT): Disabling Optim recording after 1.000000 s
2024-02-27T21:49:33.575Z,1709070573.575 [lab_test_optim:Startup:UseMission:C] Stopped
2024-02-27T21:49:33.575Z,1709070573.575 [lab_test_optim:Startup:UseMission:D] Running Loop=1
2024-02-27T21:49:33.575Z,1709070573.575 [lab_test_optim:C] Running Loop=1
2024-02-27T21:49:33.575Z,1709070573.575 [lab_test_optim:C] Running Loop=1
2024-02-27T21:49:33.592Z,1709070573.592 [lab_test_optim:C](DEBUG): Initialize ReadDataComponent to sense PowerOnly.sampleLoad1
2024-02-27T21:49:33.960Z,1709070573.960 [PowerOnly](INFO): Powering down loadControl
2024-02-27T21:49:33.976Z,1709070573.976 [lab_test_optim:Startup:UseMission:D] Stopped
2024-02-27T21:49:33.976Z,1709070573.976 [lab_test_optim:Startup:UseMission:E.Wait] Running Loop=1
2024-02-27T21:49:33.977Z,1709070573.977 [lab_test_optim:Startup:UseMission:E.Wait](DEBUG): Initialize Wait Component.
2024-02-27T21:49:34.370Z,1709070574.370 [lab_test_optim:C] Stopped
2024-02-27T21:49:35.576Z,1709070575.576 [lab_test_optim:Startup:UseMission:E.Wait](INFO): Done Waiting.
2024-02-27T21:49:35.576Z,1709070575.576 [lab_test_optim:Startup:UseMission:E.Wait] Stopped
2024-02-27T21:49:35.576Z,1709070575.576 [lab_test_optim:Startup:UseMission:E.Wait](DEBUG): Uninitialize Wait Component.
2024-02-27T21:49:35.577Z,1709070575.577 [lab_test_optim:Startup:UseMission:F] Running Loop=1
2024-02-27T21:49:35.981Z,1709070575.981 [lab_test_optim:Startup:UseMission:F] Stopped
2024-02-27T21:49:35.981Z,1709070575.981 [lab_test_optim:Startup:UseMission:G] Running Loop=1
2024-02-27T21:49:36.403Z,1709070576.403 [lab_test_optim:Startup:UseMission:G](IMPORTANT): Powering up Optim to try to tide over gap to handoff...
2024-02-27T21:49:36.403Z,1709070576.403 [lab_test_optim:Startup:UseMission:G] Stopped
2024-02-27T21:49:36.404Z,1709070576.404 [lab_test_optim:Startup:UseMission](INFO): Completed lab_test_optim:Startup:UseMission
2024-02-27T21:49:36.404Z,1709070576.404 [lab_test_optim:Startup:UseMission] Stopped
2024-02-27T21:49:36.404Z,1709070576.404 [lab_test_optim:Startup:UseMission](DEBUG): Aggregate::uninitialize lab_test_optim:Startup:UseMission
2024-02-27T21:49:36.404Z,1709070576.404 [lab_test_optim:Startup:UseMission:A] Stopped
2024-02-27T21:49:36.404Z,1709070576.404 [lab_test_optim:Startup:UseBackdoor] Running Loop=1
2024-02-27T21:49:36.404Z,1709070576.404 [lab_test_optim:Startup:UseBackdoor](DEBUG): Aggregate::initialize lab_test_optim:Startup:UseBackdoor
2024-02-27T21:49:36.404Z,1709070576.404 [lab_test_optim:Startup:UseBackdoor:A.Execute] Running Loop=1
2024-02-27T21:49:36.405Z,1709070576.405 [lab_test_optim:C] Running Loop=1
2024-02-27T21:49:36.784Z,1709070576.784 [PowerOnly](INFO): Powering up loadControl
2024-02-27T21:49:36.834Z,1709070576.834 [lab_test_optim:Startup:UseBackdoor] Stopped
2024-02-27T21:49:36.834Z,1709070576.834 [lab_test_optim:Startup:UseBackdoor](DEBUG): Aggregate::uninitialize lab_test_optim:Startup:UseBackdoor
2024-02-27T21:49:36.834Z,1709070576.834 [lab_test_optim:Startup:UseBackdoor:A.Execute] Stopped
2024-02-27T21:49:36.835Z,1709070576.835 [lab_test_optim:Startup:UseHardcode] Running Loop=1
2024-02-27T21:49:36.835Z,1709070576.835 [lab_test_optim:Startup:UseHardcode](DEBUG): Aggregate::initialize lab_test_optim:Startup:UseHardcode
2024-02-27T21:49:36.835Z,1709070576.835 [lab_test_optim:Startup:UseHardcode:A.Execute] Running Loop=1
2024-02-27T21:49:37.211Z,1709070577.211 [lab_test_optim:Startup:UseHardcode] Stopped
2024-02-27T21:49:37.211Z,1709070577.211 [lab_test_optim:Startup:UseHardcode](DEBUG): Aggregate::uninitialize lab_test_optim:Startup:UseHardcode
2024-02-27T21:49:37.211Z,1709070577.211 [lab_test_optim:Startup:UseHardcode:A.Execute] Stopped
2024-02-27T21:49:37.212Z,1709070577.212 [lab_test_optim:Startup](INFO): Completed lab_test_optim:Startup
2024-02-27T21:49:37.212Z,1709070577.212 [lab_test_optim:Startup] Stopped
2024-02-27T21:49:37.212Z,1709070577.212 [lab_test_optim:Startup](DEBUG): Aggregate::uninitialize lab_test_optim:Startup
2024-02-27T21:49:37.212Z,1709070577.212 [lab_test_optim:Run] Running Loop=1
2024-02-27T21:49:37.212Z,1709070577.212 [lab_test_optim:Run](DEBUG): Aggregate::initialize lab_test_optim:Run
2024-02-27T21:49:37.212Z,1709070577.212 [lab_test_optim:Run:A] Running Loop=1
2024-02-27T21:49:37.604Z,1709070577.604 [lab_test_optim:Run:A](IMPORTANT): Trying to run Optim and Multiray forreal
2024-02-27T21:49:37.604Z,1709070577.604 [lab_test_optim:Run:A] Stopped
2024-02-27T21:49:37.604Z,1709070577.604 [lab_test_optim:Run:B] Running Loop=1
2024-02-27T21:49:38.066Z,1709070578.066 [lab_test_optim:Run:B] Stopped
2024-02-27T21:49:38.066Z,1709070578.066 [lab_test_optim:Run:C] Running Loop=1
2024-02-27T21:49:38.406Z,1709070578.406 [lab_test_optim:Run:C] Stopped
2024-02-27T21:49:38.406Z,1709070578.406 [lab_test_optim:Run:D] Running Loop=1
2024-02-27T21:49:38.828Z,1709070578.828 [lab_test_optim:Run:D] Stopped
2024-02-27T21:49:38.828Z,1709070578.828 [lab_test_optim:Run:setRed] Running Loop=1
2024-02-27T21:49:38.828Z,1709070578.828 [lab_test_optim:Run:setRed](DEBUG): Aggregate::initialize lab_test_optim:Run:setRed
2024-02-27T21:49:38.828Z,1709070578.828 [lab_test_optim:Run:setRed:A] Running Loop=1
2024-02-27T21:49:38.828Z,1709070578.828 [lab_test_optim:D] Running Loop=1
2024-02-27T21:49:38.829Z,1709070578.829 [lab_test_optim:D] Running Loop=1
2024-02-27T21:49:38.829Z,1709070578.829 [lab_test_optim:D](DEBUG): Initialize ReadDataComponent to sense MultiRay.lightModeLog
2024-02-27T21:49:39.247Z,1709070579.247 [lab_test_optim:Run:setRed] Stopped
2024-02-27T21:49:39.247Z,1709070579.247 [lab_test_optim:Run:setRed](DEBUG): Aggregate::uninitialize lab_test_optim:Run:setRed
2024-02-27T21:49:39.247Z,1709070579.247 [lab_test_optim:Run:setRed:A] Stopped
2024-02-27T21:49:39.247Z,1709070579.247 [lab_test_optim:Run:setWhite] Running Loop=1
2024-02-27T21:49:39.248Z,1709070579.248 [lab_test_optim:Run:setWhite](DEBUG): Aggregate::initialize lab_test_optim:Run:setWhite
2024-02-27T21:49:39.248Z,1709070579.248 [lab_test_optim:Run:setWhite:A] Running Loop=1
2024-02-27T21:49:39.652Z,1709070579.652 [lab_test_optim:Run:setWhite:A] Stopped
2024-02-27T21:49:39.652Z,1709070579.652 [lab_test_optim:Run:setWhite:B] Running Loop=1
2024-02-27T21:49:40.075Z,1709070580.075 [lab_test_optim:Run:setWhite:B](INFO): Setting muliray white brightness to 100.000000 count
2024-02-27T21:49:40.076Z,1709070580.076 [lab_test_optim:Run:setWhite:B] Stopped
2024-02-27T21:49:40.076Z,1709070580.076 [lab_test_optim:Run:setWhite](INFO): Completed lab_test_optim:Run:setWhite
2024-02-27T21:49:40.076Z,1709070580.076 [lab_test_optim:Run:setWhite] Stopped
2024-02-27T21:49:40.076Z,1709070580.076 [lab_test_optim:Run:setWhite](DEBUG): Aggregate::uninitialize lab_test_optim:Run:setWhite
2024-02-27T21:49:40.076Z,1709070580.076 [lab_test_optim:Run:G] Running Loop=1
2024-02-27T21:49:40.422Z,1709070580.422 [lab_test_optim:Run:G](IMPORTANT): Recording for 1.000000 min
2024-02-27T21:49:40.422Z,1709070580.422 [lab_test_optim:Run:G] Stopped
2024-02-27T21:49:40.423Z,1709070580.423 [lab_test_optim:Run:H.Wait] Running Loop=1
2024-02-27T21:49:40.423Z,1709070580.423 [lab_test_optim:Run:H.Wait](DEBUG): Initialize Wait Component.
2024-02-27T21:49:41.217Z,1709070581.217 [MultiRay](IMPORTANT): MultiRay white lights ON
2024-02-27T21:50:00.868Z,1709070600.868 [BackseatComponent](IMPORTANT): ikshana: running backseat application.
2024-02-27T21:50:01.866Z,1709070601.866 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T21:50:03.576Z,1709070603.576 [BackseatComponent](INFO): Created universal data reader for depth with code: 6
2024-02-27T21:50:03.576Z,1709070603.576 [BackseatComponent](INFO): Requesting data from depth (6). Requested size is: 1
2024-02-27T21:50:12.791Z,1709070612.791 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T21:50:23.301Z,1709070623.301 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T21:50:34.657Z,1709070634.657 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T21:50:40.648Z,1709070640.648 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T21:50:41.058Z,1709070641.058 [lab_test_optim:Run:H.Wait](INFO): Done Waiting.
2024-02-27T21:50:41.058Z,1709070641.058 [lab_test_optim:Run:H.Wait] Stopped
2024-02-27T21:50:41.058Z,1709070641.058 [lab_test_optim:Run:H.Wait](DEBUG): Uninitialize Wait Component.
2024-02-27T21:50:41.058Z,1709070641.058 [lab_test_optim:Run](INFO): Completed lab_test_optim:Run
2024-02-27T21:50:41.058Z,1709070641.058 [lab_test_optim:Run] Stopped
2024-02-27T21:50:41.059Z,1709070641.059 [lab_test_optim:Run](DEBUG): Aggregate::uninitialize lab_test_optim:Run
2024-02-27T21:50:41.059Z,1709070641.059 [lab_test_optim:G.Wait] Running Loop=1
2024-02-27T21:50:41.059Z,1709070641.059 [lab_test_optim:G.Wait](DEBUG): Initialize Wait Component.
2024-02-27T21:50:45.514Z,1709070645.514 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T21:50:56.828Z,1709070656.828 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T21:51:07.734Z,1709070667.734 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T21:51:11.297Z,1709070671.297 [CommandExec](IMPORTANT): got command stop
2024-02-27T21:51:11.297Z,1709070671.297 [CommandExec](IMPORTANT): Scheduling is paused
2024-02-27T21:51:11.297Z,1709070671.297 [Supervisor](INFO): Stop Mission called by CommandExec::commandStop
2024-02-27T21:51:11.340Z,1709070671.340 [MissionManager](INFO): MissionManager is completed.
2024-02-27T21:51:11.340Z,1709070671.340 [MissionManager](INFO): Uninitializing Mission lab_test_optim
2024-02-27T21:51:11.340Z,1709070671.340 [lab_test_optim] Stopped
2024-02-27T21:51:11.341Z,1709070671.341 [lab_test_optim](DEBUG): Aggregate::uninitialize lab_test_optim
2024-02-27T21:51:11.341Z,1709070671.341 [lab_test_optim:BackseatDriver] Stopped
2024-02-27T21:51:11.341Z,1709070671.341 [lab_test_optim:BackseatDriver](DEBUG): Aggregate::uninitialize lab_test_optim:BackseatDriver
2024-02-27T21:51:11.341Z,1709070671.341 [lab_test_optim:BackseatDriver:A.BackseatDriver] Stopped
2024-02-27T21:51:11.341Z,1709070671.341 [lab_test_optim:B] Stopped
2024-02-27T21:51:11.341Z,1709070671.341 [lab_test_optim:C] Stopped
2024-02-27T21:51:11.341Z,1709070671.341 [lab_test_optim:D] Stopped
2024-02-27T21:51:11.341Z,1709070671.341 [lab_test_optim:G.Wait] Stopped
2024-02-27T21:51:11.341Z,1709070671.341 [lab_test_optim:G.Wait](DEBUG): Uninitialize Wait Component.
2024-02-27T21:51:11.492Z,1709070671.492 [BackseatComponent](INFO): Sent LCM shutdown request.
2024-02-27T21:51:11.492Z,1709070671.492 [BackseatComponent](INFO): Shutdown requested. Waiting (18.00 sec to power down.).
2024-02-27T21:51:11.747Z,1709070671.747 [MissionManager](IMPORTANT): Started mission Default
2024-02-27T21:51:11.747Z,1709070671.747 [Default] Running Loop=1
2024-02-27T21:51:11.747Z,1709070671.747 [Default](DEBUG): Aggregate::initialize Default
2024-02-27T21:51:11.747Z,1709070671.747 [Default:B.GoToSurface] Running Loop=1
2024-02-27T21:51:11.747Z,1709070671.747 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2024-02-27T21:51:11.747Z,1709070671.747 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2024-02-27T21:51:11.748Z,1709070671.748 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2024-02-27T21:51:11.748Z,1709070671.748 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2024-02-27T21:51:11.749Z,1709070671.749 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2024-02-27T21:51:11.749Z,1709070671.749 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2024-02-27T21:51:11.749Z,1709070671.749 [Default:A.Wait] Running Loop=1
2024-02-27T21:51:11.749Z,1709070671.749 [Default:A.Wait](DEBUG): Initialize Wait Component.
2024-02-27T21:51:18.728Z,1709070678.728 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T21:51:25.074Z,1709070685.074 [Default:A.Wait](INFO): Done Waiting.
2024-02-27T21:51:25.075Z,1709070685.075 [Default:A.Wait] Stopped
2024-02-27T21:51:25.075Z,1709070685.075 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2024-02-27T21:51:25.459Z,1709070685.459 [Default:CheckIn] Running Loop=1
2024-02-27T21:51:25.459Z,1709070685.459 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-02-27T21:51:25.459Z,1709070685.459 [Default:CheckIn:Read_GPS] Running Loop=1
2024-02-27T21:51:29.665Z,1709070689.665 [BackseatComponent](INFO): Powering down and starting shutdown timer (18.00 sec).
2024-02-27T21:51:29.666Z,1709070689.666 [BackseatComponent](INFO): Unsubscribing from LCM channels.
2024-02-27T21:51:29.666Z,1709070689.666 [LcmUniversalReporter](INFO): Deactivating messaging.
2024-02-27T21:51:30.006Z,1709070690.006 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T21:51:37.660Z,1709070697.660 [CommandLine](INFO): End of History
2024-02-27T21:51:37.717Z,1709070697.717 [CommandLine](INFO): End of History
2024-02-27T21:51:37.774Z,1709070697.774 [CommandLine](INFO): End of History
2024-02-27T21:51:37.835Z,1709070697.835 [CommandLine](INFO): End of History
2024-02-27T21:51:37.890Z,1709070697.890 [CommandLine](INFO): End of History
2024-02-27T21:51:37.948Z,1709070697.948 [CommandLine](INFO): End of History
2024-02-27T21:51:38.068Z,1709070698.068 [CommandLine](INFO): End of History
2024-02-27T21:51:38.129Z,1709070698.129 [CommandLine](INFO): End of History
2024-02-27T21:51:38.189Z,1709070698.189 [CommandLine](INFO): End of History
2024-02-27T21:51:38.245Z,1709070698.245 [CommandLine](INFO): End of History
2024-02-27T21:51:38.300Z,1709070698.300 [CommandLine](INFO): End of History
2024-02-27T21:51:38.357Z,1709070698.357 [CommandLine](INFO): End of History
2024-02-27T21:51:38.467Z,1709070698.467 [CommandLine](INFO): End of History
2024-02-27T21:51:38.522Z,1709070698.522 [CommandLine](INFO): End of History
2024-02-27T21:51:38.564Z,1709070698.564 [CommandLine](INFO): End of History
2024-02-27T21:51:38.633Z,1709070698.633 [CommandLine](INFO): End of History
2024-02-27T21:51:38.674Z,1709070698.674 [CommandLine](INFO): End of History
2024-02-27T21:51:38.732Z,1709070698.732 [CommandLine](INFO): End of History
2024-02-27T21:51:38.891Z,1709070698.891 [CommandLine](INFO): End of History
2024-02-27T21:51:38.995Z,1709070698.995 [CommandLine](INFO): End of History
2024-02-27T21:51:39.094Z,1709070699.094 [CommandLine](INFO): End of History
2024-02-27T21:51:39.217Z,1709070699.217 [CommandLine](INFO): End of History
2024-02-27T21:51:39.351Z,1709070699.351 [CommandLine](INFO): End of History
2024-02-27T21:51:39.448Z,1709070699.448 [CommandLine](INFO): End of History
2024-02-27T21:51:39.521Z,1709070699.521 [CommandLine](INFO): End of History
2024-02-27T21:51:39.653Z,1709070699.653 [CommandLine](INFO): End of History
2024-02-27T21:51:39.782Z,1709070699.782 [CommandLine](INFO): End of History
2024-02-27T21:51:39.857Z,1709070699.857 [CommandLine](INFO): End of History
2024-02-27T21:51:39.941Z,1709070699.941 [CommandLine](INFO): End of History
2024-02-27T21:51:40.112Z,1709070700.112 [CommandLine](INFO): End of History
2024-02-27T21:51:40.204Z,1709070700.204 [CommandLine](INFO): End of History
2024-02-27T21:51:40.284Z,1709070700.284 [CommandLine](INFO): End of History
2024-02-27T21:51:40.897Z,1709070700.897 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T21:51:51.907Z,1709070711.907 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T21:52:01.066Z,1709070721.066 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T21:52:02.739Z,1709070722.739 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T21:52:09.168Z,1709070729.168 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2024-02-27T21:52:09.168Z,1709070729.168 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-02-27T21:52:09.169Z,1709070729.169 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 3
2024-02-27T21:52:09.169Z,1709070729.169 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2024-02-27T21:52:09.180Z,1709070729.180 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-02-27T21:52:09.180Z,1709070729.180 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2024-02-27T21:52:09.592Z,1709070729.592 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-02-27T21:52:09.592Z,1709070729.592 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2024-02-27T21:52:09.592Z,1709070729.592 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2024-02-27T21:52:09.593Z,1709070729.593 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 3
2024-02-27T21:52:09.973Z,1709070729.973 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2024-02-27T21:52:12.031Z,1709070732.031 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T21:52:13.647Z,1709070733.647 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T21:52:22.938Z,1709070742.938 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T21:52:24.558Z,1709070744.558 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T21:52:33.443Z,1709070753.443 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T21:52:35.868Z,1709070755.868 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T21:52:44.756Z,1709070764.756 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T21:52:46.781Z,1709070766.781 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T21:52:55.699Z,1709070775.699 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T21:52:57.683Z,1709070777.683 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T21:53:06.571Z,1709070786.571 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T21:53:08.592Z,1709070788.592 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T21:53:17.509Z,1709070797.509 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T21:53:19.503Z,1709070799.503 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T21:53:27.982Z,1709070807.982 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T21:53:30.855Z,1709070810.855 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T21:53:38.891Z,1709070818.891 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T21:53:41.720Z,1709070821.720 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T21:53:47.314Z,1709070827.314 [NAL9602](FAULT): GPS failed to acquire within timeout.
2024-02-27T21:53:47.314Z,1709070827.314 [NAL9602] Data Fault, FailCount= 1
2024-02-27T21:53:47.314Z,1709070827.314 [NAL9602](ERROR): Data Fault
2024-02-27T21:53:47.352Z,1709070827.352 [CBIT](ERROR): Data Fault in component: NAL9602
2024-02-27T21:53:47.714Z,1709070827.714 [NAL9602](INFO): Powering down
2024-02-27T21:53:48.544Z,1709070828.544 [CBIT](INFO): Clearing failed state for component NAL9602
2024-02-27T21:53:48.544Z,1709070828.544 [NAL9602] No Fault, FailCount= 1
2024-02-27T21:53:49.398Z,1709070829.398 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T21:53:52.634Z,1709070832.634 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T21:54:00.302Z,1709070840.302 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T21:54:03.138Z,1709070843.138 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T21:54:11.212Z,1709070851.212 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T21:54:14.041Z,1709070854.041 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T21:54:18.019Z,1709070858.019 [NAL9602](INFO): Powering up NAL9602
2024-02-27T21:54:21.719Z,1709070861.719 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T21:54:24.946Z,1709070864.946 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T21:54:28.927Z,1709070868.927 [NAL9602](INFO): NAL9602 initialized
2024-02-27T21:54:32.623Z,1709070872.623 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T21:54:35.855Z,1709070875.855 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T21:54:43.532Z,1709070883.532 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T21:54:46.764Z,1709070886.764 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T21:54:54.438Z,1709070894.438 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T21:54:57.671Z,1709070897.671 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T21:55:05.344Z,1709070905.344 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T21:55:08.578Z,1709070908.578 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T21:55:10.142Z,1709070910.142 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2024-02-27T21:55:10.142Z,1709070910.142 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-02-27T21:55:10.143Z,1709070910.143 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 4
2024-02-27T21:55:10.143Z,1709070910.143 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2024-02-27T21:55:10.182Z,1709070910.182 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-02-27T21:55:10.182Z,1709070910.182 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2024-02-27T21:55:10.555Z,1709070910.555 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-02-27T21:55:10.555Z,1709070910.555 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2024-02-27T21:55:10.556Z,1709070910.556 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2024-02-27T21:55:10.556Z,1709070910.556 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 4
2024-02-27T21:55:10.973Z,1709070910.973 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2024-02-27T21:55:16.307Z,1709070916.307 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T21:55:19.494Z,1709070919.494 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T21:55:27.165Z,1709070927.165 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T21:55:30.798Z,1709070930.798 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T21:55:38.071Z,1709070938.071 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T21:55:42.111Z,1709070942.111 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T21:55:48.985Z,1709070948.985 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T21:55:53.073Z,1709070953.073 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T21:55:59.888Z,1709070959.888 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T21:56:03.928Z,1709070963.928 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T21:56:10.794Z,1709070970.794 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T21:56:14.431Z,1709070974.431 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T21:56:20.895Z,1709070980.895 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T21:56:25.341Z,1709070985.341 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T21:56:25.717Z,1709070985.717 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-02-27T21:51:25.5Z
2024-02-27T21:56:25.717Z,1709070985.717 [Default:CheckIn:Read_GPS] Stopped
2024-02-27T21:56:25.717Z,1709070985.717 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-02-27T21:56:26.114Z,1709070986.114 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2024-02-27T21:56:30.988Z,1709070990.988 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240227T214255/Courier0004.lzma
2024-02-27T21:56:31.801Z,1709070991.801 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T21:56:31.990Z,1709070991.990 [DataOverHttps](INFO): Moved sent file to Logs/20240227T214255/Courier0004.lzma.bak
2024-02-27T21:56:31.990Z,1709070991.990 [DataOverHttps](INFO): SBD MOMSN=19295594
2024-02-27T21:56:36.278Z,1709070996.278 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T21:56:42.715Z,1709071002.715 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T21:56:47.154Z,1709071007.154 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T21:56:47.858Z,1709071007.858 [DataOverHttps](INFO): Sending 636 bytes from file Logs/20240227T214255/Express0005.lzma
2024-02-27T21:56:48.858Z,1709071008.858 [DataOverHttps](INFO): Moved sent file to Logs/20240227T214255/Express0005.lzma.bak
2024-02-27T21:56:48.858Z,1709071008.858 [DataOverHttps](INFO): SBD MOMSN=19295596
2024-02-27T21:56:50.343Z,1709071010.343 [Default:CheckIn:Read_Iridium] Stopped
2024-02-27T21:56:50.343Z,1709071010.343 [Default:CheckIn:C.Wait] Running Loop=1
2024-02-27T21:56:50.343Z,1709071010.343 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-02-27T21:56:53.667Z,1709071013.667 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T21:56:55.572Z,1709071015.572 [BPC1](ERROR): Failed to receive data from all battery packs.
2024-02-27T21:56:55.572Z,1709071015.572 [BPC1] Communications Fault, FailCount= 1
2024-02-27T21:56:55.572Z,1709071015.572 [BPC1](ERROR): Communications Fault
2024-02-27T21:56:55.648Z,1709071015.648 [CBIT](ERROR): Communications Fault in component: BPC1
2024-02-27T21:57:09.414Z,1709071029.414 [CommandExec](IMPORTANT): got command run ./Missions/Engineering/lab_test_optim.tl
2024-02-27T21:57:09.415Z,1709071029.415 [MissionManager](INFO): Loading Mission from file: ./Missions/Engineering/lab_test_optim.tl
2024-02-27T21:57:09.415Z,1709071029.415 [MissionManager](DEBUG): TethyslAPI: loading: ./Missions/Engineering/lab_test_optim.tl
2024-02-27T21:57:09.416Z,1709071029.416 [MissionManager](DEBUG): TethyslAPI: mission file loaded: ./Missions/Engineering/lab_test_optim.tl
2024-02-27T21:57:09.917Z,1709071029.917 [MissionManager](DEBUG): TethyslAPI: ./Missions/Engineering/lab_test_optim.tl translated into:
15
1
30
1
3
2
100
100
0
Waiting
for backseat to start up...
Disabling Optim recording after
Powering up Optim to try to tide over gap to handoff...
! echo 1 > /dev/loadC3
Optim power on. Spinning for
cycles.
1
! echo 0 > /dev/loadC3
Optim power off. Spinning again.
1
! echo 1 > /dev/loadC3
Optim power on. Handing off to mission.
! echo 1 > /dev/loadC3; sleep 1; echo 0 > /dev/loadC3; sleep 1; echo 1 > dev/loadC3
Hardcoded Optim command sent. Good luck.
Trying to run Optim and Multiray forreal
1
Setting multiray red brightness to
2
Setting muliray white brightness to
Recording for
2024-02-27T21:57:09.924Z,1709071029.924 [MissionManager](INFO): DefineArg lab_test_optim.MissionTimeout = 15.000000 min
2024-02-27T21:57:09.926Z,1709071029.926 [MissionManager](INFO): DefineArg lab_test_optim.RecordTime = 1.000000 min
2024-02-27T21:57:09.929Z,1709071029.929 [MissionManager](INFO): DefineArg lab_test_optim.BackseatWait = 30.000000 s
2024-02-27T21:57:09.931Z,1709071029.931 [MissionManager](INFO): DefineArg lab_test_optim.UseMission = 1 bool
2024-02-27T21:57:09.933Z,1709071029.933 [MissionManager](INFO): DefineArg lab_test_optim.UseHardcode = 0 bool
2024-02-27T21:57:09.935Z,1709071029.935 [MissionManager](INFO): DefineArg lab_test_optim.InitialSampleTime = 1.000000 s
2024-02-27T21:57:09.937Z,1709071029.937 [MissionManager](INFO): DefineArg lab_test_optim.SleepCycles = 3.000000 count
2024-02-27T21:57:09.939Z,1709071029.939 [MissionManager](INFO): DefineArg lab_test_optim.LightMode = 2.000000 count
2024-02-27T21:57:09.977Z,1709071029.977 [MissionManager](INFO): DefineArg lab_test_optim.BrightnessWhite = 100.000000 n/a int32
2024-02-27T21:57:09.979Z,1709071029.979 [MissionManager](INFO): DefineArg lab_test_optim.BrightnessRed = 100.000000 n/a int32
2024-02-27T21:57:09.998Z,1709071029.998 [MissionManager](INFO): DefineOutput lab_test_optim.CyclesWaited = 0.000000 count
2024-02-27T21:57:10.005Z,1709071030.005 [MissionManager](INFO): DefineOutput lab_test_optim.RecordingEnabled = 0 bool
2024-02-27T21:57:10.006Z,1709071030.006 [MissionManager](INFO): DefineOutput lab_test_optim.LightsEnabled = 0 bool
2024-02-27T21:57:10.007Z,1709071030.007 [MissionManager](INFO): Inserting Stack from file: Missions/Insert/BackseatDriver.tl
2024-02-27T21:57:10.007Z,1709071030.007 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Insert/BackseatDriver.tl
2024-02-27T21:57:10.020Z,1709071030.020 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Insert/BackseatDriver.tl
2024-02-27T21:57:10.075Z,1709071030.075 [MissionManager](DEBUG): TethyslAPI: Missions/Insert/BackseatDriver.tl translated into:
2024-02-27T21:57:10.083Z,1709071030.083 [MissionManager](INFO): DefineArg lab_test_optim:BackseatDriver.EnableBackseat = 0 bool
2024-02-27T21:57:10.094Z,1709071030.094 [lab_test_optim:BackseatDriver:A.BackseatDriver](DEBUG): Construct BackseatDriver.
2024-02-27T21:57:10.173Z,1709071030.173 [lab_test_optim:Startup:B.Wait](DEBUG): Construct Wait.
2024-02-27T21:57:10.194Z,1709071030.194 [lab_test_optim:Startup:UseMission:E.Wait](DEBUG): Construct Wait.
2024-02-27T21:57:10.202Z,1709071030.202 [lab_test_optim:Startup:UseBackdoor:A.Execute](DEBUG): Construct Execute.
2024-02-27T21:57:10.211Z,1709071030.211 [lab_test_optim:Startup:UseBackdoor:D.Execute](DEBUG): Construct Execute.
2024-02-27T21:57:10.224Z,1709071030.224 [lab_test_optim:Startup:UseBackdoor:G.Execute](DEBUG): Construct Execute.
2024-02-27T21:57:10.227Z,1709071030.227 [lab_test_optim:Startup:UseHardcode:A.Execute](DEBUG): Construct Execute.
2024-02-27T21:57:10.242Z,1709071030.242 [lab_test_optim:Run:H.Wait](DEBUG): Construct Wait.
2024-02-27T21:57:10.243Z,1709071030.243 [lab_test_optim:G.Wait](DEBUG): Construct Wait.
2024-02-27T21:57:10.251Z,1709071030.251 [MissionManager](DEBUG):
mission lab_test_optim {
arguments {
MissionTimeout = 15 minute
"""
Backseat will stay on for this duration, independent of Optim state
"""
RecordTime = 1 minute
"""
How long to record after startup sequence (hopefully) turns on Optim camera
"""
BackseatWait = 30 second
"""
How long to wait for the backseat to power up before attempting to power the Optim
"""
UseMission = true
"""
If true, tries to go through the application and use components/behaviors for commands.
Set InitialSampleTime to change delays. If false, backdoors app. Use SleepCycles to change delays.
Optim must be on C3.
"""
UseHardcode = false
"""
If true, backdoors app with a powercycle and a hardcoded sleep 1. Try the two other modes first?
Optim must be on C3.
"""
InitialSampleTime = 1 second
"""
PowerOnly sample time for initial record. Will go back to continuous after startup.
"""
SleepCycles = 3 count
"""
How many vehicle computation cycles to wait before commanding the Optim off on initial record
"""
LightMode = 2 count
"""
Mode for Multiray lights. 0 is off, 1 is red, 2 is white
"""
BrightnessWhite = 100 none_int
"""
White Multiray LED brightness, 0-100
"""
BrightnessRed = 100 none_int
"""
Red Multiray LED brightness, 0-100
"""
}
output {
CyclesWaited = 0 count
RecordingEnabled = false
LightsEnabled = false
}
timeout duration=MissionTimeout
insert Insert/BackseatDriver.tl
assign in parallel BackseatDriver:EnableBackseat = true
readData strategy="MinError" {
while ( RecordingEnabled )
Sensor:PowerOnly.sampleLoad1
}
readData strategy="MinError" {
while ( LightsEnabled )
Sensor:MultiRay.lightModeLog
}
aggregate Startup {
run in sequence
syslog important "Waiting " + BackseatWait~s + " for backseat to start up..."
behavior Guidance:Wait {
run in sequence
set duration = BackseatWait
}
aggregate UseMission {
run in sequence
break if (
not UseMission
or UseHardcode
)
assign in parallel Sensor:PowerOnly.sampleTime1 = InitialSampleTime
assign in sequence RecordingEnabled = true
syslog important "Disabling Optim recording after " + InitialSampleTime~s
assign in sequence RecordingEnabled = false
behavior Guidance:Wait {
run in sequence
set duration = InitialSampleTime
}
assign in sequence RecordingEnabled = true
syslog important "Powering up Optim to try to tide over gap to handoff..."
}
aggregate UseBackdoor {
run in sequence
break if (
UseMission
or UseHardcode
)
behavior Guidance:Execute {
run in sequence
set command = "! echo 1 > /dev/loadC3"
}
syslog important "Optim power on. Spinning for " + SleepCycles~count + " cycles."
aggregate WaitForStop {
run in sequence repeat=SleepCycles
assign in sequence CyclesWaited = CyclesWaited + 1 count
}
behavior Guidance:Execute {
run in sequence
set command = "! echo 0 > /dev/loadC3"
}
syslog important "Optim power off. Spinning again."
aggregate WaitForStart {
run in sequence repeat=SleepCycles
assign in sequence CyclesWaited = CyclesWaited + 1 count
}
behavior Guidance:Execute {
run in sequence
set command = "! echo 1 > /dev/loadC3"
}
syslog important "Optim power on. Handing off to mission."
}
aggregate UseHardcode {
run in sequence
break if ( not UseHardcode )
behavior Guidance:Execute {
run in sequence
set command = "! echo 1 > /dev/loadC3; sleep 1; echo 0 > /dev/loadC3; sleep 1; echo 1 > dev/loadC3"
}
syslog important "Hardcoded Optim command sent. Good luck."
}
}
aggregate Run {
run in sequence
syslog important "Trying to run Optim and Multiray forreal"
assign in sequence RecordingEnabled = true
assign in sequence LightsEnabled = true
assign in sequence Sensor:MultiRay.lightModeCommand = LightMode
aggregate setRed {
run in sequence
break if ( LightMode != 1 count )
assign in sequence Sensor:MultiRay.brightnessRed = BrightnessRed
syslog info "Setting multiray red brightness to" + BrightnessRed~count
}
aggregate setWhite {
run in sequence
break if ( LightMode != 2 count )
assign in sequence Sensor:MultiRay.brightnessWhite = BrightnessWhite
syslog info "Setting muliray white brightness to" + BrightnessWhite~count
}
syslog important "Recording for " + RecordTime~min
behavior Guidance:Wait {
run in sequence
set duration = RecordTime
}
}
behavior Guidance:Wait {
run in sequence
set duration = MissionTimeout
}
}
2024-02-27T21:57:10.262Z,1709071030.262 [CommandExec](IMPORTANT): Running ./Missions/Engineering/lab_test_optim.tl
2024-02-27T21:57:10.538Z,1709071030.538 [Default] Stopped
2024-02-27T21:57:10.538Z,1709071030.538 [Default](DEBUG): Aggregate::uninitialize Default
2024-02-27T21:57:10.538Z,1709071030.538 [Default:B.GoToSurface] Stopped
2024-02-27T21:57:10.538Z,1709071030.538 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2024-02-27T21:57:10.538Z,1709071030.538 [Default:CheckIn] Stopped
2024-02-27T21:57:10.539Z,1709071030.539 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-02-27T21:57:10.539Z,1709071030.539 [Default:CheckIn:C.Wait] Stopped
2024-02-27T21:57:10.539Z,1709071030.539 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-02-27T21:57:10.539Z,1709071030.539 [MissionManager](IMPORTANT): Started mission lab_test_optim
2024-02-27T21:57:10.539Z,1709071030.539 [lab_test_optim] Running Loop=1
2024-02-27T21:57:10.539Z,1709071030.539 [lab_test_optim](DEBUG): Aggregate::initialize lab_test_optim
2024-02-27T21:57:10.539Z,1709071030.539 [lab_test_optim:BackseatDriver] Running Loop=1
2024-02-27T21:57:10.539Z,1709071030.539 [lab_test_optim:BackseatDriver](DEBUG): Aggregate::initialize lab_test_optim:BackseatDriver
2024-02-27T21:57:10.540Z,1709071030.540 [lab_test_optim:BackseatDriver:A.BackseatDriver] Running Loop=1
2024-02-27T21:57:10.540Z,1709071030.540 [lab_test_optim:B] Running Loop=1
2024-02-27T21:57:10.540Z,1709071030.540 [lab_test_optim:C] Running Loop=1
2024-02-27T21:57:10.540Z,1709071030.540 [lab_test_optim:D] Running Loop=1
2024-02-27T21:57:10.541Z,1709071030.541 [lab_test_optim:Startup] Running Loop=1
2024-02-27T21:57:10.541Z,1709071030.541 [lab_test_optim:Startup](DEBUG): Aggregate::initialize lab_test_optim:Startup
2024-02-27T21:57:10.541Z,1709071030.541 [lab_test_optim:Startup:A] Running Loop=1
2024-02-27T21:57:10.542Z,1709071030.542 [lab_test_optim:Startup:A](IMPORTANT): Waiting 30.000000 s for backseat to start up...
2024-02-27T21:57:10.542Z,1709071030.542 [lab_test_optim:Startup:A] Stopped
2024-02-27T21:57:10.542Z,1709071030.542 [lab_test_optim:Startup:B.Wait] Running Loop=1
2024-02-27T21:57:10.542Z,1709071030.542 [lab_test_optim:Startup:B.Wait](DEBUG): Initialize Wait Component.
2024-02-27T21:57:10.542Z,1709071030.542 [lab_test_optim:D] Stopped
2024-02-27T21:57:10.542Z,1709071030.542 [lab_test_optim:C] Stopped
2024-02-27T21:57:10.542Z,1709071030.542 [lab_test_optim:B] Running Loop=1
2024-02-27T21:57:10.542Z,1709071030.542 [lab_test_optim:BackseatDriver] Running Loop=1
2024-02-27T21:57:10.543Z,1709071030.543 [lab_test_optim:BackseatDriver:A.BackseatDriver](INFO): Initializing backseat
2024-02-27T21:57:10.668Z,1709071030.668 [BackseatComponent](INFO): Powering up
2024-02-27T21:57:10.669Z,1709071030.669 [BackseatComponent](INFO): Subscribing to LCM channels.
2024-02-27T21:57:41.251Z,1709071061.251 [lab_test_optim:Startup:B.Wait](INFO): Done Waiting.
2024-02-27T21:57:41.251Z,1709071061.251 [lab_test_optim:Startup:B.Wait] Stopped
2024-02-27T21:57:41.251Z,1709071061.251 [lab_test_optim:Startup:B.Wait](DEBUG): Uninitialize Wait Component.
2024-02-27T21:57:41.251Z,1709071061.251 [lab_test_optim:Startup:UseMission] Running Loop=1
2024-02-27T21:57:41.251Z,1709071061.251 [lab_test_optim:Startup:UseMission](DEBUG): Aggregate::initialize lab_test_optim:Startup:UseMission
2024-02-27T21:57:41.251Z,1709071061.251 [lab_test_optim:Startup:UseMission:A] Running Loop=1
2024-02-27T21:57:41.251Z,1709071061.251 [lab_test_optim:Startup:UseMission:B] Running Loop=1
2024-02-27T21:57:41.667Z,1709071061.667 [lab_test_optim:Startup:UseMission:B] Stopped
2024-02-27T21:57:41.668Z,1709071061.668 [lab_test_optim:Startup:UseMission:C] Running Loop=1
2024-02-27T21:57:41.668Z,1709071061.668 [lab_test_optim:Startup:UseMission:A] Running Loop=1
2024-02-27T21:57:42.068Z,1709071062.068 [lab_test_optim:Startup:UseMission:C](IMPORTANT): Disabling Optim recording after 1.000000 s
2024-02-27T21:57:42.068Z,1709071062.068 [lab_test_optim:Startup:UseMission:C] Stopped
2024-02-27T21:57:42.093Z,1709071062.093 [lab_test_optim:Startup:UseMission:D] Running Loop=1
2024-02-27T21:57:42.094Z,1709071062.094 [lab_test_optim:C] Running Loop=1
2024-02-27T21:57:42.094Z,1709071062.094 [lab_test_optim:C] Running Loop=1
2024-02-27T21:57:42.094Z,1709071062.094 [lab_test_optim:C](DEBUG): Initialize ReadDataComponent to sense PowerOnly.sampleLoad1
2024-02-27T21:57:42.456Z,1709071062.456 [PowerOnly](INFO): Powering down loadControl
2024-02-27T21:57:42.473Z,1709071062.473 [lab_test_optim:Startup:UseMission:D] Stopped
2024-02-27T21:57:42.473Z,1709071062.473 [lab_test_optim:Startup:UseMission:E.Wait] Running Loop=1
2024-02-27T21:57:42.473Z,1709071062.473 [lab_test_optim:Startup:UseMission:E.Wait](DEBUG): Initialize Wait Component.
2024-02-27T21:57:42.863Z,1709071062.863 [lab_test_optim:C] Stopped
2024-02-27T21:57:44.067Z,1709071064.067 [lab_test_optim:Startup:UseMission:E.Wait](INFO): Done Waiting.
2024-02-27T21:57:44.067Z,1709071064.067 [lab_test_optim:Startup:UseMission:E.Wait] Stopped
2024-02-27T21:57:44.067Z,1709071064.067 [lab_test_optim:Startup:UseMission:E.Wait](DEBUG): Uninitialize Wait Component.
2024-02-27T21:57:44.067Z,1709071064.067 [lab_test_optim:Startup:UseMission:F] Running Loop=1
2024-02-27T21:57:44.476Z,1709071064.476 [lab_test_optim:Startup:UseMission:F] Stopped
2024-02-27T21:57:44.476Z,1709071064.476 [lab_test_optim:Startup:UseMission:G] Running Loop=1
2024-02-27T21:57:44.895Z,1709071064.895 [lab_test_optim:Startup:UseMission:G](IMPORTANT): Powering up Optim to try to tide over gap to handoff...
2024-02-27T21:57:44.895Z,1709071064.895 [lab_test_optim:Startup:UseMission:G] Stopped
2024-02-27T21:57:44.896Z,1709071064.896 [lab_test_optim:Startup:UseMission](INFO): Completed lab_test_optim:Startup:UseMission
2024-02-27T21:57:44.896Z,1709071064.896 [lab_test_optim:Startup:UseMission] Stopped
2024-02-27T21:57:44.896Z,1709071064.896 [lab_test_optim:Startup:UseMission](DEBUG): Aggregate::uninitialize lab_test_optim:Startup:UseMission
2024-02-27T21:57:44.896Z,1709071064.896 [lab_test_optim:Startup:UseMission:A] Stopped
2024-02-27T21:57:44.896Z,1709071064.896 [lab_test_optim:Startup:UseBackdoor] Running Loop=1
2024-02-27T21:57:44.896Z,1709071064.896 [lab_test_optim:Startup:UseBackdoor](DEBUG): Aggregate::initialize lab_test_optim:Startup:UseBackdoor
2024-02-27T21:57:44.896Z,1709071064.896 [lab_test_optim:Startup:UseBackdoor:A.Execute] Running Loop=1
2024-02-27T21:57:44.897Z,1709071064.897 [lab_test_optim:C] Running Loop=1
2024-02-27T21:57:45.281Z,1709071065.281 [PowerOnly](INFO): Powering up loadControl
2024-02-27T21:57:45.326Z,1709071065.326 [lab_test_optim:Startup:UseBackdoor] Stopped
2024-02-27T21:57:45.326Z,1709071065.326 [lab_test_optim:Startup:UseBackdoor](DEBUG): Aggregate::uninitialize lab_test_optim:Startup:UseBackdoor
2024-02-27T21:57:45.326Z,1709071065.326 [lab_test_optim:Startup:UseBackdoor:A.Execute] Stopped
2024-02-27T21:57:45.326Z,1709071065.326 [lab_test_optim:Startup:UseHardcode] Running Loop=1
2024-02-27T21:57:45.326Z,1709071065.326 [lab_test_optim:Startup:UseHardcode](DEBUG): Aggregate::initialize lab_test_optim:Startup:UseHardcode
2024-02-27T21:57:45.326Z,1709071065.326 [lab_test_optim:Startup:UseHardcode:A.Execute] Running Loop=1
2024-02-27T21:57:45.696Z,1709071065.696 [lab_test_optim:Startup:UseHardcode] Stopped
2024-02-27T21:57:45.696Z,1709071065.696 [lab_test_optim:Startup:UseHardcode](DEBUG): Aggregate::uninitialize lab_test_optim:Startup:UseHardcode
2024-02-27T21:57:45.696Z,1709071065.696 [lab_test_optim:Startup:UseHardcode:A.Execute] Stopped
2024-02-27T21:57:45.696Z,1709071065.696 [lab_test_optim:Startup](INFO): Completed lab_test_optim:Startup
2024-02-27T21:57:45.696Z,1709071065.696 [lab_test_optim:Startup] Stopped
2024-02-27T21:57:45.696Z,1709071065.696 [lab_test_optim:Startup](DEBUG): Aggregate::uninitialize lab_test_optim:Startup
2024-02-27T21:57:45.696Z,1709071065.696 [lab_test_optim:Run] Running Loop=1
2024-02-27T21:57:45.697Z,1709071065.697 [lab_test_optim:Run](DEBUG): Aggregate::initialize lab_test_optim:Run
2024-02-27T21:57:45.697Z,1709071065.697 [lab_test_optim:Run:A] Running Loop=1
2024-02-27T21:57:46.092Z,1709071066.092 [lab_test_optim:Run:A](IMPORTANT): Trying to run Optim and Multiray forreal
2024-02-27T21:57:46.092Z,1709071066.092 [lab_test_optim:Run:A] Stopped
2024-02-27T21:57:46.092Z,1709071066.092 [lab_test_optim:Run:B] Running Loop=1
2024-02-27T21:57:46.491Z,1709071066.491 [lab_test_optim:Run:B] Stopped
2024-02-27T21:57:46.491Z,1709071066.491 [lab_test_optim:Run:C] Running Loop=1
2024-02-27T21:57:46.891Z,1709071066.891 [lab_test_optim:Run:C] Stopped
2024-02-27T21:57:46.891Z,1709071066.891 [lab_test_optim:Run:D] Running Loop=1
2024-02-27T21:57:47.295Z,1709071067.295 [lab_test_optim:Run:D] Stopped
2024-02-27T21:57:47.295Z,1709071067.295 [lab_test_optim:Run:setRed] Running Loop=1
2024-02-27T21:57:47.295Z,1709071067.295 [lab_test_optim:Run:setRed](DEBUG): Aggregate::initialize lab_test_optim:Run:setRed
2024-02-27T21:57:47.295Z,1709071067.295 [lab_test_optim:Run:setRed:A] Running Loop=1
2024-02-27T21:57:47.295Z,1709071067.295 [lab_test_optim:D] Running Loop=1
2024-02-27T21:57:47.295Z,1709071067.295 [lab_test_optim:D] Running Loop=1
2024-02-27T21:57:47.296Z,1709071067.296 [lab_test_optim:D](DEBUG): Initialize ReadDataComponent to sense MultiRay.lightModeLog
2024-02-27T21:57:47.731Z,1709071067.731 [lab_test_optim:Run:setRed] Stopped
2024-02-27T21:57:47.731Z,1709071067.731 [lab_test_optim:Run:setRed](DEBUG): Aggregate::uninitialize lab_test_optim:Run:setRed
2024-02-27T21:57:47.731Z,1709071067.731 [lab_test_optim:Run:setRed:A] Stopped
2024-02-27T21:57:47.731Z,1709071067.731 [lab_test_optim:Run:setWhite] Running Loop=1
2024-02-27T21:57:47.731Z,1709071067.731 [lab_test_optim:Run:setWhite](DEBUG): Aggregate::initialize lab_test_optim:Run:setWhite
2024-02-27T21:57:47.732Z,1709071067.732 [lab_test_optim:Run:setWhite:A] Running Loop=1
2024-02-27T21:57:48.151Z,1709071068.151 [lab_test_optim:Run:setWhite:A] Stopped
2024-02-27T21:57:48.151Z,1709071068.151 [lab_test_optim:Run:setWhite:B] Running Loop=1
2024-02-27T21:57:48.563Z,1709071068.563 [lab_test_optim:Run:setWhite:B](INFO): Setting muliray white brightness to 100.000000 count
2024-02-27T21:57:48.564Z,1709071068.564 [lab_test_optim:Run:setWhite:B] Stopped
2024-02-27T21:57:48.564Z,1709071068.564 [lab_test_optim:Run:setWhite](INFO): Completed lab_test_optim:Run:setWhite
2024-02-27T21:57:48.564Z,1709071068.564 [lab_test_optim:Run:setWhite] Stopped
2024-02-27T21:57:48.564Z,1709071068.564 [lab_test_optim:Run:setWhite](DEBUG): Aggregate::uninitialize lab_test_optim:Run:setWhite
2024-02-27T21:57:48.564Z,1709071068.564 [lab_test_optim:Run:G] Running Loop=1
2024-02-27T21:57:48.916Z,1709071068.916 [lab_test_optim:Run:G](IMPORTANT): Recording for 1.000000 min
2024-02-27T21:57:48.916Z,1709071068.916 [lab_test_optim:Run:G] Stopped
2024-02-27T21:57:48.916Z,1709071068.916 [lab_test_optim:Run:H.Wait] Running Loop=1
2024-02-27T21:57:48.916Z,1709071068.916 [lab_test_optim:Run:H.Wait](DEBUG): Initialize Wait Component.
2024-02-27T21:57:52.137Z,1709071072.137 [MultiRay](IMPORTANT): MultiRay white lights ON
2024-02-27T21:58:07.920Z,1709071087.920 [CBIT](INFO): Clearing failed state for component DropWeight
2024-02-27T21:58:07.920Z,1709071087.920 [DropWeight] No Fault, FailCount= 1
2024-02-27T21:58:08.975Z,1709071088.975 [BackseatComponent](IMPORTANT): ikshana: running backseat application.
2024-02-27T21:58:11.134Z,1709071091.134 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5
2024-02-27T21:58:11.134Z,1709071091.134 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-02-27T21:58:11.135Z,1709071091.135 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 5
2024-02-27T21:58:11.135Z,1709071091.135 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2024-02-27T21:58:11.148Z,1709071091.148 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-02-27T21:58:11.148Z,1709071091.148 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2024-02-27T21:58:11.556Z,1709071091.556 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-02-27T21:58:11.556Z,1709071091.556 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5
2024-02-27T21:58:11.556Z,1709071091.556 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2024-02-27T21:58:11.557Z,1709071091.557 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 5
2024-02-27T21:58:11.968Z,1709071091.968 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2024-02-27T21:58:49.539Z,1709071129.539 [lab_test_optim:Run:H.Wait](INFO): Done Waiting.
2024-02-27T21:58:49.539Z,1709071129.539 [lab_test_optim:Run:H.Wait] Stopped
2024-02-27T21:58:49.539Z,1709071129.539 [lab_test_optim:Run:H.Wait](DEBUG): Uninitialize Wait Component.
2024-02-27T21:58:49.540Z,1709071129.540 [lab_test_optim:Run](INFO): Completed lab_test_optim:Run
2024-02-27T21:58:49.540Z,1709071129.540 [lab_test_optim:Run] Stopped
2024-02-27T21:58:49.540Z,1709071129.540 [lab_test_optim:Run](DEBUG): Aggregate::uninitialize lab_test_optim:Run
2024-02-27T21:58:49.540Z,1709071129.540 [lab_test_optim:G.Wait] Running Loop=1
2024-02-27T21:58:49.540Z,1709071129.540 [lab_test_optim:G.Wait](DEBUG): Initialize Wait Component.
2024-02-27T22:01:12.138Z,1709071272.138 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6
2024-02-27T22:01:12.138Z,1709071272.138 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-02-27T22:01:12.139Z,1709071272.139 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 6
2024-02-27T22:01:12.139Z,1709071272.139 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2024-02-27T22:01:12.152Z,1709071272.152 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-02-27T22:01:12.152Z,1709071272.152 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2024-02-27T22:01:12.557Z,1709071272.557 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-02-27T22:01:12.557Z,1709071272.557 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6
2024-02-27T22:01:12.557Z,1709071272.557 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2024-02-27T22:01:12.557Z,1709071272.557 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 6
2024-02-27T22:01:12.953Z,1709071272.953 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2024-02-27T22:04:13.193Z,1709071453.193 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7
2024-02-27T22:04:13.193Z,1709071453.193 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-02-27T22:04:13.194Z,1709071453.194 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 7
2024-02-27T22:04:13.194Z,1709071453.194 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2024-02-27T22:04:13.225Z,1709071453.225 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-02-27T22:04:13.225Z,1709071453.225 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2024-02-27T22:04:13.608Z,1709071453.608 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-02-27T22:04:13.608Z,1709071453.608 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7
2024-02-27T22:04:13.608Z,1709071453.608 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2024-02-27T22:04:13.609Z,1709071453.609 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 7
2024-02-27T22:04:13.981Z,1709071453.981 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2024-02-27T22:04:30.942Z,1709071470.942 [NAL9602](FAULT): GPS failed to acquire within timeout.
2024-02-27T22:04:30.942Z,1709071470.942 [NAL9602] Data Fault, FailCount= 2
2024-02-27T22:04:30.942Z,1709071470.942 [NAL9602](ERROR): Data Fault
2024-02-27T22:04:30.987Z,1709071470.987 [CBIT](ERROR): Data Fault in component: NAL9602
2024-02-27T22:04:31.346Z,1709071471.346 [NAL9602](INFO): Powering down
2024-02-27T22:04:32.180Z,1709071472.180 [CBIT](INFO): Clearing failed state for component NAL9602
2024-02-27T22:04:32.180Z,1709071472.180 [NAL9602] No Fault, FailCount= 2
2024-02-27T22:05:01.646Z,1709071501.646 [NAL9602](INFO): Powering up NAL9602
2024-02-27T22:05:12.550Z,1709071512.550 [NAL9602](INFO): NAL9602 initialized
2024-02-27T22:06:56.851Z,1709071616.851 [CBIT](INFO): Clearing failed state for component BPC1
2024-02-27T22:06:56.851Z,1709071616.851 [BPC1] No Fault, FailCount= 1
2024-02-27T22:07:14.166Z,1709071634.166 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8
2024-02-27T22:07:14.166Z,1709071634.166 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-02-27T22:07:14.167Z,1709071634.167 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 8
2024-02-27T22:07:14.167Z,1709071634.167 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2024-02-27T22:07:14.181Z,1709071634.181 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-02-27T22:07:14.181Z,1709071634.181 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2024-02-27T22:07:14.600Z,1709071634.600 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-02-27T22:07:14.600Z,1709071634.600 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8
2024-02-27T22:07:14.601Z,1709071634.601 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2024-02-27T22:07:14.601Z,1709071634.601 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 8
2024-02-27T22:07:14.996Z,1709071634.996 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2024-02-27T22:08:08.355Z,1709071688.355 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T22:08:09.546Z,1709071689.546 [lab_test_optim:BackseatDriver:A.BackseatDriver](INFO): Created data writer for _.data_dir_logging_rate with code: 1918
2024-02-27T22:08:19.267Z,1709071699.267 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T22:08:30.177Z,1709071710.177 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T22:08:41.135Z,1709071721.135 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T22:08:52.392Z,1709071732.392 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T22:09:04.894Z,1709071744.894 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T22:09:15.474Z,1709071755.474 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T22:09:25.511Z,1709071765.511 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T22:09:36.479Z,1709071776.479 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T22:09:47.335Z,1709071787.335 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T22:09:57.839Z,1709071797.839 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T22:10:01.060Z,1709071801.060 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T22:10:08.820Z,1709071808.820 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T22:10:15.222Z,1709071815.222 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 9
2024-02-27T22:10:15.222Z,1709071815.222 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-02-27T22:10:15.223Z,1709071815.223 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 9
2024-02-27T22:10:15.223Z,1709071815.223 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2024-02-27T22:10:15.261Z,1709071815.261 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-02-27T22:10:15.261Z,1709071815.261 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2024-02-27T22:10:15.589Z,1709071815.589 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-02-27T22:10:15.589Z,1709071815.589 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 9
2024-02-27T22:10:15.590Z,1709071815.590 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2024-02-27T22:10:15.590Z,1709071815.590 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 9
2024-02-27T22:10:16.002Z,1709071816.002 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2024-02-27T22:10:19.676Z,1709071819.676 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T22:10:30.568Z,1709071830.568 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T22:10:41.471Z,1709071841.471 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T22:10:52.381Z,1709071852.381 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T22:11:03.474Z,1709071863.474 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T22:11:14.198Z,1709071874.198 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T22:11:21.815Z,1709071881.815 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T22:11:25.138Z,1709071885.138 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T22:11:32.782Z,1709071892.782 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T22:11:36.018Z,1709071896.018 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T22:11:43.690Z,1709071903.690 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T22:11:46.919Z,1709071906.919 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T22:11:54.594Z,1709071914.594 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T22:11:57.827Z,1709071917.827 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T22:12:05.511Z,1709071925.511 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T22:12:08.735Z,1709071928.735 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T22:12:10.711Z,1709071930.711 [lab_test_optim](INFO): Timed out from 2024-02-27T21:57:10.5Z
2024-02-27T22:12:10.711Z,1709071930.711 [MissionManager](INFO): lab_test_optim is completed.
2024-02-27T22:12:10.711Z,1709071930.711 [MissionManager](INFO): Uninitializing Mission lab_test_optim
2024-02-27T22:12:10.711Z,1709071930.711 [lab_test_optim] Stopped
2024-02-27T22:12:10.711Z,1709071930.711 [lab_test_optim](DEBUG): Aggregate::uninitialize lab_test_optim
2024-02-27T22:12:10.711Z,1709071930.711 [lab_test_optim:BackseatDriver] Stopped
2024-02-27T22:12:10.711Z,1709071930.711 [lab_test_optim:BackseatDriver](DEBUG): Aggregate::uninitialize lab_test_optim:BackseatDriver
2024-02-27T22:12:10.711Z,1709071930.711 [lab_test_optim:BackseatDriver:A.BackseatDriver] Stopped
2024-02-27T22:12:10.711Z,1709071930.711 [lab_test_optim:B] Stopped
2024-02-27T22:12:10.712Z,1709071930.712 [lab_test_optim:C] Stopped
2024-02-27T22:12:10.712Z,1709071930.712 [lab_test_optim:D] Stopped
2024-02-27T22:12:10.712Z,1709071930.712 [lab_test_optim:G.Wait] Stopped
2024-02-27T22:12:10.712Z,1709071930.712 [lab_test_optim:G.Wait](DEBUG): Uninitialize Wait Component.
2024-02-27T22:12:11.107Z,1709071931.107 [MissionManager](IMPORTANT): Started mission Default
2024-02-27T22:12:11.107Z,1709071931.107 [Default] Running Loop=1
2024-02-27T22:12:11.107Z,1709071931.107 [Default](DEBUG): Aggregate::initialize Default
2024-02-27T22:12:11.107Z,1709071931.107 [Default:B.GoToSurface] Running Loop=1
2024-02-27T22:12:11.107Z,1709071931.107 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2024-02-27T22:12:11.107Z,1709071931.107 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2024-02-27T22:12:11.108Z,1709071931.108 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2024-02-27T22:12:11.108Z,1709071931.108 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2024-02-27T22:12:11.109Z,1709071931.109 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2024-02-27T22:12:11.109Z,1709071931.109 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2024-02-27T22:12:11.109Z,1709071931.109 [Default:A.Wait] Running Loop=1
2024-02-27T22:12:11.109Z,1709071931.109 [Default:A.Wait](DEBUG): Initialize Wait Component.
2024-02-27T22:12:11.681Z,1709071931.681 [BackseatComponent](INFO): Sent LCM shutdown request.
2024-02-27T22:12:11.682Z,1709071931.682 [BackseatComponent](INFO): Shutdown requested. Waiting (18.00 sec to power down.).
2024-02-27T22:12:16.057Z,1709071936.057 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T22:12:19.645Z,1709071939.645 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T22:12:24.448Z,1709071944.448 [Default:A.Wait](INFO): Done Waiting.
2024-02-27T22:12:24.448Z,1709071944.448 [Default:A.Wait] Stopped
2024-02-27T22:12:24.448Z,1709071944.448 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2024-02-27T22:12:24.843Z,1709071944.843 [Default:CheckIn] Running Loop=1
2024-02-27T22:12:24.843Z,1709071944.843 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-02-27T22:12:24.844Z,1709071944.844 [Default:CheckIn:Read_GPS] Running Loop=1
2024-02-27T22:12:27.323Z,1709071947.323 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T22:12:29.864Z,1709071949.864 [BackseatComponent](INFO): Powering down and starting shutdown timer (18.00 sec).
2024-02-27T22:12:29.865Z,1709071949.865 [BackseatComponent](INFO): Unsubscribing from LCM channels.
2024-02-27T22:12:29.865Z,1709071949.865 [LcmUniversalReporter](INFO): Deactivating messaging.
2024-02-27T22:12:30.551Z,1709071950.551 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T22:12:38.633Z,1709071958.633 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T22:12:41.457Z,1709071961.457 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T22:12:50.001Z,1709071970.001 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T22:12:52.368Z,1709071972.368 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T22:13:00.852Z,1709071980.852 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T22:13:03.282Z,1709071983.282 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T22:13:11.796Z,1709071991.796 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T22:13:14.213Z,1709071994.213 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T22:13:16.177Z,1709071996.177 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 10
2024-02-27T22:13:16.177Z,1709071996.177 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-02-27T22:13:16.178Z,1709071996.178 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 10
2024-02-27T22:13:16.178Z,1709071996.178 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2024-02-27T22:13:16.202Z,1709071996.202 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-02-27T22:13:16.202Z,1709071996.202 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2024-02-27T22:13:16.617Z,1709071996.617 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-02-27T22:13:16.618Z,1709071996.618 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 10
2024-02-27T22:13:16.618Z,1709071996.618 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2024-02-27T22:13:16.618Z,1709071996.618 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 10
2024-02-27T22:13:16.965Z,1709071996.965 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2024-02-27T22:13:22.669Z,1709072002.669 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T22:13:25.142Z,1709072005.142 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T22:13:33.582Z,1709072013.582 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T22:13:36.407Z,1709072016.407 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T22:13:44.485Z,1709072024.485 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T22:13:47.311Z,1709072027.311 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T22:13:55.800Z,1709072035.800 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T22:13:57.814Z,1709072037.814 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T22:14:06.707Z,1709072046.707 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T22:14:08.728Z,1709072048.728 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T22:14:17.615Z,1709072057.615 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T22:14:19.632Z,1709072059.632 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T22:14:28.109Z,1709072068.109 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T22:14:30.541Z,1709072070.541 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T22:14:39.033Z,1709072079.033 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T22:14:41.446Z,1709072081.446 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T22:14:50.335Z,1709072090.335 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T22:14:51.944Z,1709072091.944 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T22:15:01.242Z,1709072101.242 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T22:15:02.859Z,1709072102.859 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T22:15:11.771Z,1709072111.771 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T22:15:14.185Z,1709072114.185 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T22:15:15.334Z,1709072115.334 [NAL9602](FAULT): GPS failed to acquire within timeout.
2024-02-27T22:15:15.334Z,1709072115.334 [NAL9602] Data Fault, FailCount= 3
2024-02-27T22:15:15.334Z,1709072115.334 [NAL9602](ERROR): Data Fault
2024-02-27T22:15:15.352Z,1709072115.352 [CBIT](ERROR): Data Fault in component: NAL9602
2024-02-27T22:15:15.738Z,1709072115.738 [NAL9602](INFO): Powering down
2024-02-27T22:15:16.562Z,1709072116.562 [CBIT](INFO): Clearing failed state for component NAL9602
2024-02-27T22:15:16.562Z,1709072116.562 [NAL9602] No Fault, FailCount= 3
2024-02-27T22:15:22.672Z,1709072122.672 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-02-27T22:15:24.329Z,1709072124.329 [CommandExec](IMPORTANT): got command restart application
2024-02-27T22:15:25.090Z,1709072125.090 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-02-27T22:15:25.332Z,1709072125.332 [Supervisor](INFO): Stop Mission called by Supervisor::terminate
2024-02-27T22:15:25.332Z,1709072125.332 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread.
2024-02-27T22:15:25.333Z,1709072125.333 [CommandExec](INFO): Uninitializing the command executive.
2024-02-27T22:15:25.333Z,1709072125.333 [CommandExec](INFO): Uninitializing the command scheduler.
2024-02-27T22:15:25.333Z,1709072125.333 [CommandExec ThreadHandler](INFO): Thread cancelled.
2024-02-27T22:15:25.412Z,1709072125.412 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye!
2024-02-27T22:15:25.412Z,1709072125.412 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2024-02-27T22:15:25.412Z,1709072125.412 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2024-02-27T22:15:25.413Z,1709072125.413 [NavChartDb](INFO): Join timeout helper Thread ID is 9352
2024-02-27T22:15:25.608Z,1709072125.608 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2024-02-27T22:15:25.608Z,1709072125.608 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2024-02-27T22:15:25.616Z,1709072125.616 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2024-02-27T22:15:25.616Z,1709072125.616 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2024-02-27T22:15:25.616Z,1709072125.616 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 9353
2024-02-27T22:15:26.028Z,1709072126.028 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2024-02-27T22:15:26.029Z,1709072126.029 [WetLabsBB2FL](INFO): Powering down
2024-02-27T22:15:26.029Z,1709072126.029 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2024-02-27T22:15:26.054Z,1709072126.054 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2024-02-27T22:15:26.054Z,1709072126.054 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2024-02-27T22:15:26.054Z,1709072126.054 [CTD_Seabird](INFO): Join timeout helper Thread ID is 9354
2024-02-27T22:15:26.140Z,1709072126.140 [CTD_Seabird](INFO): Powering down
2024-02-27T22:15:26.152Z,1709072126.152 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2024-02-27T22:15:26.153Z,1709072126.153 [CTD_Seabird](INFO): Powering down
2024-02-27T22:15:26.164Z,1709072126.164 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2024-02-27T22:15:26.172Z,1709072126.172 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler
2024-02-27T22:15:26.173Z,1709072126.173 [DAT ThreadHandler](INFO): Thread cancelled.
2024-02-27T22:15:26.173Z,1709072126.173 [DAT](INFO): Join timeout helper Thread ID is 9355
2024-02-27T22:15:26.209Z,1709072126.209 [DAT](INFO): Powering down
2024-02-27T22:15:26.281Z,1709072126.281 [DAT ThreadHandler](INFO): Uninitializing protected caller thread.
2024-02-27T22:15:26.281Z,1709072126.281 [DAT](INFO): Powering down
2024-02-27T22:15:26.282Z,1709072126.282 [DAT ThreadHandler](INFO): Thread cancelled.
2024-02-27T22:15:26.282Z,1709072126.282 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2024-02-27T22:15:26.282Z,1709072126.282 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2024-02-27T22:15:26.283Z,1709072126.283 [Radio_Surface](INFO): Join timeout helper Thread ID is 9356
2024-02-27T22:15:26.404Z,1709072126.404 [Radio_Surface](INFO): Powering down
2024-02-27T22:15:26.405Z,1709072126.405 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2024-02-27T22:15:26.405Z,1709072126.405 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2024-02-27T22:15:26.425Z,1709072126.425 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2024-02-27T22:15:26.425Z,1709072126.425 [Onboard ThreadHandler](INFO): Thread cancelled.
2024-02-27T22:15:26.425Z,1709072126.425 [Onboard](INFO): Join timeout helper Thread ID is 9357
2024-02-27T22:15:26.465Z,1709072126.465 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2024-02-27T22:15:28.564Z,1709072128.564 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2024-02-27T22:15:28.565Z,1709072128.565 [Onboard ThreadHandler](INFO): Thread cancelled.
2024-02-27T22:15:28.581Z,1709072128.581 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2024-02-27T22:15:28.581Z,1709072128.581 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2024-02-27T22:15:28.581Z,1709072128.581 [DataOverHttps](INFO): Join timeout helper Thread ID is 9358
2024-02-27T22:15:29.476Z,1709072129.476 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2024-02-27T22:15:29.476Z,1709072129.476 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2024-02-27T22:15:29.485Z,1709072129.485 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler
2024-02-27T22:15:29.485Z,1709072129.485 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2024-02-27T22:15:29.485Z,1709072129.485 [BackseatComponent](INFO): Join timeout helper Thread ID is 9359
2024-02-27T22:15:29.604Z,1709072129.604 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread.
2024-02-27T22:15:29.605Z,1709072129.605 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2024-02-27T22:15:29.625Z,1709072129.625 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2024-02-27T22:15:29.626Z,1709072129.626 [logger ThreadHandler](INFO): Thread cancelled.
2024-02-27T22:15:29.626Z,1709072129.626 [logger](INFO): Join timeout helper Thread ID is 9360
2024-02-27T22:15:29.626Z,1709072129.626 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2024-02-27T22:15:29.626Z,1709072129.626 [logger ThreadHandler](INFO): Thread cancelled.
2024-02-27T22:15:29.628Z,1709072129.628 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2024-02-27T22:15:29.628Z,1709072129.628 [CommandLine ThreadHandler](INFO): Thread cancelled.
2024-02-27T22:15:29.628Z,1709072129.628 [CommandLine](INFO): Join timeout helper Thread ID is 9361
2024-02-27T22:15:29.672Z,1709072129.672 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2024-02-27T22:15:29.672Z,1709072129.672 [CommandLine ThreadHandler](INFO): Thread cancelled.
2024-02-27T22:15:29.689Z,1709072129.689 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler
2024-02-27T22:15:29.689Z,1709072129.689 [CommandExec ThreadHandler](INFO): Thread cancelled.
2024-02-27T22:15:29.689Z,1709072129.689 [CommandExec](INFO): Join timeout helper Thread ID is 9362
2024-02-27T22:15:29.690Z,1709072129.690 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2024-02-27T22:15:29.690Z,1709072129.690 [controlThread ThreadHandler](INFO): Thread cancelled.
2024-02-27T22:15:29.691Z,1709072129.691 [controlThread](INFO): Join timeout helper Thread ID is 9363
2024-02-27T22:15:29.860Z,1709072129.860 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2024-02-27T22:15:29.860Z,1709072129.860 [controlThread](DEBUG): Uninitializing ControlThread
2024-02-27T22:15:29.861Z,1709072129.861 [AHRS_M2](INFO): Powering down
2024-02-27T22:15:29.933Z,1709072129.933 [MultiRay](INFO): Powering down.
2024-02-27T22:15:29.934Z,1709072129.934 [NAL9602](INFO): Powering down
2024-02-27T22:15:29.936Z,1709072129.936 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2024-02-27T22:15:29.937Z,1709072129.937 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2024-02-27T22:15:29.937Z,1709072129.937 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2024-02-27T22:15:29.938Z,1709072129.938 [MissionManager](INFO): Uninitializing Mission Default
2024-02-27T22:15:29.938Z,1709072129.938 [Default] Stopped
2024-02-27T22:15:29.938Z,1709072129.938 [Default](DEBUG): Aggregate::uninitialize Default
2024-02-27T22:15:29.938Z,1709072129.938 [Default:B.GoToSurface] Stopped
2024-02-27T22:15:29.938Z,1709072129.938 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2024-02-27T22:15:29.938Z,1709072129.938 [Default:CheckIn] Stopped
2024-02-27T22:15:29.938Z,1709072129.938 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-02-27T22:15:29.938Z,1709072129.938 [Default:CheckIn:Read_GPS] Stopped
2024-02-27T22:15:29.941Z,1709072129.941 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2024-02-27T22:15:29.941Z,1709072129.941 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2024-02-27T22:15:29.942Z,1709072129.942 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2024-02-27T22:15:29.942Z,1709072129.942 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2024-02-27T22:15:29.942Z,1709072129.942 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2024-02-27T22:15:29.942Z,1709072129.942 [BuoyancyServo](INFO): Powering down
2024-02-27T22:15:29.956Z,1709072129.956 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2024-02-27T22:15:29.956Z,1709072129.956 [ElevatorServo](INFO): Powering down
2024-02-27T22:15:29.957Z,1709072129.957 [MassServo](DEBUG): Uninitialize Mass Servo.
2024-02-27T22:15:29.957Z,1709072129.957 [MassServo](INFO): Powering down
2024-02-27T22:15:29.958Z,1709072129.958 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2024-02-27T22:15:29.958Z,1709072129.958 [RudderServo](INFO): Powering down
2024-02-27T22:15:29.959Z,1709072129.959 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2024-02-27T22:15:29.959Z,1709072129.959 [ThrusterHE](INFO): Powering down
2024-02-27T22:15:29.960Z,1709072129.960 [SBIT](DEBUG): Uninitialize SBIT Component.
2024-02-27T22:15:29.960Z,1709072129.960 [IBIT](DEBUG): Uninitialize IBIT Component.
2024-02-27T22:15:29.961Z,1709072129.961 [CBIT](DEBUG): Uninitialize CBIT Component.
2024-02-27T22:15:29.961Z,1709072129.961 [CBIT](DEBUG): Powering off loads.
2024-02-27T22:15:29.972Z,1709072129.972 [CBIT](DEBUG): Disabling WDT.
2024-02-27T22:15:29.984Z,1709072129.984 [CBIT](DEBUG): Opening all GF detection circuits.
2024-02-27T22:15:29.985Z,1709072129.985 [controlThread ThreadHandler](INFO): Thread cancelled.
2024-02-27T22:15:30.012Z,1709072130.012 [DAT ThreadHandler](INFO): Thread cancelled.
2024-02-27T22:15:30.017Z,1709072130.017 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2024-02-27T22:15:30.019Z,1709072130.019 [Onboard ThreadHandler](INFO): Thread cancelled.
2024-02-27T22:15:30.025Z,1709072130.025 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2024-02-27T22:15:30.069Z,1709072130.069 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2024-02-27T22:15:30.124Z,1709072130.124 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2024-02-27T22:15:30.128Z,1709072130.128 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2024-02-27T22:15:30.188Z,1709072130.188 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2024-02-27T22:15:30.235Z,1709072130.235 [logger ThreadHandler](INFO): Thread cancelled.