2024-07-03T18:36:12.484Z,1720031772.484 [Supervisor](DEBUG): Initializing supervisor.
2024-07-03T18:36:12.488Z,1720031772.488 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2024-07-03T18:36:12.488Z,1720031772.488 [SyncHandler](INFO): Protected caller Thread ID is 804
2024-07-03T18:36:12.489Z,1720031772.489 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2024-07-03T18:36:12.490Z,1720031772.490 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2024-07-03T18:36:12.490Z,1720031772.490 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 805
2024-07-03T18:36:12.494Z,1720031772.494 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2024-07-03T18:36:12.512Z,1720031772.512 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2024-07-03T18:36:12.513Z,1720031772.513 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2024-07-03T18:36:12.513Z,1720031772.513 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 806
2024-07-03T18:36:12.517Z,1720031772.517 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2024-07-03T18:36:12.518Z,1720031772.518 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2024-07-03T18:36:12.519Z,1720031772.519 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 807
2024-07-03T18:36:12.521Z,1720031772.521 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2024-07-03T18:36:12.522Z,1720031772.522 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2024-07-03T18:36:12.522Z,1720031772.522 [logger ThreadHandler](INFO): Protected caller Thread ID is 808
2024-07-03T18:36:12.526Z,1720031772.526 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2024-07-03T18:36:12.526Z,1720031772.526 [Supervisor](INFO): Looking for Config files in directory: Config/
2024-07-03T18:36:12.528Z,1720031772.528 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2024-07-03T18:36:13.018Z,1720031773.018 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2024-07-03T18:36:13.019Z,1720031773.019 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2024-07-03T18:36:13.250Z,1720031773.250 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2024-07-03T18:36:13.251Z,1720031773.251 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2024-07-03T18:36:13.345Z,1720031773.345 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2024-07-03T18:36:13.600Z,1720031773.600 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2024-07-03T18:36:13.600Z,1720031773.600 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2024-07-03T18:36:13.694Z,1720031773.694 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2024-07-03T18:36:13.803Z,1720031773.803 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2024-07-03T18:36:13.803Z,1720031773.803 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2024-07-03T18:36:14.248Z,1720031774.248 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2024-07-03T18:36:14.248Z,1720031774.248 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2024-07-03T18:36:14.395Z,1720031774.395 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2024-07-03T18:36:14.396Z,1720031774.396 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2024-07-03T18:36:14.954Z,1720031774.954 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2024-07-03T18:36:14.954Z,1720031774.954 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2024-07-03T18:36:15.160Z,1720031775.160 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2024-07-03T18:36:15.161Z,1720031775.161 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2024-07-03T18:36:15.590Z,1720031775.590 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2024-07-03T18:36:15.590Z,1720031775.590 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2024-07-03T18:36:15.899Z,1720031775.899 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2024-07-03T18:36:15.900Z,1720031775.900 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2024-07-03T18:36:16.023Z,1720031776.023 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2024-07-03T18:36:16.023Z,1720031776.023 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2024-07-03T18:36:16.888Z,1720031776.888 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2024-07-03T18:36:16.889Z,1720031776.889 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2024-07-03T18:36:17.276Z,1720031777.276 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2024-07-03T18:36:17.277Z,1720031777.277 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2024-07-03T18:36:17.948Z,1720031777.948 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2024-07-03T18:36:17.949Z,1720031777.949 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-triton/
2024-07-03T18:36:17.950Z,1720031777.950 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/vehicle.cfg
2024-07-03T18:36:18.084Z,1720031778.084 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/secure.cfg
2024-07-03T18:36:18.181Z,1720031778.181 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Science.cfg
2024-07-03T18:36:18.332Z,1720031778.332 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Simulator.cfg
2024-07-03T18:36:18.430Z,1720031778.430 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Battery.cfg
2024-07-03T18:36:18.706Z,1720031778.706 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2024-07-03T18:36:18.706Z,1720031778.706 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/logger.cfg
2024-07-03T18:36:18.824Z,1720031778.824 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Servo.cfg
2024-07-03T18:36:18.945Z,1720031778.945 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Navigation.cfg
2024-07-03T18:36:19.053Z,1720031779.053 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Sensor.cfg
2024-07-03T18:36:19.217Z,1720031779.217 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Control.cfg
2024-07-03T18:36:19.328Z,1720031779.328 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/BIT.cfg
2024-07-03T18:36:19.428Z,1720031779.428 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-triton/root/
2024-07-03T18:36:19.428Z,1720031779.428 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg
2024-07-03T18:36:19.433Z,1720031779.433 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2024-07-03T18:36:19.444Z,1720031779.444 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2024-07-03T18:36:19.444Z,1720031779.444 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2024-07-03T18:36:19.552Z,1720031779.552 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2024-07-03T18:36:19.552Z,1720031779.552 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2024-07-03T18:36:19.603Z,1720031779.603 [VerticalControl](DEBUG): Construct VerticalControl.
2024-07-03T18:36:19.663Z,1720031779.663 [VerticalControl] Loaded
2024-07-03T18:36:19.664Z,1720031779.664 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2024-07-03T18:36:19.667Z,1720031779.667 [HorizontalControl](DEBUG): Construct HorizontalControl.
2024-07-03T18:36:19.714Z,1720031779.714 [HorizontalControl] Loaded
2024-07-03T18:36:19.714Z,1720031779.714 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2024-07-03T18:36:19.717Z,1720031779.717 [SpeedControl](DEBUG): Construct SpeedControl.
2024-07-03T18:36:19.720Z,1720031779.720 [SpeedControl] Loaded
2024-07-03T18:36:19.720Z,1720031779.720 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2024-07-03T18:36:19.722Z,1720031779.722 [LoopControl](DEBUG): Construct LoopControl.
2024-07-03T18:36:19.723Z,1720031779.723 [LoopControl] Loaded
2024-07-03T18:36:19.723Z,1720031779.723 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2024-07-03T18:36:19.724Z,1720031779.724 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2024-07-03T18:36:19.724Z,1720031779.724 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2024-07-03T18:36:19.853Z,1720031779.853 [BuoyancyServo] Loaded
2024-07-03T18:36:19.853Z,1720031779.853 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2024-07-03T18:36:19.875Z,1720031779.875 [ElevatorServo] Loaded
2024-07-03T18:36:19.875Z,1720031779.875 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2024-07-03T18:36:19.896Z,1720031779.896 [MassServo] Loaded
2024-07-03T18:36:19.897Z,1720031779.897 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2024-07-03T18:36:19.917Z,1720031779.917 [RudderServo] Loaded
2024-07-03T18:36:19.917Z,1720031779.917 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2024-07-03T18:36:19.934Z,1720031779.934 [ThrusterHE] Loaded
2024-07-03T18:36:19.934Z,1720031779.934 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread.
2024-07-03T18:36:19.934Z,1720031779.934 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2024-07-03T18:36:19.935Z,1720031779.935 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2024-07-03T18:36:19.984Z,1720031779.984 [DepthRateCalculator] Loaded
2024-07-03T18:36:19.984Z,1720031779.984 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2024-07-03T18:36:19.989Z,1720031779.989 [PitchRateCalculator] Loaded
2024-07-03T18:36:19.989Z,1720031779.989 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2024-07-03T18:36:19.999Z,1720031779.999 [SpeedCalculator] Loaded
2024-07-03T18:36:19.999Z,1720031779.999 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2024-07-03T18:36:20.004Z,1720031780.004 [YawRateCalculator] Loaded
2024-07-03T18:36:20.004Z,1720031780.004 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2024-07-03T18:36:20.022Z,1720031780.022 [ElevatorOffsetCalculator] Loaded
2024-07-03T18:36:20.022Z,1720031780.022 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2024-07-03T18:36:20.023Z,1720031780.023 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2024-07-03T18:36:20.023Z,1720031780.023 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2024-07-03T18:36:20.135Z,1720031780.135 [DeadReckonUsingMultipleVelocitySources] Loaded
2024-07-03T18:36:20.135Z,1720031780.135 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2024-07-03T18:36:20.148Z,1720031780.148 [NavChart] Loaded
2024-07-03T18:36:20.149Z,1720031780.149 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2024-07-03T18:36:20.154Z,1720031780.154 [UniversalFixResidualReporter] Loaded
2024-07-03T18:36:20.155Z,1720031780.155 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2024-07-03T18:36:20.155Z,1720031780.155 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2024-07-03T18:36:20.156Z,1720031780.156 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2024-07-03T18:36:20.562Z,1720031780.562 [BackseatComponent] Loaded
2024-07-03T18:36:20.562Z,1720031780.562 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread.
2024-07-03T18:36:20.563Z,1720031780.563 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 4090B4E0
2024-07-03T18:36:20.563Z,1720031780.563 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 895
2024-07-03T18:36:20.566Z,1720031780.566 [LcmUniversalReporter] Loaded
2024-07-03T18:36:20.567Z,1720031780.567 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread.
2024-07-03T18:36:20.573Z,1720031780.573 [BioacousticsDataBridge] Loaded
2024-07-03T18:36:20.573Z,1720031780.573 [ComponentRegistry](DEBUG): SyncComponent "BioacousticsDataBridge" handled in the control thread.
2024-07-03T18:36:21.402Z,1720031781.402 [BPC1] Loaded
2024-07-03T18:36:21.402Z,1720031781.402 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2024-07-03T18:36:21.474Z,1720031781.474 [DataOverHttps] Loaded
2024-07-03T18:36:21.474Z,1720031781.474 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2024-07-03T18:36:21.475Z,1720031781.475 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 4093B4E0
2024-07-03T18:36:21.476Z,1720031781.476 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 896
2024-07-03T18:36:21.499Z,1720031781.499 [Depth_Keller] Loaded
2024-07-03T18:36:21.499Z,1720031781.499 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2024-07-03T18:36:21.504Z,1720031781.504 [DropWeight] Loaded
2024-07-03T18:36:21.505Z,1720031781.505 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2024-07-03T18:36:21.569Z,1720031781.569 [NAL9602] Loaded
2024-07-03T18:36:21.569Z,1720031781.569 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2024-07-03T18:36:21.599Z,1720031781.599 [Onboard] Loaded
2024-07-03T18:36:21.600Z,1720031781.600 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2024-07-03T18:36:21.601Z,1720031781.601 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 4096B4E0
2024-07-03T18:36:21.601Z,1720031781.601 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 897
2024-07-03T18:36:21.615Z,1720031781.615 [Power24vConverter] Loaded
2024-07-03T18:36:21.616Z,1720031781.616 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2024-07-03T18:36:21.631Z,1720031781.631 [Radio_Surface] Loaded
2024-07-03T18:36:21.631Z,1720031781.631 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2024-07-03T18:36:21.632Z,1720031781.632 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 4099B4E0
2024-07-03T18:36:21.632Z,1720031781.632 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 898
2024-07-03T18:36:21.648Z,1720031781.648 [Sonardyne_Nano] Loaded
2024-07-03T18:36:21.648Z,1720031781.648 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread.
2024-07-03T18:36:21.649Z,1720031781.649 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2024-07-03T18:36:21.649Z,1720031781.649 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2024-07-03T18:36:21.704Z,1720031781.704 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2024-07-03T18:36:21.705Z,1720031781.705 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2024-07-03T18:36:21.870Z,1720031781.870 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2024-07-03T18:36:21.871Z,1720031781.871 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2024-07-03T18:36:21.897Z,1720031781.897 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2024-07-03T18:36:21.897Z,1720031781.897 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2024-07-03T18:36:22.070Z,1720031782.070 [CTD_Seabird] Loaded
2024-07-03T18:36:22.070Z,1720031782.070 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2024-07-03T18:36:22.071Z,1720031782.071 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40ADB4E0
2024-07-03T18:36:22.071Z,1720031782.071 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 899
2024-07-03T18:36:22.094Z,1720031782.094 [PAR_Licor] Loaded
2024-07-03T18:36:22.094Z,1720031782.094 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2024-07-03T18:36:22.139Z,1720031782.139 [WetLabsBB2FL] Loaded
2024-07-03T18:36:22.139Z,1720031782.139 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2024-07-03T18:36:22.140Z,1720031782.140 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40B0B4E0
2024-07-03T18:36:22.141Z,1720031782.141 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 900
2024-07-03T18:36:22.141Z,1720031782.141 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2024-07-03T18:36:22.142Z,1720031782.142 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2024-07-03T18:36:22.471Z,1720031782.471 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2024-07-03T18:36:22.472Z,1720031782.472 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2024-07-03T18:36:22.799Z,1720031782.799 [SBIT](DEBUG): Construct Startup Built In Test.
2024-07-03T18:36:22.809Z,1720031782.809 [SBIT] Loaded
2024-07-03T18:36:22.809Z,1720031782.809 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2024-07-03T18:36:22.812Z,1720031782.812 [IBIT](DEBUG): Construct Initiated Built In Test.
2024-07-03T18:36:22.825Z,1720031782.825 [IBIT] Loaded
2024-07-03T18:36:22.825Z,1720031782.825 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2024-07-03T18:36:22.865Z,1720031782.865 [CBIT](DEBUG): Construct Continuous Built In Test.
2024-07-03T18:36:23.013Z,1720031783.013 [CBIT] Loaded
2024-07-03T18:36:23.014Z,1720031783.014 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2024-07-03T18:36:23.014Z,1720031783.014 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2024-07-03T18:36:23.022Z,1720031783.022 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2024-07-03T18:36:23.025Z,1720031783.025 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2024-07-03T18:36:23.036Z,1720031783.036 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2024-07-03T18:36:23.037Z,1720031783.037 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C074E0
2024-07-03T18:36:23.038Z,1720031783.038 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 901
2024-07-03T18:36:23.042Z,1720031783.042 [Supervisor](INFO): Main Thread ID is 803
2024-07-03T18:36:23.042Z,1720031783.042 [Supervisor](DEBUG): Running supervisor.
2024-07-03T18:36:23.043Z,1720031783.043 [CommandExec ThreadHandler](INFO): Handler Thread ID is 902
2024-07-03T18:36:23.044Z,1720031783.044 [CommandExec](INFO): Initializing the command executive.
2024-07-03T18:36:23.045Z,1720031783.045 [CommandLine ThreadHandler](INFO): Handler Thread ID is 903
2024-07-03T18:36:23.048Z,1720031783.048 [controlThread ThreadHandler](INFO): Handler Thread ID is 904
2024-07-03T18:36:23.049Z,1720031783.049 [controlThread](DEBUG): Initializing ControlThread
2024-07-03T18:36:23.050Z,1720031783.050 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2024-07-03T18:36:23.051Z,1720031783.051 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2024-07-03T18:36:23.052Z,1720031783.052 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2024-07-03T18:36:23.052Z,1720031783.052 [LoopControl](DEBUG): Initialize LoopControlComponent.
2024-07-03T18:36:23.054Z,1720031783.054 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2024-07-03T18:36:23.054Z,1720031783.054 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2024-07-03T18:36:23.054Z,1720031783.054 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2024-07-03T18:36:23.055Z,1720031783.055 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2024-07-03T18:36:23.055Z,1720031783.055 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2024-07-03T18:36:23.056Z,1720031783.056 [NavChart](DEBUG): Initialize NavChart Navigation.
2024-07-03T18:36:23.056Z,1720031783.056 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2024-07-03T18:36:23.064Z,1720031783.064 [SBIT](INFO): Initialize SBIT Component.
2024-07-03T18:36:23.064Z,1720031783.064 [SBIT](IMPORTANT): git: 2024-06-03
2024-07-03T18:36:23.065Z,1720031783.065 [SBIT](INFO): git hash: 7fa19da3a148abf4baea4b65318d99ca26f8c915
2024-07-03T18:36:23.065Z,1720031783.065 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2024-07-03T18:36:23.066Z,1720031783.066 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #1 PREEMPT Tue Dec 18 21:19:28 PST 2018
Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021
2024-07-03T18:36:23.067Z,1720031783.067 [SBIT](INFO): Beginning SBIT in 20.000000 seconds.
2024-07-03T18:36:23.068Z,1720031783.068 [IBIT](INFO): Initialize IBIT Component.
2024-07-03T18:36:23.069Z,1720031783.069 [CBIT](DEBUG): Initialize CBIT Component.
2024-07-03T18:36:23.069Z,1720031783.069 [logger ThreadHandler](INFO): Handler Thread ID is 905
2024-07-03T18:36:23.080Z,1720031783.080 [CBIT](DEBUG): Initialized mux pins.
2024-07-03T18:36:23.080Z,1720031783.080 [CBIT](DEBUG): Initializing the watchdog timer.
2024-07-03T18:36:23.088Z,1720031783.088 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 906
2024-07-03T18:36:23.100Z,1720031783.100 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 907
2024-07-03T18:36:23.102Z,1720031783.102 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2024-07-03T18:36:23.104Z,1720031783.104 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2024-07-03T18:36:23.104Z,1720031783.104 [CBIT](DEBUG): Initializing heartbeat.
2024-07-03T18:36:23.118Z,1720031783.118 [Onboard ThreadHandler](INFO): Handler Thread ID is 908
2024-07-03T18:36:23.137Z,1720031783.137 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 909
2024-07-03T18:36:23.156Z,1720031783.156 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 910
2024-07-03T18:36:23.157Z,1720031783.157 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2024-07-03T18:36:23.161Z,1720031783.161 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 912
2024-07-03T18:36:23.164Z,1720031783.164 [WetLabsBB2FL](INFO): Powering up
2024-07-03T18:36:23.165Z,1720031783.165 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 914
2024-07-03T18:36:23.168Z,1720031783.168 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2024-07-03T18:36:23.168Z,1720031783.168 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2024-07-03T18:36:23.168Z,1720031783.168 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2024-07-03T18:36:23.168Z,1720031783.168 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2024-07-03T18:36:23.168Z,1720031783.168 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2024-07-03T18:36:23.168Z,1720031783.168 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2024-07-03T18:36:23.169Z,1720031783.169 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2024-07-03T18:36:23.169Z,1720031783.169 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2024-07-03T18:36:23.176Z,1720031783.176 [CBIT](DEBUG): Deactivating GF circuits.
2024-07-03T18:36:23.176Z,1720031783.176 [CBIT](DEBUG): Deactivating emergency mode.
2024-07-03T18:36:23.216Z,1720031783.216 [CBIT](DEBUG): Backplane powered.
2024-07-03T18:36:23.216Z,1720031783.216 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser
2024-07-03T18:36:23.217Z,1720031783.217 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl
2024-07-03T18:36:23.217Z,1720031783.217 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl
2024-07-03T18:36:23.218Z,1720031783.218 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl
2024-07-03T18:36:23.262Z,1720031783.262 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into:
2024-07-03T18:36:23.267Z,1720031783.267 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2024-07-03T18:36:23.306Z,1720031783.306 [MissionManager](DEBUG):
# Copyright (c) 2024 MBARI
# MBARI Proprietary Information. Confidential. All Rights Reserved
# Unauthorized copying or distribution of this file via any medium is strictly
# prohibited.
#
# WARNING - This file contains information whose export is restricted by the
# Export Administration Act of 1979 (Title 50, U.S.C., App. 2401 et seq.), as
# amended. Violations of these export laws are subject to severe civil and/or
# criminal penalties.
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-07-03T18:36:23.307Z,1720031783.307 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl
2024-07-03T18:36:23.307Z,1720031783.307 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl
2024-07-03T18:36:23.324Z,1720031783.324 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl
2024-07-03T18:36:23.544Z,1720031783.544 [Radio_Surface](INFO): Powering up
2024-07-03T18:36:23.627Z,1720031783.627 [MissionManager](DEBUG): TethyslAPI: Missions/Default.tl translated into:
0
13
Burn on
Dropped weight due to communications timeout.
5
Default mission has been running for
Restarting logs and Default mission.
restart logs
2024-07-03T18:36:23.677Z,1720031783.677 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2024-07-03T18:36:23.679Z,1720031783.679 [Default:A.Wait](DEBUG): Construct Wait.
2024-07-03T18:36:23.681Z,1720031783.681 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2024-07-03T18:36:23.722Z,1720031783.722 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2024-07-03T18:36:23.737Z,1720031783.737 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2024-07-03T18:36:23.743Z,1720031783.743 [Default:E.Execute](DEBUG): Construct Execute.
2024-07-03T18:36:23.762Z,1720031783.762 [MissionManager](DEBUG):
# Copyright (c) 2024 MBARI
# MBARI Proprietary Information. Confidential. All Rights Reserved
# Unauthorized copying or distribution of this file via any medium is strictly
# prohibited.
#
# WARNING - This file contains information whose export is restricted by the
# Export Administration Act of 1979 (Title 50, U.S.C., App. 2401 et seq.), as
# amended. Violations of these export laws are subject to severe civil and/or
# criminal penalties.
mission Default {
arguments {
ElapsedSinceDefaultStarted = 0 minute
}
behavior Guidance:Wait {
"""
Wait a moment to see if the scheduler starts a new mission before
starting to actually run Default.
"""
run in sequence
set duration = 13 second
}
behavior Guidance:GoToSurface {
run in progression
}
aggregate CheckIn {
run in sequence repeat=288
readDatum id="Read_GPS" {
timeout duration=P5M
Universal:time_fix
}
readDatum id="Read_Iridium" {
timeout duration=P4H {
behavior Guidance:Execute {
run in sequence
set command = "Burn on"
}
syslog critical "Dropped weight due to communications timeout."
}
Universal:platform_communications
}
behavior Guidance:Wait {
run in sequence
set duration = 5 minute
}
assign in sequence ElapsedSinceDefaultStarted = elapsed ( Universal:mission_started )
syslog important "Default mission has been running for " + ElapsedSinceDefaultStarted~minute
}
syslog important "Restarting logs and Default mission."
behavior Guidance:Execute {
run in sequence
set command = "restart logs"
}
}
2024-07-03T18:36:23.766Z,1720031783.766 [controlThread](DEBUG): Component order: CycleStarter,BioacousticsDataBridge,BPC1,Depth_Keller,DropWeight,NAL9602,Power24vConverter,Sonardyne_Nano,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter,
2024-07-03T18:36:23.822Z,1720031783.822 [Power24vConverter](INFO): Powering up.
2024-07-03T18:36:23.823Z,1720031783.823 [Sonardyne_Nano](INFO): Initializing.
2024-07-03T18:36:23.861Z,1720031783.861 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2024-07-03T18:36:23.868Z,1720031783.868 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2024-07-03T18:36:23.869Z,1720031783.869 [ElevatorServo](DEBUG): Initializing EZServoServo.
2024-07-03T18:36:23.876Z,1720031783.876 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2024-07-03T18:36:23.877Z,1720031783.877 [MassServo](DEBUG): Initializing EZServoServo.
2024-07-03T18:36:23.884Z,1720031783.884 [MassServo](DEBUG): Initializing MassServo.
2024-07-03T18:36:23.885Z,1720031783.885 [RudderServo](DEBUG): Initializing EZServoServo.
2024-07-03T18:36:23.892Z,1720031783.892 [RudderServo](DEBUG): Initializing RudderServo.
2024-07-03T18:36:23.893Z,1720031783.893 [ThrusterHE](DEBUG): Initializing EZServoServo.
2024-07-03T18:36:23.900Z,1720031783.900 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2024-07-03T18:36:24.205Z,1720031784.205 [DropWeight](CRITICAL): DROP WEIGHT MISSING.
2024-07-03T18:36:24.205Z,1720031784.205 [DropWeight] Hardware Fault, FailCount= 1
2024-07-03T18:36:24.205Z,1720031784.205 [DropWeight](ERROR): Hardware Fault
2024-07-03T18:36:24.242Z,1720031784.242 [CommandExec](FAULT): Scheduling is paused
2024-07-03T18:36:24.243Z,1720031784.243 [CBIT](INFO): Critical error at 20240703T183624
2024-07-03T18:36:24.243Z,1720031784.243 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2024-07-03T18:36:24.253Z,1720031784.253 [CBIT](ERROR): Hardware Fault in component: DropWeight
2024-07-03T18:36:24.254Z,1720031784.254 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2024-07-03T18:36:24.600Z,1720031784.600 [CBIT](INFO): Critical error at 20240703T183624
2024-07-03T18:36:25.300Z,1720031785.300 [WetLabsBB2FL](INFO): Powering down
2024-07-03T18:36:25.794Z,1720031785.794 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART
2024-07-03T18:36:28.220Z,1720031788.220 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2107
2024-07-03T18:36:29.728Z,1720031789.728 [ThrusterHE](ERROR): Zero Speed Commanded.
2024-07-03T18:36:33.177Z,1720031793.177 [CBIT](CRITICAL): Environmental Failure. Press:14.810154 PSI. Humidity:41%. Temp:27 C. ABORTING MISSION
2024-07-03T18:36:33.487Z,1720031793.487 [CBIT](INFO): Critical error at 20240703T183633
2024-07-03T18:36:36.593Z,1720031796.593 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004245
2024-07-03T18:36:43.590Z,1720031803.590 [SBIT](IMPORTANT): Beginning Startup BIT
2024-07-03T18:36:43.598Z,1720031803.598 [CBIT](IMPORTANT): Beginning ground fault scan
2024-07-03T18:36:51.649Z,1720031811.649 [NAL9602](INFO): Powering up NAL9602
2024-07-03T18:36:54.524Z,1720031814.524 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.006506
CHAN A1 (24V): -0.007206
CHAN A2 (12V): -0.004681
CHAN A3 (5V): -0.003028
CHAN B0 (3.3V): -0.001128
CHAN B1 (3.15aV): -0.001196
CHAN B2 (3.15bV): -0.001470
CHAN B3 (GND): -0.000007
OPEN: 0.003254
Full Scale: +/- 1 mA
2024-07-03T18:37:02.557Z,1720031822.557 [NAL9602](INFO): NAL9602 initialized
2024-07-03T18:37:20.340Z,1720031840.340 [NAL9602](INFO): SBD MO Status=0, MOMSN=5055, MT Status=0, MTMSN=0
2024-07-03T18:37:20.340Z,1720031840.340 [NAL9602](INFO): No messages in MT queue
2024-07-03T18:37:32.863Z,1720031852.863 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,183731.00,A,3648.16245,N,12147.28538,W,0.214,224.62,030724,,,A*7E
2024-07-03T18:37:32.902Z,1720031852.902 [NAL9602](INFO): GPS fix at 20240703T183731: (36.802707, -121.788090)
2024-07-03T18:37:37.733Z,1720031857.733 [SBIT](IMPORTANT): SBIT PASSED
2024-07-03T18:37:37.733Z,1720031857.733 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2024-07-03T18:37:37.734Z,1720031857.734 [SBIT](IMPORTANT): AHRS_M2.loadAtStartup=0 bool;
2024-07-03T18:37:37.734Z,1720031857.734 [SBIT](IMPORTANT): BPC1.batteryMissingStickThreshold=6 count;
2024-07-03T18:37:37.734Z,1720031857.734 [SBIT](IMPORTANT): DAT.loadAtStartup=0 bool;
2024-07-03T18:37:38.125Z,1720031858.125 [MissionManager](IMPORTANT): Started mission Startup
2024-07-03T18:37:38.125Z,1720031858.125 [Startup] Running Loop=1
2024-07-03T18:37:38.125Z,1720031858.125 [Startup](DEBUG): Aggregate::initialize Startup
2024-07-03T18:37:38.125Z,1720031858.125 [Startup:A.GoToSurface] Running Loop=1
2024-07-03T18:37:38.125Z,1720031858.125 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2024-07-03T18:37:38.126Z,1720031858.126 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2024-07-03T18:37:38.126Z,1720031858.126 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2024-07-03T18:37:38.127Z,1720031858.127 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2024-07-03T18:37:38.127Z,1720031858.127 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2024-07-03T18:37:38.127Z,1720031858.127 [Startup:A.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2024-07-03T18:37:38.128Z,1720031858.128 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2024-07-03T18:37:38.129Z,1720031858.129 [Startup:StartupSatComms] Running Loop=1
2024-07-03T18:37:38.129Z,1720031858.129 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2024-07-03T18:37:38.130Z,1720031858.130 [Startup:StartupSatComms:A] Running Loop=1
2024-07-03T18:37:38.529Z,1720031858.529 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2024-07-03T18:37:44.583Z,1720031864.583 [BPC1](ERROR): BPC1B: No match for serial number FFFF in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2024-07-03T18:37:45.796Z,1720031865.796 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,183744.00,A,3648.16676,N,12147.28269,W,0.758,217.57,030724,,,A*70
2024-07-03T18:37:45.798Z,1720031865.798 [NAL9602](INFO): GPS fix at 20240703T183744: (36.802779, -121.788045)
2024-07-03T18:37:45.807Z,1720031865.807 [Startup:StartupSatComms:A] Stopped
2024-07-03T18:37:45.807Z,1720031865.807 [Startup:StartupSatComms:B] Running Loop=1
2024-07-03T18:37:46.223Z,1720031866.223 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2024-07-03T18:37:55.421Z,1720031875.421 [DataOverHttps](INFO): Sending 168 bytes from file Logs/20240703T001319/Courier0007.lzma
2024-07-03T18:37:56.425Z,1720031876.425 [DataOverHttps](INFO): Moved sent file to Logs/20240703T001319/Courier0007.lzma.bak
2024-07-03T18:37:56.426Z,1720031876.426 [DataOverHttps](INFO): SBD MOMSN=21321398
2024-07-03T18:38:14.284Z,1720031894.284 [DataOverHttps](INFO): Sending 438 bytes from file Logs/20240703T183612/Courier0000.lzma
2024-07-03T18:38:15.285Z,1720031895.285 [DataOverHttps](INFO): Moved sent file to Logs/20240703T183612/Courier0000.lzma.bak
2024-07-03T18:38:15.286Z,1720031895.286 [DataOverHttps](INFO): SBD MOMSN=21321400
2024-07-03T18:38:18.508Z,1720031898.508 [NAL9602](INFO): Not Powering down - fast GPS
2024-07-03T18:38:23.374Z,1720031903.374 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2024-07-03T18:38:23.374Z,1720031903.374 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2024-07-03T18:38:23.374Z,1720031903.374 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-07-03T18:38:23.401Z,1720031903.401 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-07-03T18:38:23.796Z,1720031903.796 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-07-03T18:38:23.796Z,1720031903.796 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2024-07-03T18:38:28.877Z,1720031908.877 [DataOverHttps](IMPORTANT): SBD MTMSN=20240703T183828
2024-07-03T18:38:36.025Z,1720031916.025 [DataOverHttps](INFO): Sending 328 bytes from file Logs/20240703T001319/Express0008.lzma
2024-07-03T18:38:36.028Z,1720031916.028 [DataOverHttps](INFO): Received command: ibit
2024-07-03T18:38:36.061Z,1720031916.061 [CommandExec](IMPORTANT): got command ibit
2024-07-03T18:38:36.319Z,1720031916.319 [IBIT](IMPORTANT): Beginning Initiated BIT
2024-07-03T18:38:36.319Z,1720031916.319 [IBIT](IMPORTANT): Beginning control surface checks.
2024-07-03T18:38:36.322Z,1720031916.322 [CBIT](IMPORTANT): Beginning ground fault scan
2024-07-03T18:38:37.326Z,1720031917.326 [DataOverHttps](INFO): Moved sent file to Logs/20240703T001319/Express0008.lzma.bak
2024-07-03T18:38:37.326Z,1720031917.326 [DataOverHttps](INFO): SBD MOMSN=21321408
2024-07-03T18:38:37.918Z,1720031917.918 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,183836.00,A,3648.16675,N,12147.28659,W,0.019,208.44,030724,,,A*70
2024-07-03T18:38:37.926Z,1720031917.926 [NAL9602](INFO): GPS fix at 20240703T183836: (36.802779, -121.788110)
2024-07-03T18:38:44.366Z,1720031924.366 [NAL9602](INFO): SBD MO Status=0, MOMSN=5056, MT Status=0, MTMSN=0
2024-07-03T18:38:44.366Z,1720031924.366 [NAL9602](INFO): No messages in MT queue
2024-07-03T18:38:45.578Z,1720031925.578 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,183843.00,A,3648.16667,N,12147.28712,W,0.097,208.44,030724,,,A*79
2024-07-03T18:38:45.581Z,1720031925.581 [NAL9602](INFO): GPS fix at 20240703T183843: (36.802778, -121.788119)
2024-07-03T18:38:47.220Z,1720031927.220 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.005782
CHAN A1 (24V): -0.006625
CHAN A2 (12V): -0.004201
CHAN A3 (5V): -0.002599
CHAN B0 (3.3V): -0.001475
CHAN B1 (3.15aV): -0.001122
CHAN B2 (3.15bV): -0.001535
CHAN B3 (GND): -0.000023
OPEN: 0.003619
Full Scale: +/- 1 mA
2024-07-03T18:38:48.007Z,1720031928.007 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,183846.00,A,3648.16625,N,12147.28740,W,0.233,208.44,030724,,,A*71
2024-07-03T18:38:48.009Z,1720031928.009 [NAL9602](INFO): GPS fix at 20240703T183846: (36.802771, -121.788123)
2024-07-03T18:38:50.838Z,1720031930.838 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,183849.00,A,3648.16692,N,12147.28734,W,0.136,208.44,030724,,,A*77
2024-07-03T18:38:50.857Z,1720031930.857 [NAL9602](INFO): GPS fix at 20240703T183849: (36.802782, -121.788122)
2024-07-03T18:38:53.671Z,1720031933.671 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,183851.00,A,3648.16739,N,12147.28727,W,0.039,208.44,030724,,,A*72
2024-07-03T18:38:53.673Z,1720031933.673 [NAL9602](INFO): GPS fix at 20240703T183851: (36.802790, -121.788121)
2024-07-03T18:38:55.272Z,1720031935.272 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240703T183612/Courier0004.lzma
2024-07-03T18:38:56.273Z,1720031936.273 [DataOverHttps](INFO): Moved sent file to Logs/20240703T183612/Courier0004.lzma.bak
2024-07-03T18:38:56.274Z,1720031936.274 [DataOverHttps](INFO): SBD MOMSN=21321420
2024-07-03T18:38:56.895Z,1720031936.895 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,183855.00,A,3648.16772,N,12147.28732,W,0.058,208.44,030724,,,A*7A
2024-07-03T18:38:56.897Z,1720031936.897 [NAL9602](INFO): GPS fix at 20240703T183855: (36.802795, -121.788122)
2024-07-03T18:38:59.718Z,1720031939.718 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,183858.00,A,3648.16765,N,12147.28736,W,0.156,208.44,030724,,,A*7A
2024-07-03T18:38:59.721Z,1720031939.721 [NAL9602](INFO): GPS fix at 20240703T183858: (36.802794, -121.788123)
2024-07-03T18:39:02.950Z,1720031942.950 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,183901.00,A,3648.16791,N,12147.28728,W,0.058,208.44,030724,,,A*7C
2024-07-03T18:39:02.953Z,1720031942.953 [NAL9602](INFO): GPS fix at 20240703T183901: (36.802799, -121.788121)
2024-07-03T18:39:05.778Z,1720031945.778 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,183904.00,A,3648.16824,N,12147.28720,W,0.039,208.44,030724,,,A*77
2024-07-03T18:39:05.780Z,1720031945.780 [NAL9602](INFO): GPS fix at 20240703T183904: (36.802804, -121.788120)
2024-07-03T18:39:09.014Z,1720031949.014 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,183907.00,A,3648.16864,N,12147.28710,W,0.058,208.44,030724,,,A*74
2024-07-03T18:39:09.016Z,1720031949.016 [NAL9602](INFO): GPS fix at 20240703T183907: (36.802811, -121.788118)
2024-07-03T18:39:11.842Z,1720031951.842 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,183910.00,A,3648.16921,N,12147.28691,W,0.117,208.44,030724,,,A*70
2024-07-03T18:39:11.845Z,1720031951.845 [NAL9602](INFO): GPS fix at 20240703T183910: (36.802820, -121.788115)
2024-07-03T18:39:15.070Z,1720031955.070 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,183913.00,A,3648.17032,N,12147.28661,W,0.019,208.44,030724,,,A*79
2024-07-03T18:39:15.073Z,1720031955.073 [NAL9602](INFO): GPS fix at 20240703T183913: (36.802839, -121.788110)
2024-07-03T18:39:16.796Z,1720031956.796 [DataOverHttps](INFO): Sending 796 bytes from file Logs/20240703T183612/Express0001.lzma
2024-07-03T18:39:17.091Z,1720031957.091 [BPC1](ERROR): BPC1B: No match for serial number 1717 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2024-07-03T18:39:17.798Z,1720031957.798 [DataOverHttps](INFO): Moved sent file to Logs/20240703T183612/Express0001.lzma.bak
2024-07-03T18:39:17.798Z,1720031957.798 [DataOverHttps](INFO): SBD MOMSN=21321423
2024-07-03T18:39:17.918Z,1720031957.918 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,183916.00,A,3648.17167,N,12147.28620,W,0.078,208.44,030724,,,A*7F
2024-07-03T18:39:17.921Z,1720031957.921 [NAL9602](INFO): GPS fix at 20240703T183916: (36.802861, -121.788103)
2024-07-03T18:39:20.739Z,1720031960.739 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,183919.00,A,3648.17300,N,12147.28584,W,0.097,208.44,030724,,,A*7F
2024-07-03T18:39:20.741Z,1720031960.741 [NAL9602](INFO): GPS fix at 20240703T183919: (36.802883, -121.788097)
2024-07-03T18:39:22.824Z,1720031962.824 [IBIT](IMPORTANT): Communications Status:
Fix Status: 1
Iridium Signal Strength: 4
Latitude: 36.802883 Longitude: -121.788094
2024-07-03T18:39:23.183Z,1720031963.183 [IBIT](FAULT): Warning: Battery Data not active. Expected only when running primaries. Threshold checking not active.
2024-07-03T18:39:23.588Z,1720031963.588 [IBIT](IMPORTANT): bitHumidityThreshold: 55.000000 %
2024-07-03T18:39:23.588Z,1720031963.588 [IBIT](IMPORTANT): bitPressureThreshold: 0.750000 psi
2024-07-03T18:39:23.588Z,1720031963.588 [IBIT](ERROR): Pressure failed. Onboard reading:14.773376 PSI
2024-07-03T18:39:23.589Z,1720031963.589 [IBIT](IMPORTANT): Humidity:37.150532 %
2024-07-03T18:39:23.974Z,1720031963.974 [IBIT](FAULT): Unable to read vehicle orientation values from AHRS
2024-07-03T18:39:24.377Z,1720031964.377 [IBIT](IMPORTANT): surfaceThreshold: 1.000000 m
2024-07-03T18:39:24.378Z,1720031964.378 [IBIT](IMPORTANT): buoyancyNeutral: 200.000000 cc
2024-07-03T18:39:24.378Z,1720031964.378 [IBIT](IMPORTANT): massDefault: 0.000000 cm
2024-07-03T18:39:24.378Z,1720031964.378 [IBIT](IMPORTANT): stopDepth: 275.000000 m
2024-07-03T18:39:24.378Z,1720031964.378 [IBIT](IMPORTANT): abortDepth: 300.000000 m
2024-07-03T18:39:24.378Z,1720031964.378 [IBIT](IMPORTANT): IBIT FAILED
2024-07-03T18:39:24.788Z,1720031964.788 [Startup:StartupSatComms:B](INFO): Timed out from 2024-07-03T18:37:45.8Z
2024-07-03T18:39:24.788Z,1720031964.788 [Startup:StartupSatComms:B] Stopped
2024-07-03T18:39:24.788Z,1720031964.788 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2024-07-03T18:39:24.788Z,1720031964.788 [Startup:StartupSatComms] Stopped
2024-07-03T18:39:24.788Z,1720031964.788 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2024-07-03T18:39:24.789Z,1720031964.789 [Startup](INFO): Completed Startup
2024-07-03T18:39:24.789Z,1720031964.789 [MissionManager](INFO): Startup is completed.
2024-07-03T18:39:24.790Z,1720031964.790 [MissionManager](INFO): Uninitializing Mission Startup
2024-07-03T18:39:24.790Z,1720031964.790 [Startup] Stopped
2024-07-03T18:39:24.790Z,1720031964.790 [Startup](DEBUG): Aggregate::uninitialize Startup
2024-07-03T18:39:24.790Z,1720031964.790 [Startup:A.GoToSurface] Stopped
2024-07-03T18:39:24.790Z,1720031964.790 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2024-07-03T18:39:25.177Z,1720031965.177 [MissionManager](IMPORTANT): Started mission Default
2024-07-03T18:39:25.177Z,1720031965.177 [Default] Running Loop=1
2024-07-03T18:39:25.177Z,1720031965.177 [Default](DEBUG): Aggregate::initialize Default
2024-07-03T18:39:25.177Z,1720031965.177 [Default:B.GoToSurface] Running Loop=1
2024-07-03T18:39:25.177Z,1720031965.177 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2024-07-03T18:39:25.177Z,1720031965.177 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2024-07-03T18:39:25.178Z,1720031965.178 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2024-07-03T18:39:25.178Z,1720031965.178 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2024-07-03T18:39:25.178Z,1720031965.178 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2024-07-03T18:39:25.178Z,1720031965.178 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2024-07-03T18:39:25.179Z,1720031965.179 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2024-07-03T18:39:25.179Z,1720031965.179 [Default:A.Wait] Running Loop=1
2024-07-03T18:39:25.179Z,1720031965.179 [Default:A.Wait](DEBUG): Initialize Wait Component.
2024-07-03T18:39:38.522Z,1720031978.522 [Default:A.Wait](INFO): Done Waiting.
2024-07-03T18:39:38.523Z,1720031978.523 [Default:A.Wait] Stopped
2024-07-03T18:39:38.523Z,1720031978.523 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2024-07-03T18:39:38.918Z,1720031978.918 [Default:CheckIn] Running Loop=1
2024-07-03T18:39:38.918Z,1720031978.918 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-07-03T18:39:38.918Z,1720031978.918 [Default:CheckIn:Read_GPS] Running Loop=1
2024-07-03T18:39:39.322Z,1720031979.322 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2024-07-03T18:39:40.268Z,1720031980.268 [DataOverHttps](INFO): Sending 423 bytes from file Logs/20240703T183612/Express0005.lzma
2024-07-03T18:39:40.942Z,1720031980.942 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,183939.00,A,3648.17647,N,12147.28482,W,0.136,208.44,030724,,,A*76
2024-07-03T18:39:40.945Z,1720031980.945 [NAL9602](INFO): GPS fix at 20240703T183939: (36.802941, -121.788080)
2024-07-03T18:39:40.986Z,1720031980.986 [Default:CheckIn:Read_GPS] Stopped
2024-07-03T18:39:40.986Z,1720031980.986 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-07-03T18:39:41.269Z,1720031981.269 [DataOverHttps](INFO): Moved sent file to Logs/20240703T183612/Express0005.lzma.bak
2024-07-03T18:39:41.269Z,1720031981.269 [DataOverHttps](INFO): SBD MOMSN=21321440
2024-07-03T18:39:41.363Z,1720031981.363 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2024-07-03T18:39:59.007Z,1720031999.007 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20240703T183612/Courier0007.lzma
2024-07-03T18:40:00.009Z,1720032000.009 [DataOverHttps](INFO): Moved sent file to Logs/20240703T183612/Courier0007.lzma.bak
2024-07-03T18:40:00.009Z,1720032000.009 [DataOverHttps](INFO): SBD MOMSN=21321448
2024-07-03T18:40:13.402Z,1720032013.402 [NAL9602](INFO): Not Powering down - fast GPS
2024-07-03T18:40:20.038Z,1720032020.038 [DataOverHttps](INFO): Sending 622 bytes from file Logs/20240703T183612/Express0008.lzma
2024-07-03T18:40:21.037Z,1720032021.037 [DataOverHttps](INFO): Moved sent file to Logs/20240703T183612/Express0008.lzma.bak
2024-07-03T18:40:21.038Z,1720032021.038 [DataOverHttps](INFO): SBD MOMSN=21321451
2024-07-03T18:40:24.588Z,1720032024.588 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2024-07-03T18:40:24.588Z,1720032024.588 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2024-07-03T18:40:24.588Z,1720032024.588 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-07-03T18:40:24.616Z,1720032024.616 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-07-03T18:40:25.010Z,1720032025.010 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-07-03T18:40:25.011Z,1720032025.011 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2024-07-03T18:40:27.018Z,1720032027.018 [Default:CheckIn:Read_Iridium] Stopped
2024-07-03T18:40:27.018Z,1720032027.018 [Default:CheckIn:C.Wait] Running Loop=1
2024-07-03T18:40:27.018Z,1720032027.018 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-07-03T18:41:18.285Z,1720032078.285 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-07-03T18:41:19.957Z,1720032079.957 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-07-03T18:41:25.154Z,1720032085.154 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-07-03T18:41:26.769Z,1720032086.769 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2024-07-03T18:41:40.505Z,1720032100.505 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-07-03T18:41:45.353Z,1720032105.353 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2024-07-03T18:41:51.817Z,1720032111.817 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2024-07-03T18:41:55.858Z,1720032115.858 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-07-03T18:42:06.765Z,1720032126.765 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2024-07-03T18:42:10.805Z,1720032130.805 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-07-03T18:42:22.521Z,1720032142.521 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2024-07-03T18:42:25.803Z,1720032145.803 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2024-07-03T18:42:25.803Z,1720032145.803 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2024-07-03T18:42:25.803Z,1720032145.803 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-07-03T18:42:25.847Z,1720032145.847 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-07-03T18:42:26.158Z,1720032146.158 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-07-03T18:42:26.212Z,1720032146.212 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-07-03T18:42:26.212Z,1720032146.212 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2024-07-03T18:42:37.873Z,1720032157.873 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2024-07-03T18:42:41.509Z,1720032161.509 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-07-03T18:42:53.225Z,1720032173.225 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2024-07-03T18:42:57.669Z,1720032177.669 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-07-03T18:43:08.981Z,1720032188.981 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2024-07-03T18:43:13.021Z,1720032193.021 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-07-03T18:43:23.929Z,1720032203.929 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2024-07-03T18:43:27.969Z,1720032207.969 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-07-03T18:43:39.281Z,1720032219.281 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7).
2024-07-03T18:43:45.752Z,1720032225.752 [BPC1](INFO): Calculating totals. Valid battery stick count: 53. Valid reserve battery stick count: 5.
2024-07-03T18:43:45.756Z,1720032225.756 [BPC1](INFO): Received data from all battery sticks.
2024-07-03T18:44:26.967Z,1720032266.967 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2024-07-03T18:44:26.967Z,1720032266.967 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2024-07-03T18:44:26.967Z,1720032266.967 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-07-03T18:44:26.979Z,1720032266.979 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-07-03T18:44:27.391Z,1720032267.391 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-07-03T18:44:27.391Z,1720032267.391 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2024-07-03T18:45:27.568Z,1720032327.568 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-07-03T18:45:27.568Z,1720032327.568 [Default:CheckIn:C.Wait] Stopped
2024-07-03T18:45:27.568Z,1720032327.568 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-07-03T18:45:27.568Z,1720032327.568 [Default:CheckIn:D] Running Loop=1
2024-07-03T18:45:27.974Z,1720032327.974 [Default:CheckIn:D] Stopped
2024-07-03T18:45:27.974Z,1720032327.974 [Default:CheckIn:E] Running Loop=1
2024-07-03T18:45:28.377Z,1720032328.377 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 6.046615 min
2024-07-03T18:45:28.377Z,1720032328.377 [Default:CheckIn:E] Stopped
2024-07-03T18:45:28.377Z,1720032328.377 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-07-03T18:45:28.377Z,1720032328.377 [Default:CheckIn] Stopped
2024-07-03T18:45:28.377Z,1720032328.377 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-07-03T18:45:28.378Z,1720032328.378 [Default:CheckIn](INFO): Running loop #2
2024-07-03T18:45:28.378Z,1720032328.378 [Default:CheckIn] Running Loop=2
2024-07-03T18:45:28.378Z,1720032328.378 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-07-03T18:45:28.378Z,1720032328.378 [Default:CheckIn:Read_GPS] Running Loop=1
2024-07-03T18:46:24.938Z,1720032384.938 [Power24vConverter](INFO): Powering down.
2024-07-03T18:46:28.166Z,1720032388.166 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2024-07-03T18:46:28.166Z,1720032388.166 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2024-07-03T18:46:28.166Z,1720032388.166 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-07-03T18:46:28.214Z,1720032388.214 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-07-03T18:46:28.581Z,1720032388.581 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-07-03T18:46:28.581Z,1720032388.581 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2024-07-03T18:48:29.366Z,1720032509.366 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2024-07-03T18:48:29.366Z,1720032509.366 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5
2024-07-03T18:48:29.366Z,1720032509.366 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-07-03T18:48:29.378Z,1720032509.378 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-07-03T18:48:29.797Z,1720032509.797 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-07-03T18:48:29.797Z,1720032509.797 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5
2024-07-03T18:50:28.549Z,1720032628.549 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-07-03T18:45:28.4Z
2024-07-03T18:50:28.549Z,1720032628.549 [Default:CheckIn:Read_GPS] Stopped
2024-07-03T18:50:28.549Z,1720032628.549 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-07-03T18:50:30.579Z,1720032630.579 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2024-07-03T18:50:30.584Z,1720032630.584 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6
2024-07-03T18:50:30.584Z,1720032630.584 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-07-03T18:50:30.636Z,1720032630.636 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-07-03T18:50:31.022Z,1720032631.022 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-07-03T18:50:31.022Z,1720032631.022 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6
2024-07-03T18:50:32.176Z,1720032632.176 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2024-07-03T18:50:37.555Z,1720032637.555 [DataOverHttps](INFO): Sending 168 bytes from file Logs/20240703T183612/Courier0010.lzma
2024-07-03T18:50:38.557Z,1720032638.557 [DataOverHttps](INFO): Moved sent file to Logs/20240703T183612/Courier0010.lzma.bak
2024-07-03T18:50:38.558Z,1720032638.558 [DataOverHttps](INFO): SBD MOMSN=21321492
2024-07-03T18:50:58.164Z,1720032658.164 [DataOverHttps](INFO): Sending 240 bytes from file Logs/20240703T183612/Express0011.lzma
2024-07-03T18:50:59.165Z,1720032659.165 [DataOverHttps](INFO): Moved sent file to Logs/20240703T183612/Express0011.lzma.bak
2024-07-03T18:50:59.165Z,1720032659.165 [DataOverHttps](INFO): SBD MOMSN=21321494
2024-07-03T18:51:02.876Z,1720032662.876 [NAL9602](INFO): Not Powering down - fast GPS
2024-07-03T18:51:06.548Z,1720032666.548 [Default:CheckIn:Read_Iridium] Stopped
2024-07-03T18:51:06.548Z,1720032666.548 [Default:CheckIn:C.Wait] Running Loop=1
2024-07-03T18:51:06.548Z,1720032666.548 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-07-03T18:51:24.323Z,1720032684.323 [CBIT](INFO): Clearing failed state for component DropWeight
2024-07-03T18:51:24.323Z,1720032684.323 [DropWeight] No Fault, FailCount= 1
2024-07-03T18:52:31.779Z,1720032751.779 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2024-07-03T18:52:31.779Z,1720032751.779 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7
2024-07-03T18:52:31.779Z,1720032751.779 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-07-03T18:52:31.791Z,1720032751.791 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-07-03T18:52:32.208Z,1720032752.208 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-07-03T18:52:32.208Z,1720032752.208 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7
2024-07-03T18:52:46.260Z,1720032766.260 [CommandExec](IMPORTANT): got command quit
2024-07-03T18:52:47.264Z,1720032767.264 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread.
2024-07-03T18:52:47.264Z,1720032767.264 [CommandExec](INFO): Uninitializing the command executive.
2024-07-03T18:52:47.264Z,1720032767.264 [CommandExec](INFO): Uninitializing the command scheduler.
2024-07-03T18:52:47.264Z,1720032767.264 [CommandExec ThreadHandler](INFO): Thread cancelled.
2024-07-03T18:52:47.399Z,1720032767.399 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye!
2024-07-03T18:52:47.400Z,1720032767.400 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2024-07-03T18:52:47.400Z,1720032767.400 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2024-07-03T18:52:47.400Z,1720032767.400 [NavChartDb](INFO): Join timeout helper Thread ID is 937
2024-07-03T18:52:47.664Z,1720032767.664 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2024-07-03T18:52:47.664Z,1720032767.664 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2024-07-03T18:52:47.679Z,1720032767.679 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2024-07-03T18:52:47.680Z,1720032767.680 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2024-07-03T18:52:47.680Z,1720032767.680 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 938
2024-07-03T18:52:47.908Z,1720032767.908 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2024-07-03T18:52:47.908Z,1720032767.908 [WetLabsBB2FL](INFO): Powering down
2024-07-03T18:52:47.909Z,1720032767.909 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2024-07-03T18:52:47.916Z,1720032767.916 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2024-07-03T18:52:47.916Z,1720032767.916 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2024-07-03T18:52:47.916Z,1720032767.916 [CTD_Seabird](INFO): Join timeout helper Thread ID is 939
2024-07-03T18:52:48.280Z,1720032768.280 [CTD_Seabird](INFO): Powering down
2024-07-03T18:52:48.292Z,1720032768.292 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2024-07-03T18:52:48.292Z,1720032768.292 [CTD_Seabird](INFO): Powering down
2024-07-03T18:52:48.303Z,1720032768.303 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2024-07-03T18:52:48.304Z,1720032768.304 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2024-07-03T18:52:48.304Z,1720032768.304 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2024-07-03T18:52:48.304Z,1720032768.304 [Radio_Surface](INFO): Join timeout helper Thread ID is 940
2024-07-03T18:52:48.520Z,1720032768.520 [Radio_Surface](INFO): Powering down
2024-07-03T18:52:48.520Z,1720032768.520 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2024-07-03T18:52:48.521Z,1720032768.521 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2024-07-03T18:52:48.532Z,1720032768.532 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2024-07-03T18:52:48.532Z,1720032768.532 [Onboard ThreadHandler](INFO): Thread cancelled.
2024-07-03T18:52:48.532Z,1720032768.532 [Onboard](INFO): Join timeout helper Thread ID is 941
2024-07-03T18:52:48.928Z,1720032768.928 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2024-07-03T18:52:48.928Z,1720032768.928 [Onboard ThreadHandler](INFO): Thread cancelled.
2024-07-03T18:52:48.937Z,1720032768.937 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2024-07-03T18:52:48.937Z,1720032768.937 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2024-07-03T18:52:48.937Z,1720032768.937 [DataOverHttps](INFO): Join timeout helper Thread ID is 942
2024-07-03T18:52:49.464Z,1720032769.464 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2024-07-03T18:52:49.464Z,1720032769.464 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2024-07-03T18:52:49.492Z,1720032769.492 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler
2024-07-03T18:52:49.492Z,1720032769.492 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2024-07-03T18:52:49.493Z,1720032769.493 [BackseatComponent](INFO): Join timeout helper Thread ID is 943
2024-07-03T18:52:49.544Z,1720032769.544 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread.
2024-07-03T18:52:49.544Z,1720032769.544 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2024-07-03T18:52:49.552Z,1720032769.552 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2024-07-03T18:52:49.553Z,1720032769.553 [logger ThreadHandler](INFO): Thread cancelled.
2024-07-03T18:52:49.553Z,1720032769.553 [logger](INFO): Join timeout helper Thread ID is 944
2024-07-03T18:52:49.589Z,1720032769.589 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2024-07-03T18:52:49.589Z,1720032769.589 [logger ThreadHandler](INFO): Thread cancelled.
2024-07-03T18:52:49.592Z,1720032769.592 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2024-07-03T18:52:49.592Z,1720032769.592 [CommandLine ThreadHandler](INFO): Thread cancelled.
2024-07-03T18:52:49.593Z,1720032769.593 [CommandLine](INFO): Join timeout helper Thread ID is 945
2024-07-03T18:52:49.640Z,1720032769.640 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2024-07-03T18:52:49.640Z,1720032769.640 [CommandLine ThreadHandler](INFO): Thread cancelled.
2024-07-03T18:52:49.652Z,1720032769.652 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler
2024-07-03T18:52:49.652Z,1720032769.652 [CommandExec ThreadHandler](INFO): Thread cancelled.
2024-07-03T18:52:49.653Z,1720032769.653 [CommandExec](INFO): Join timeout helper Thread ID is 946
2024-07-03T18:52:49.654Z,1720032769.654 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2024-07-03T18:52:49.654Z,1720032769.654 [controlThread ThreadHandler](INFO): Thread cancelled.
2024-07-03T18:52:49.654Z,1720032769.654 [controlThread](INFO): Join timeout helper Thread ID is 947
2024-07-03T18:52:49.928Z,1720032769.928 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2024-07-03T18:52:49.928Z,1720032769.928 [controlThread](DEBUG): Uninitializing ControlThread
2024-07-03T18:52:49.929Z,1720032769.929 [NAL9602](INFO): Powering down
2024-07-03T18:52:49.930Z,1720032769.930 [Sonardyne_Nano](INFO): Powering down
2024-07-03T18:52:50.048Z,1720032770.048 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2024-07-03T18:52:50.049Z,1720032770.049 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2024-07-03T18:52:50.050Z,1720032770.050 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2024-07-03T18:52:50.050Z,1720032770.050 [MissionManager](INFO): Uninitializing Mission Default
2024-07-03T18:52:50.050Z,1720032770.050 [Default] Stopped
2024-07-03T18:52:50.050Z,1720032770.050 [Default](DEBUG): Aggregate::uninitialize Default
2024-07-03T18:52:50.050Z,1720032770.050 [Default:B.GoToSurface] Stopped
2024-07-03T18:52:50.050Z,1720032770.050 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2024-07-03T18:52:50.050Z,1720032770.050 [Default:CheckIn] Stopped
2024-07-03T18:52:50.051Z,1720032770.051 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-07-03T18:52:50.051Z,1720032770.051 [Default:CheckIn:C.Wait] Stopped
2024-07-03T18:52:50.051Z,1720032770.051 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-07-03T18:52:50.053Z,1720032770.053 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2024-07-03T18:52:50.054Z,1720032770.054 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2024-07-03T18:52:50.054Z,1720032770.054 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2024-07-03T18:52:50.054Z,1720032770.054 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2024-07-03T18:52:50.055Z,1720032770.055 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2024-07-03T18:52:50.055Z,1720032770.055 [BuoyancyServo](INFO): Powering down
2024-07-03T18:52:50.068Z,1720032770.068 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2024-07-03T18:52:50.068Z,1720032770.068 [ElevatorServo](INFO): Powering down
2024-07-03T18:52:50.069Z,1720032770.069 [MassServo](DEBUG): Uninitialize Mass Servo.
2024-07-03T18:52:50.069Z,1720032770.069 [MassServo](INFO): Powering down
2024-07-03T18:52:50.070Z,1720032770.070 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2024-07-03T18:52:50.070Z,1720032770.070 [RudderServo](INFO): Powering down
2024-07-03T18:52:50.071Z,1720032770.071 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2024-07-03T18:52:50.071Z,1720032770.071 [ThrusterHE](INFO): Powering down
2024-07-03T18:52:50.072Z,1720032770.072 [SBIT](DEBUG): Uninitialize SBIT Component.
2024-07-03T18:52:50.072Z,1720032770.072 [IBIT](DEBUG): Uninitialize IBIT Component.
2024-07-03T18:52:50.073Z,1720032770.073 [CBIT](DEBUG): Uninitialize CBIT Component.
2024-07-03T18:52:50.073Z,1720032770.073 [CBIT](DEBUG): Powering off loads.
2024-07-03T18:52:50.083Z,1720032770.083 [CBIT](DEBUG): Disabling WDT.
2024-07-03T18:52:50.096Z,1720032770.096 [CBIT](DEBUG): Opening all GF detection circuits.
2024-07-03T18:52:50.097Z,1720032770.097 [controlThread ThreadHandler](INFO): Thread cancelled.
2024-07-03T18:52:50.153Z,1720032770.153 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2024-07-03T18:52:50.156Z,1720032770.156 [Onboard ThreadHandler](INFO): Thread cancelled.
2024-07-03T18:52:50.162Z,1720032770.162 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2024-07-03T18:52:50.204Z,1720032770.204 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2024-07-03T18:52:50.241Z,1720032770.241 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2024-07-03T18:52:50.246Z,1720032770.246 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2024-07-03T18:52:50.278Z,1720032770.278 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2024-07-03T18:52:50.349Z,1720032770.349 [logger ThreadHandler](INFO): Thread cancelled.