2024-05-06T14:21:16.234Z,1715005276.234 [Supervisor](DEBUG): Initializing supervisor.
2024-05-06T14:21:16.239Z,1715005276.239 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2024-05-06T14:21:16.239Z,1715005276.239 [SyncHandler](INFO): Protected caller Thread ID is 836
2024-05-06T14:21:16.240Z,1715005276.240 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2024-05-06T14:21:16.241Z,1715005276.241 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2024-05-06T14:21:16.241Z,1715005276.241 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 837
2024-05-06T14:21:16.245Z,1715005276.245 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2024-05-06T14:21:16.262Z,1715005276.262 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2024-05-06T14:21:16.263Z,1715005276.263 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2024-05-06T14:21:16.264Z,1715005276.264 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 838
2024-05-06T14:21:16.268Z,1715005276.268 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2024-05-06T14:21:16.269Z,1715005276.269 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2024-05-06T14:21:16.269Z,1715005276.269 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 839
2024-05-06T14:21:16.271Z,1715005276.271 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2024-05-06T14:21:16.272Z,1715005276.272 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2024-05-06T14:21:16.273Z,1715005276.273 [logger ThreadHandler](INFO): Protected caller Thread ID is 840
2024-05-06T14:21:16.276Z,1715005276.276 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2024-05-06T14:21:16.277Z,1715005276.277 [Supervisor](INFO): Looking for Config files in directory: Config/
2024-05-06T14:21:16.280Z,1715005276.280 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2024-05-06T14:21:16.628Z,1715005276.628 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2024-05-06T14:21:16.629Z,1715005276.629 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2024-05-06T14:21:16.736Z,1715005276.736 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2024-05-06T14:21:16.853Z,1715005276.853 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2024-05-06T14:21:16.854Z,1715005276.854 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2024-05-06T14:21:16.994Z,1715005276.994 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2024-05-06T14:21:16.994Z,1715005276.994 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2024-05-06T14:21:17.354Z,1715005277.354 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2024-05-06T14:21:17.354Z,1715005277.354 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2024-05-06T14:21:17.462Z,1715005277.462 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2024-05-06T14:21:17.462Z,1715005277.462 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2024-05-06T14:21:17.889Z,1715005277.889 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2024-05-06T14:21:17.891Z,1715005277.891 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2024-05-06T14:21:18.116Z,1715005278.116 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2024-05-06T14:21:18.118Z,1715005278.118 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2024-05-06T14:21:18.207Z,1715005278.207 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2024-05-06T14:21:18.457Z,1715005278.457 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2024-05-06T14:21:18.458Z,1715005278.458 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2024-05-06T14:21:18.690Z,1715005278.690 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2024-05-06T14:21:18.691Z,1715005278.691 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2024-05-06T14:21:19.231Z,1715005279.231 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2024-05-06T14:21:19.233Z,1715005279.233 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2024-05-06T14:21:19.433Z,1715005279.433 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2024-05-06T14:21:19.434Z,1715005279.434 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2024-05-06T14:21:19.756Z,1715005279.756 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2024-05-06T14:21:19.758Z,1715005279.758 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2024-05-06T14:21:20.635Z,1715005280.635 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2024-05-06T14:21:20.636Z,1715005280.636 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2024-05-06T14:21:21.238Z,1715005281.238 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2024-05-06T14:21:21.240Z,1715005281.240 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-ahi/
2024-05-06T14:21:21.243Z,1715005281.243 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Control.cfg
2024-05-06T14:21:21.352Z,1715005281.352 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Science.cfg
2024-05-06T14:21:21.482Z,1715005281.482 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/secure.cfg
2024-05-06T14:21:21.576Z,1715005281.576 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Servo.cfg
2024-05-06T14:21:21.694Z,1715005281.694 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/BIT.cfg
2024-05-06T14:21:21.791Z,1715005281.791 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Battery.cfg
2024-05-06T14:21:22.056Z,1715005282.056 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2024-05-06T14:21:22.057Z,1715005282.057 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/vehicle.cfg
2024-05-06T14:21:22.177Z,1715005282.177 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/logger.cfg
2024-05-06T14:21:22.287Z,1715005282.287 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Navigation.cfg
2024-05-06T14:21:22.401Z,1715005282.401 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Sensor.cfg
2024-05-06T14:21:22.553Z,1715005282.553 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Simulator.cfg
2024-05-06T14:21:22.649Z,1715005282.649 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg
2024-05-06T14:21:22.667Z,1715005282.667 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2024-05-06T14:21:22.813Z,1715005282.813 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2024-05-06T14:21:22.814Z,1715005282.814 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2024-05-06T14:21:22.883Z,1715005282.883 [VerticalControl](DEBUG): Construct VerticalControl.
2024-05-06T14:21:22.943Z,1715005282.943 [VerticalControl] Loaded
2024-05-06T14:21:22.943Z,1715005282.943 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2024-05-06T14:21:22.946Z,1715005282.946 [HorizontalControl](DEBUG): Construct HorizontalControl.
2024-05-06T14:21:22.993Z,1715005282.993 [HorizontalControl] Loaded
2024-05-06T14:21:22.993Z,1715005282.993 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2024-05-06T14:21:22.995Z,1715005282.995 [SpeedControl](DEBUG): Construct SpeedControl.
2024-05-06T14:21:22.999Z,1715005282.999 [SpeedControl] Loaded
2024-05-06T14:21:22.999Z,1715005282.999 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2024-05-06T14:21:23.002Z,1715005283.002 [LoopControl](DEBUG): Construct LoopControl.
2024-05-06T14:21:23.002Z,1715005283.002 [LoopControl] Loaded
2024-05-06T14:21:23.002Z,1715005283.002 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2024-05-06T14:21:23.003Z,1715005283.003 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2024-05-06T14:21:23.003Z,1715005283.003 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2024-05-06T14:21:23.084Z,1715005283.084 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2024-05-06T14:21:23.085Z,1715005283.085 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2024-05-06T14:21:23.866Z,1715005283.866 [AHRS_M2] Loaded
2024-05-06T14:21:23.866Z,1715005283.866 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2024-05-06T14:21:24.115Z,1715005284.115 [BackseatComponent](INFO): Found secondary power supply at: /dev/loadC4
2024-05-06T14:21:24.116Z,1715005284.116 [BackseatComponent] Loaded
2024-05-06T14:21:24.116Z,1715005284.116 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread.
2024-05-06T14:21:24.117Z,1715005284.117 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 4089D4E0
2024-05-06T14:21:24.118Z,1715005284.118 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 922
2024-05-06T14:21:24.121Z,1715005284.121 [LcmUniversalReporter] Loaded
2024-05-06T14:21:24.121Z,1715005284.121 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread.
2024-05-06T14:21:24.910Z,1715005284.910 [BPC1] Loaded
2024-05-06T14:21:24.910Z,1715005284.910 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2024-05-06T14:21:25.051Z,1715005285.051 [DataOverHttps] Loaded
2024-05-06T14:21:25.051Z,1715005285.051 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2024-05-06T14:21:25.052Z,1715005285.052 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 408CD4E0
2024-05-06T14:21:25.052Z,1715005285.052 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 923
2024-05-06T14:21:25.072Z,1715005285.072 [Depth_Keller] Loaded
2024-05-06T14:21:25.073Z,1715005285.073 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2024-05-06T14:21:25.077Z,1715005285.077 [DropWeight] Loaded
2024-05-06T14:21:25.078Z,1715005285.078 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2024-05-06T14:21:25.138Z,1715005285.138 [NAL9602] Loaded
2024-05-06T14:21:25.139Z,1715005285.139 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2024-05-06T14:21:25.168Z,1715005285.168 [Onboard] Loaded
2024-05-06T14:21:25.169Z,1715005285.169 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2024-05-06T14:21:25.170Z,1715005285.170 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 408FD4E0
2024-05-06T14:21:25.170Z,1715005285.170 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 924
2024-05-06T14:21:25.182Z,1715005285.182 [Power24vConverter] Loaded
2024-05-06T14:21:25.182Z,1715005285.182 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2024-05-06T14:21:25.195Z,1715005285.195 [Radio_Surface] Loaded
2024-05-06T14:21:25.195Z,1715005285.195 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2024-05-06T14:21:25.196Z,1715005285.196 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 4092D4E0
2024-05-06T14:21:25.197Z,1715005285.197 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 925
2024-05-06T14:21:25.210Z,1715005285.210 [Sonardyne_Nano] Loaded
2024-05-06T14:21:25.210Z,1715005285.210 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread.
2024-05-06T14:21:25.300Z,1715005285.300 [DAT] Loaded
2024-05-06T14:21:25.301Z,1715005285.301 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread.
2024-05-06T14:21:25.302Z,1715005285.302 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 4095D4E0
2024-05-06T14:21:25.302Z,1715005285.302 [DAT ThreadHandler](INFO): Protected caller Thread ID is 926
2024-05-06T14:21:25.324Z,1715005285.324 [Waterlinked] Loaded
2024-05-06T14:21:25.325Z,1715005285.325 [ComponentRegistry](DEBUG): SyncComponent "Waterlinked" handled in the control thread.
2024-05-06T14:21:25.325Z,1715005285.325 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2024-05-06T14:21:25.325Z,1715005285.325 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2024-05-06T14:21:25.343Z,1715005285.343 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2024-05-06T14:21:25.345Z,1715005285.345 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2024-05-06T14:21:25.418Z,1715005285.418 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2024-05-06T14:21:25.420Z,1715005285.420 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2024-05-06T14:21:25.590Z,1715005285.590 [SBIT](DEBUG): Construct Startup Built In Test.
2024-05-06T14:21:25.599Z,1715005285.599 [SBIT] Loaded
2024-05-06T14:21:25.599Z,1715005285.599 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2024-05-06T14:21:25.602Z,1715005285.602 [IBIT](DEBUG): Construct Initiated Built In Test.
2024-05-06T14:21:25.614Z,1715005285.614 [IBIT] Loaded
2024-05-06T14:21:25.615Z,1715005285.615 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2024-05-06T14:21:25.621Z,1715005285.621 [CBIT](DEBUG): Construct Continuous Built In Test.
2024-05-06T14:21:25.725Z,1715005285.725 [CBIT] Loaded
2024-05-06T14:21:25.725Z,1715005285.725 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2024-05-06T14:21:25.725Z,1715005285.725 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2024-05-06T14:21:25.726Z,1715005285.726 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2024-05-06T14:21:26.125Z,1715005286.125 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2024-05-06T14:21:26.126Z,1715005286.126 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2024-05-06T14:21:26.194Z,1715005286.194 [DepthRateCalculator] Loaded
2024-05-06T14:21:26.195Z,1715005286.195 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2024-05-06T14:21:26.200Z,1715005286.200 [PitchRateCalculator] Loaded
2024-05-06T14:21:26.200Z,1715005286.200 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2024-05-06T14:21:26.210Z,1715005286.210 [SpeedCalculator] Loaded
2024-05-06T14:21:26.211Z,1715005286.211 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2024-05-06T14:21:26.215Z,1715005286.215 [YawRateCalculator] Loaded
2024-05-06T14:21:26.215Z,1715005286.215 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2024-05-06T14:21:26.235Z,1715005286.235 [ElevatorOffsetCalculator] Loaded
2024-05-06T14:21:26.235Z,1715005286.235 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2024-05-06T14:21:26.236Z,1715005286.236 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2024-05-06T14:21:26.236Z,1715005286.236 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2024-05-06T14:21:26.448Z,1715005286.448 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2024-05-06T14:21:26.448Z,1715005286.448 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2024-05-06T14:21:26.583Z,1715005286.583 [DeadReckonUsingMultipleVelocitySources] Loaded
2024-05-06T14:21:26.583Z,1715005286.583 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2024-05-06T14:21:26.625Z,1715005286.625 [DeadReckonUsingSpeedCalculator] Loaded
2024-05-06T14:21:26.625Z,1715005286.625 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2024-05-06T14:21:26.667Z,1715005286.667 [DeadReckonWithRespectToSeafloor] Loaded
2024-05-06T14:21:26.667Z,1715005286.667 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToSeafloor" handled in the control thread.
2024-05-06T14:21:26.681Z,1715005286.681 [NavChart] Loaded
2024-05-06T14:21:26.681Z,1715005286.681 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2024-05-06T14:21:26.687Z,1715005286.687 [UniversalFixResidualReporter] Loaded
2024-05-06T14:21:26.687Z,1715005286.687 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2024-05-06T14:21:26.702Z,1715005286.702 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2024-05-06T14:21:26.703Z,1715005286.703 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2024-05-06T14:21:26.864Z,1715005286.864 [BuoyancyServo] Loaded
2024-05-06T14:21:26.865Z,1715005286.865 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2024-05-06T14:21:26.885Z,1715005286.885 [ElevatorServo] Loaded
2024-05-06T14:21:26.885Z,1715005286.885 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2024-05-06T14:21:26.905Z,1715005286.905 [MassServo] Loaded
2024-05-06T14:21:26.905Z,1715005286.905 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2024-05-06T14:21:26.923Z,1715005286.923 [RudderServo] Loaded
2024-05-06T14:21:26.924Z,1715005286.924 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2024-05-06T14:21:26.938Z,1715005286.938 [ThrusterHE] Loaded
2024-05-06T14:21:26.939Z,1715005286.939 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread.
2024-05-06T14:21:26.939Z,1715005286.939 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2024-05-06T14:21:26.940Z,1715005286.940 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2024-05-06T14:21:27.164Z,1715005287.164 [CTD_Seabird] Loaded
2024-05-06T14:21:27.164Z,1715005287.164 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2024-05-06T14:21:27.165Z,1715005287.165 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40BD74E0
2024-05-06T14:21:27.165Z,1715005287.165 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 927
2024-05-06T14:21:27.199Z,1715005287.199 [ESPComponent] Loaded
2024-05-06T14:21:27.199Z,1715005287.199 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread.
2024-05-06T14:21:27.219Z,1715005287.219 [PAR_Licor] Loaded
2024-05-06T14:21:27.219Z,1715005287.219 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2024-05-06T14:21:27.263Z,1715005287.263 [WetLabsBB2FL] Loaded
2024-05-06T14:21:27.263Z,1715005287.263 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2024-05-06T14:21:27.264Z,1715005287.264 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40C074E0
2024-05-06T14:21:27.264Z,1715005287.264 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 928
2024-05-06T14:21:27.265Z,1715005287.265 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2024-05-06T14:21:27.271Z,1715005287.271 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2024-05-06T14:21:27.274Z,1715005287.274 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2024-05-06T14:21:27.286Z,1715005287.286 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2024-05-06T14:21:27.287Z,1715005287.287 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C374E0
2024-05-06T14:21:27.287Z,1715005287.287 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 929
2024-05-06T14:21:27.292Z,1715005287.292 [Supervisor](INFO): Main Thread ID is 827
2024-05-06T14:21:27.292Z,1715005287.292 [Supervisor](DEBUG): Running supervisor.
2024-05-06T14:21:27.292Z,1715005287.292 [CommandExec ThreadHandler](INFO): Handler Thread ID is 930
2024-05-06T14:21:27.293Z,1715005287.293 [CommandExec](INFO): Initializing the command executive.
2024-05-06T14:21:27.294Z,1715005287.294 [CommandLine ThreadHandler](INFO): Handler Thread ID is 931
2024-05-06T14:21:27.297Z,1715005287.297 [controlThread ThreadHandler](INFO): Handler Thread ID is 932
2024-05-06T14:21:27.297Z,1715005287.297 [controlThread](DEBUG): Initializing ControlThread
2024-05-06T14:21:27.298Z,1715005287.298 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2024-05-06T14:21:27.299Z,1715005287.299 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2024-05-06T14:21:27.300Z,1715005287.300 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2024-05-06T14:21:27.301Z,1715005287.301 [LoopControl](DEBUG): Initialize LoopControlComponent.
2024-05-06T14:21:27.306Z,1715005287.306 [SBIT](INFO): Initialize SBIT Component.
2024-05-06T14:21:27.306Z,1715005287.306 [SBIT](IMPORTANT): git: 2024-04-30_A
2024-05-06T14:21:27.306Z,1715005287.306 [SBIT](INFO): git hash: 6f063747ddc9dbe18e4f40e399cbc8a06a65c541
2024-05-06T14:21:27.307Z,1715005287.307 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2024-05-06T14:21:27.308Z,1715005287.308 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #639 PREEMPT Wed Mar 12 12:53:33 PDT 2014
Kernel Reported: #1 PREEMPT Tue Nov 28 15:04:22 PST 2023
2024-05-06T14:21:27.309Z,1715005287.309 [SBIT](INFO): Beginning SBIT in 83.000000 seconds.
2024-05-06T14:21:27.310Z,1715005287.310 [IBIT](INFO): Initialize IBIT Component.
2024-05-06T14:21:27.310Z,1715005287.310 [CBIT](DEBUG): Initialize CBIT Component.
2024-05-06T14:21:27.311Z,1715005287.311 [logger ThreadHandler](INFO): Handler Thread ID is 933
2024-05-06T14:21:27.324Z,1715005287.324 [CBIT](DEBUG): Initialized mux pins.
2024-05-06T14:21:27.324Z,1715005287.324 [CBIT](DEBUG): Initializing the watchdog timer.
2024-05-06T14:21:27.332Z,1715005287.332 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 934
2024-05-06T14:21:27.344Z,1715005287.344 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 935
2024-05-06T14:21:27.346Z,1715005287.346 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2024-05-06T14:21:27.348Z,1715005287.348 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2024-05-06T14:21:27.348Z,1715005287.348 [CBIT](DEBUG): Initializing heartbeat.
2024-05-06T14:21:27.356Z,1715005287.356 [Onboard ThreadHandler](INFO): Handler Thread ID is 936
2024-05-06T14:21:27.374Z,1715005287.374 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 937
2024-05-06T14:21:27.397Z,1715005287.397 [DAT ThreadHandler](INFO): Handler Thread ID is 938
2024-05-06T14:21:27.397Z,1715005287.397 [DAT](INFO): Powering up
2024-05-06T14:21:27.398Z,1715005287.398 [DAT](DEBUG): Initializing DAT.
2024-05-06T14:21:27.401Z,1715005287.401 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 940
2024-05-06T14:21:27.402Z,1715005287.402 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2024-05-06T14:21:27.408Z,1715005287.408 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 941
2024-05-06T14:21:27.412Z,1715005287.412 [WetLabsBB2FL](INFO): Powering up
2024-05-06T14:21:27.414Z,1715005287.414 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 943
2024-05-06T14:21:27.420Z,1715005287.420 [CBIT](DEBUG): Deactivating GF circuits.
2024-05-06T14:21:27.420Z,1715005287.420 [CBIT](DEBUG): Deactivating emergency mode.
2024-05-06T14:21:27.421Z,1715005287.421 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2HA05M.000
2024-05-06T14:21:27.421Z,1715005287.421 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2HA05M.000
2024-05-06T14:21:27.421Z,1715005287.421 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3HA20M.000
2024-05-06T14:21:27.421Z,1715005287.421 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3HA20M.000
2024-05-06T14:21:27.421Z,1715005287.421 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4HA51M.000
2024-05-06T14:21:27.422Z,1715005287.422 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4HA51M.000
2024-05-06T14:21:27.422Z,1715005287.422 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4HA51M.000
2024-05-06T14:21:27.422Z,1715005287.422 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4HA51M.000
2024-05-06T14:21:27.422Z,1715005287.422 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5HA53M.000
2024-05-06T14:21:27.422Z,1715005287.422 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5HA53M.000
2024-05-06T14:21:27.422Z,1715005287.422 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5HA55M.000
2024-05-06T14:21:27.422Z,1715005287.422 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5HA55M.000
2024-05-06T14:21:27.460Z,1715005287.460 [CBIT](DEBUG): Backplane powered.
2024-05-06T14:21:27.460Z,1715005287.460 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2024-05-06T14:21:27.461Z,1715005287.461 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2024-05-06T14:21:27.461Z,1715005287.461 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2024-05-06T14:21:27.461Z,1715005287.461 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2024-05-06T14:21:27.462Z,1715005287.462 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2024-05-06T14:21:27.463Z,1715005287.463 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2024-05-06T14:21:27.464Z,1715005287.464 [NavChart](DEBUG): Initialize NavChart Navigation.
2024-05-06T14:21:27.464Z,1715005287.464 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2024-05-06T14:21:27.468Z,1715005287.468 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser
2024-05-06T14:21:27.469Z,1715005287.469 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl
2024-05-06T14:21:27.469Z,1715005287.469 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl
2024-05-06T14:21:27.480Z,1715005287.480 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl
2024-05-06T14:21:27.527Z,1715005287.527 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into:
2024-05-06T14:21:27.552Z,1715005287.552 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2024-05-06T14:21:27.579Z,1715005287.579 [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-05-06T14:21:27.580Z,1715005287.580 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl
2024-05-06T14:21:27.580Z,1715005287.580 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl
2024-05-06T14:21:27.588Z,1715005287.588 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl
2024-05-06T14:21:27.780Z,1715005287.780 [Radio_Surface](INFO): Powering up
2024-05-06T14:21:27.916Z,1715005287.916 [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-05-06T14:21:27.922Z,1715005287.922 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2024-05-06T14:21:27.936Z,1715005287.936 [Default:A.Wait](DEBUG): Construct Wait.
2024-05-06T14:21:27.938Z,1715005287.938 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2024-05-06T14:21:27.979Z,1715005287.979 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2024-05-06T14:21:28.001Z,1715005288.001 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2024-05-06T14:21:28.007Z,1715005288.007 [Default:E.Execute](DEBUG): Construct Execute.
2024-05-06T14:21:28.010Z,1715005288.010 [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-05-06T14:21:28.025Z,1715005288.025 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,NAL9602,Power24vConverter,Sonardyne_Nano,Waterlinked,ESPComponent,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,DeadReckonWithRespectToSeafloor,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter,
2024-05-06T14:21:28.048Z,1715005288.048 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2024-05-06T14:21:28.202Z,1715005288.202 [Depth_Keller](ERROR): Pressure or depth reading out of range: -1.140412 decibar, -1.132002 m
2024-05-06T14:21:28.203Z,1715005288.203 [Power24vConverter](INFO): Powering up.
2024-05-06T14:21:28.204Z,1715005288.204 [Sonardyne_Nano](INFO): Initializing.
2024-05-06T14:21:28.280Z,1715005288.280 [DepthRateCalculator](ERROR): Depth measurement is not active
2024-05-06T14:21:28.316Z,1715005288.316 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2024-05-06T14:21:28.324Z,1715005288.324 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2024-05-06T14:21:28.325Z,1715005288.325 [ElevatorServo](DEBUG): Initializing EZServoServo.
2024-05-06T14:21:28.333Z,1715005288.333 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2024-05-06T14:21:28.333Z,1715005288.333 [MassServo](DEBUG): Initializing EZServoServo.
2024-05-06T14:21:28.340Z,1715005288.340 [MassServo](DEBUG): Initializing MassServo.
2024-05-06T14:21:28.341Z,1715005288.341 [RudderServo](DEBUG): Initializing EZServoServo.
2024-05-06T14:21:28.349Z,1715005288.349 [RudderServo](DEBUG): Initializing RudderServo.
2024-05-06T14:21:28.350Z,1715005288.350 [ThrusterHE](DEBUG): Initializing EZServoServo.
2024-05-06T14:21:28.356Z,1715005288.356 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2024-05-06T14:21:29.520Z,1715005289.520 [WetLabsBB2FL](INFO): Powering down
2024-05-06T14:21:30.458Z,1715005290.458 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART
2024-05-06T14:21:31.712Z,1715005291.712 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2311
2024-05-06T14:21:33.953Z,1715005293.953 [ThrusterHE](ERROR): Zero Speed Commanded.
2024-05-06T14:21:40.264Z,1715005300.264 [DAT](INFO): DAT read:
2024-05-06T14:21:40.266Z,1715005300.266 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series
2024-05-06T14:21:41.777Z,1715005301.777 [DAT](INFO): DAT read: MF Frequency Band
2024-05-06T14:21:41.780Z,1715005301.780 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.15.0
2024-05-06T14:21:41.783Z,1715005301.783 [DAT](INFO): DAT read: May 6 2024 14:21:36
2024-05-06T14:21:43.037Z,1715005303.037 [DAT](INFO): DAT read: Features enabled [Bearing]
2024-05-06T14:21:43.039Z,1715005303.039 [DAT](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP
2024-05-06T14:21:43.039Z,1715005303.039 [DAT](INFO): commRate: 800
2024-05-06T14:21:45.104Z,1715005305.104 [DAT](INFO): entering command mode
2024-05-06T14:21:45.304Z,1715005305.304 [DAT](INFO): DAT read:
2024-05-06T14:21:45.305Z,1715005305.305 [DAT](INFO): DAT read: user:1>
2024-05-06T14:21:45.305Z,1715005305.305 [DAT](INFO): setting verbose to 3
2024-05-06T14:21:45.556Z,1715005305.556 [DAT](INFO): DAT read: user:1>
2024-05-06T14:21:45.557Z,1715005305.557 [DAT](INFO): DAT read: Verbose | 3
2024-05-06T14:21:45.558Z,1715005305.558 [DAT](INFO): set verbose to 3
2024-05-06T14:21:45.558Z,1715005305.558 [DAT](INFO): setting DatVerbose to 27440
2024-05-06T14:21:45.808Z,1715005305.808 [DAT](INFO): DAT read: user:2>
2024-05-06T14:21:45.809Z,1715005305.809 [DAT](INFO): DAT read: DatVerbose | 27440
2024-05-06T14:21:45.810Z,1715005305.810 [DAT](INFO): set DatVerbose to 27440
2024-05-06T14:21:45.810Z,1715005305.810 [DAT](INFO): setting transmit power to 8
2024-05-06T14:21:46.060Z,1715005306.060 [DAT](INFO): DAT read: user:3>
2024-05-06T14:21:46.061Z,1715005306.061 [DAT](INFO): DAT read: TxPower | 8 (Max)
2024-05-06T14:21:46.062Z,1715005306.062 [DAT](INFO): set transmit power to 8
2024-05-06T14:21:46.062Z,1715005306.062 [DAT](INFO): setting local address to 1
2024-05-06T14:21:46.313Z,1715005306.313 [DAT](INFO): DAT read: user:4>
2024-05-06T14:21:46.314Z,1715005306.314 [DAT](INFO): DAT read: LocalAddr | 1
2024-05-06T14:21:46.314Z,1715005306.314 [DAT](INFO): set local address to 1
2024-05-06T14:21:46.315Z,1715005306.315 [DAT](INFO): Setting time to: 14:21:46 And date to:5/6/2024
2024-05-06T14:21:46.565Z,1715005306.565 [DAT](INFO): DAT read: user:5>
2024-05-06T14:21:46.565Z,1715005306.565 [DAT](INFO): DAT read: Mon May 6, 2024 14:21:46
2024-05-06T14:21:46.566Z,1715005306.566 [DAT](INFO): Local DAT time set to Mon May 6, 2024 14:21:46
2024-05-06T14:21:55.141Z,1715005315.141 [NAL9602](INFO): Powering up NAL9602
2024-05-06T14:21:55.164Z,1715005315.164 [Waterlinked](ERROR): only read 0 of 5 data items. Device response::BI +0, +0, +0,V
2024-05-06T14:22:04.076Z,1715005324.076 [Waterlinked](INFO): Powering down
2024-05-06T14:22:06.016Z,1715005326.016 [NAL9602](INFO): NAL9602 initialized
2024-05-06T14:22:35.510Z,1715005355.510 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-05-06T14:22:39.602Z,1715005359.602 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-05-06T14:22:50.902Z,1715005370.902 [SBIT](IMPORTANT): Beginning Startup BIT
2024-05-06T14:22:50.906Z,1715005370.906 [CBIT](IMPORTANT): Beginning ground fault scan
2024-05-06T14:22:54.501Z,1715005374.501 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-05-06T14:23:01.937Z,1715005381.937 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.015202
CHAN A1 (24V): 0.000600
CHAN A2 (12V): 0.001045
CHAN A3 (5V): -0.001162
CHAN B0 (3.3V): 0.000184
CHAN B1 (3.15aV): -0.000154
CHAN B2 (3.15bV): -0.000654
CHAN B3 (GND): 0.000002
OPEN: 0.006295
Full Scale: +/- 1 mA
2024-05-06T14:23:13.080Z,1715005393.080 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-05-06T14:23:30.450Z,1715005410.450 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-05-06T14:23:45.017Z,1715005425.017 [SBIT](IMPORTANT): SBIT PASSED
2024-05-06T14:23:45.017Z,1715005425.017 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2024-05-06T14:23:45.018Z,1715005425.018 [SBIT](IMPORTANT): BPC1.batteryMissingStickThreshold=15 count;
2024-05-06T14:23:45.018Z,1715005425.018 [SBIT](IMPORTANT): CTD_Seabird.simulateHardware=1 bool;
2024-05-06T14:23:45.018Z,1715005425.018 [SBIT](IMPORTANT): Express linearApproximation CTD_Seabird.bin_median_sea_water_salinity 0.100000 practical_salinity_unit;
2024-05-06T14:23:45.018Z,1715005425.018 [SBIT](IMPORTANT): Express linearApproximation CTD_Seabird.bin_median_sea_water_temperature 1.500000 celsius;
2024-05-06T14:23:45.018Z,1715005425.018 [SBIT](IMPORTANT): Express linearApproximation DAT.acoustic_contact_range 10.000000 meter;
2024-05-06T14:23:45.018Z,1715005425.018 [SBIT](IMPORTANT): Express linearApproximation WetLabsBB2FL.bin_median_mass_concentration_of_chlorophyll_in_sea_water 0.800000 microgram_per_liter;
2024-05-06T14:23:45.018Z,1715005425.018 [SBIT](IMPORTANT): Express linearApproximation _.planktivore_HM_AvgRois 1.000000 count_per_second;
2024-05-06T14:23:45.019Z,1715005425.019 [SBIT](IMPORTANT): Express linearApproximation _.planktivore_LM_AvgRois 0.600000 count_per_second;
2024-05-06T14:23:45.019Z,1715005425.019 [SBIT](IMPORTANT): Express linearApproximation _.predict_plankton_data_pct_dinos_sqerr 0.750000 none;
2024-05-06T14:23:45.019Z,1715005425.019 [SBIT](IMPORTANT): Express linearApproximation depth 5.000000 meter;
2024-05-06T14:23:45.019Z,1715005425.019 [SBIT](IMPORTANT): Express linearApproximation height_above_sea_floor 5.000000 meter;
2024-05-06T14:23:45.019Z,1715005425.019 [SBIT](IMPORTANT): Normal all WetLabsBB2FL.bin_median_mass_concentration_of_chlorophyll_in_sea_water;
2024-05-06T14:23:45.019Z,1715005425.019 [SBIT](IMPORTANT): Vehicle.useTlLoader=1 bool;
2024-05-06T14:23:45.019Z,1715005425.019 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=175.634497 cubic_centimeter;
2024-05-06T14:23:45.019Z,1715005425.019 [SBIT](IMPORTANT): VerticalControl.massDefault=15.996625 millimeter;
2024-05-06T14:23:45.426Z,1715005425.426 [MissionManager](IMPORTANT): Started mission Startup
2024-05-06T14:23:45.427Z,1715005425.427 [Startup] Running Loop=1
2024-05-06T14:23:45.427Z,1715005425.427 [Startup](DEBUG): Aggregate::initialize Startup
2024-05-06T14:23:45.427Z,1715005425.427 [Startup:A.GoToSurface] Running Loop=1
2024-05-06T14:23:45.427Z,1715005425.427 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2024-05-06T14:23:45.428Z,1715005425.428 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2024-05-06T14:23:45.428Z,1715005425.428 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2024-05-06T14:23:45.429Z,1715005425.429 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2024-05-06T14:23:45.429Z,1715005425.429 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2024-05-06T14:23:45.429Z,1715005425.429 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2024-05-06T14:23:45.431Z,1715005425.431 [Startup:StartupSatComms] Running Loop=1
2024-05-06T14:23:45.431Z,1715005425.431 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2024-05-06T14:23:45.431Z,1715005425.431 [Startup:StartupSatComms:A] Running Loop=1
2024-05-06T14:23:45.820Z,1715005425.820 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2024-05-06T14:23:48.630Z,1715005428.630 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-05-06T14:24:00.311Z,1715005440.311 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.005733
2024-05-06T14:24:07.231Z,1715005447.231 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-05-06T14:24:25.970Z,1715005465.970 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-05-06T14:24:27.871Z,1715005467.871 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2024-05-06T14:24:27.872Z,1715005467.872 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-05-06T14:24:27.877Z,1715005467.878 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1
2024-05-06T14:24:27.878Z,1715005467.878 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2024-05-06T14:24:27.879Z,1715005467.879 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1
2024-05-06T14:24:27.879Z,1715005467.879 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2024-05-06T14:24:27.950Z,1715005467.950 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-05-06T14:24:27.950Z,1715005467.950 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2024-05-06T14:24:27.950Z,1715005467.950 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2024-05-06T14:24:28.295Z,1715005468.295 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-05-06T14:24:28.295Z,1715005468.295 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2024-05-06T14:24:28.300Z,1715005468.300 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2024-05-06T14:24:28.300Z,1715005468.300 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1
2024-05-06T14:24:28.301Z,1715005468.301 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2024-05-06T14:24:28.301Z,1715005468.301 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1
2024-05-06T14:24:28.676Z,1715005468.676 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2024-05-06T14:24:42.839Z,1715005482.839 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-05-06T14:24:45.628Z,1715005485.628 [Startup:StartupSatComms:A](INFO): Timed out from 2024-05-06T14:23:45.4Z
2024-05-06T14:24:45.628Z,1715005485.628 [Startup:StartupSatComms:A] Stopped
2024-05-06T14:24:45.628Z,1715005485.628 [Startup:StartupSatComms:B] Running Loop=1
2024-05-06T14:24:46.056Z,1715005486.056 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2024-05-06T14:24:52.636Z,1715005492.636 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20240506T141703/Courier0000.lzma
2024-05-06T14:24:53.638Z,1715005493.638 [DataOverHttps](INFO): Moved sent file to Logs/20240506T141703/Courier0000.lzma.bak
2024-05-06T14:24:53.638Z,1715005493.638 [DataOverHttps](INFO): SBD MOMSN=19983533
2024-05-06T14:25:09.229Z,1715005509.229 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20240506T142116/Courier0000.lzma
2024-05-06T14:25:10.230Z,1715005510.230 [DataOverHttps](INFO): Moved sent file to Logs/20240506T142116/Courier0000.lzma.bak
2024-05-06T14:25:10.230Z,1715005510.230 [DataOverHttps](INFO): SBD MOMSN=19983539
2024-05-06T14:25:25.760Z,1715005525.760 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20240506T141703/Express0001.lzma
2024-05-06T14:25:26.762Z,1715005526.762 [DataOverHttps](INFO): Moved sent file to Logs/20240506T141703/Express0001.lzma.bak
2024-05-06T14:25:26.762Z,1715005526.762 [DataOverHttps](INFO): SBD MOMSN=19983542
2024-05-06T14:25:42.355Z,1715005542.355 [DataOverHttps](INFO): Sending 1148 bytes from file Logs/20240506T142116/Express0001.lzma
2024-05-06T14:25:43.354Z,1715005543.354 [DataOverHttps](INFO): Moved sent file to Logs/20240506T142116/Express0001.lzma.bak
2024-05-06T14:25:43.354Z,1715005543.354 [DataOverHttps](INFO): SBD MOMSN=19983544
2024-05-06T14:25:44.643Z,1715005544.643 [Startup:StartupSatComms:B] Stopped
2024-05-06T14:25:44.643Z,1715005544.643 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2024-05-06T14:25:44.643Z,1715005544.643 [Startup:StartupSatComms] Stopped
2024-05-06T14:25:44.643Z,1715005544.643 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2024-05-06T14:25:44.644Z,1715005544.644 [Startup](INFO): Completed Startup
2024-05-06T14:25:44.644Z,1715005544.644 [MissionManager](INFO): Startup is completed.
2024-05-06T14:25:44.645Z,1715005544.645 [MissionManager](INFO): Uninitializing Mission Startup
2024-05-06T14:25:44.645Z,1715005544.645 [Startup] Stopped
2024-05-06T14:25:44.645Z,1715005544.645 [Startup](DEBUG): Aggregate::uninitialize Startup
2024-05-06T14:25:44.645Z,1715005544.645 [Startup:A.GoToSurface] Stopped
2024-05-06T14:25:44.645Z,1715005544.645 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2024-05-06T14:25:45.043Z,1715005545.043 [MissionManager](IMPORTANT): Started mission Default
2024-05-06T14:25:45.044Z,1715005545.044 [Default] Running Loop=1
2024-05-06T14:25:45.044Z,1715005545.044 [Default](DEBUG): Aggregate::initialize Default
2024-05-06T14:25:45.044Z,1715005545.044 [Default:B.GoToSurface] Running Loop=1
2024-05-06T14:25:45.044Z,1715005545.044 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2024-05-06T14:25:45.044Z,1715005545.044 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2024-05-06T14:25:45.045Z,1715005545.045 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2024-05-06T14:25:45.045Z,1715005545.045 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2024-05-06T14:25:45.045Z,1715005545.045 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2024-05-06T14:25:45.046Z,1715005545.046 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2024-05-06T14:25:45.046Z,1715005545.046 [Default:A.Wait] Running Loop=1
2024-05-06T14:25:45.046Z,1715005545.046 [Default:A.Wait](DEBUG): Initialize Wait Component.
2024-05-06T14:25:58.348Z,1715005558.348 [Default:A.Wait](INFO): Done Waiting.
2024-05-06T14:25:58.348Z,1715005558.348 [Default:A.Wait] Stopped
2024-05-06T14:25:58.348Z,1715005558.348 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2024-05-06T14:25:58.753Z,1715005558.753 [Default:CheckIn] Running Loop=1
2024-05-06T14:25:58.753Z,1715005558.753 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-05-06T14:25:58.753Z,1715005558.753 [Default:CheckIn:Read_GPS] Running Loop=1
2024-05-06T14:25:59.164Z,1715005559.164 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2024-05-06T14:27:08.634Z,1715005628.634 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2024-05-06T14:27:15.494Z,1715005635.494 [BPC1](ERROR): BPC1B got IPBS message with 5 sticks (min is 7).
2024-05-06T14:27:23.170Z,1715005643.170 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-05-06T14:27:28.847Z,1715005648.847 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2024-05-06T14:27:28.847Z,1715005648.847 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-05-06T14:27:28.849Z,1715005648.849 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 2
2024-05-06T14:27:28.849Z,1715005648.849 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2024-05-06T14:27:28.850Z,1715005648.850 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2
2024-05-06T14:27:28.850Z,1715005648.850 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2024-05-06T14:27:28.861Z,1715005648.861 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-05-06T14:27:28.861Z,1715005648.861 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2024-05-06T14:27:28.861Z,1715005648.861 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2024-05-06T14:27:29.271Z,1715005649.271 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-05-06T14:27:29.271Z,1715005649.271 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2024-05-06T14:27:29.271Z,1715005649.271 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2024-05-06T14:27:29.271Z,1715005649.271 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 2
2024-05-06T14:27:29.280Z,1715005649.280 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2024-05-06T14:27:29.280Z,1715005649.280 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2
2024-05-06T14:27:29.644Z,1715005649.644 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2024-05-06T14:27:39.735Z,1715005659.735 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-05-06T14:27:52.338Z,1715005672.338 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-05-06T14:27:56.723Z,1715005676.723 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-05-06T14:28:04.458Z,1715005684.458 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-05-06T14:28:12.882Z,1715005692.882 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-05-06T14:28:29.850Z,1715005709.850 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-05-06T14:28:34.029Z,1715005714.029 [CommandExec](IMPORTANT): got command burn on
2024-05-06T14:28:34.029Z,1715005714.029 [CommandExec](IMPORTANT): Activating dropweight wire
2024-05-06T14:28:41.225Z,1715005721.225 [CommandExec](IMPORTANT): got command burn off
2024-05-06T14:28:41.225Z,1715005721.225 [CommandExec](IMPORTANT): Deactivating dropweight wire
2024-05-06T14:28:46.818Z,1715005726.818 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-05-06T14:29:02.978Z,1715005742.978 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7).
2024-05-06T14:29:03.849Z,1715005743.849 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-05-06T14:29:18.397Z,1715005758.397 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-05-06T14:29:19.604Z,1715005759.604 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2024-05-06T14:29:29.710Z,1715005769.710 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2024-05-06T14:29:58.743Z,1715005798.743 [BPC1](INFO): Calculating totals. Valid battery stick count: 45. Valid reserve battery stick count: 5.
2024-05-06T14:29:58.746Z,1715005798.746 [BPC1](INFO): Received data from all battery sticks.
2024-05-06T14:30:29.853Z,1715005829.853 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2024-05-06T14:30:29.853Z,1715005829.853 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-05-06T14:30:29.855Z,1715005829.855 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 3
2024-05-06T14:30:29.855Z,1715005829.855 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2024-05-06T14:30:29.856Z,1715005829.856 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 3
2024-05-06T14:30:29.856Z,1715005829.856 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2024-05-06T14:30:29.867Z,1715005829.867 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-05-06T14:30:29.867Z,1715005829.867 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2024-05-06T14:30:29.867Z,1715005829.867 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2024-05-06T14:30:30.280Z,1715005830.280 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-05-06T14:30:30.280Z,1715005830.280 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2024-05-06T14:30:30.281Z,1715005830.281 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2024-05-06T14:30:30.281Z,1715005830.281 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 3
2024-05-06T14:30:30.281Z,1715005830.281 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2024-05-06T14:30:30.281Z,1715005830.281 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 3
2024-05-06T14:30:30.677Z,1715005830.677 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2024-05-06T14:30:58.944Z,1715005858.944 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-05-06T14:25:58.8Z
2024-05-06T14:30:58.944Z,1715005858.944 [Default:CheckIn:Read_GPS] Stopped
2024-05-06T14:30:58.944Z,1715005858.944 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-05-06T14:30:59.354Z,1715005859.354 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2024-05-06T14:31:05.790Z,1715005865.790 [DataOverHttps](INFO): Sending 168 bytes from file Logs/20240506T142116/Courier0004.lzma
2024-05-06T14:31:06.786Z,1715005866.786 [DataOverHttps](INFO): Moved sent file to Logs/20240506T142116/Courier0004.lzma.bak
2024-05-06T14:31:06.786Z,1715005866.786 [DataOverHttps](INFO): SBD MOMSN=19983585
2024-05-06T14:31:22.320Z,1715005882.320 [DataOverHttps](INFO): Sending 266 bytes from file Logs/20240506T142116/Express0005.lzma
2024-05-06T14:31:23.322Z,1715005883.322 [DataOverHttps](INFO): Moved sent file to Logs/20240506T142116/Express0005.lzma.bak
2024-05-06T14:31:23.322Z,1715005883.322 [DataOverHttps](INFO): SBD MOMSN=19983587
2024-05-06T14:31:24.406Z,1715005884.406 [Default:CheckIn:Read_Iridium] Stopped
2024-05-06T14:31:24.406Z,1715005884.406 [Default:CheckIn:C.Wait] Running Loop=1
2024-05-06T14:31:24.406Z,1715005884.406 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-05-06T14:32:09.229Z,1715005929.229 [NAL9602](FAULT): GPS failed to acquire within timeout.
2024-05-06T14:32:09.230Z,1715005929.230 [NAL9602] Data Fault, FailCount= 1
2024-05-06T14:32:09.230Z,1715005929.230 [NAL9602](ERROR): Data Fault
2024-05-06T14:32:09.249Z,1715005929.249 [CBIT](ERROR): Data Fault in component: NAL9602
2024-05-06T14:32:09.630Z,1715005929.630 [NAL9602](INFO): Powering down
2024-05-06T14:32:10.455Z,1715005930.455 [CBIT](INFO): Clearing failed state for component NAL9602
2024-05-06T14:32:10.455Z,1715005930.455 [NAL9602] No Fault, FailCount= 1
2024-05-06T14:32:20.538Z,1715005940.538 [CommandExec](IMPORTANT): got command failComponent
2024-05-06T14:32:20.538Z,1715005940.538 [CommandExec](IMPORTANT): Failed components:
2024-05-06T14:32:20.538Z,1715005940.538 [CommandExec](IMPORTANT): No failed Components.
2024-05-06T14:32:39.933Z,1715005959.933 [NAL9602](INFO): Powering up NAL9602
2024-05-06T14:32:50.838Z,1715005970.838 [NAL9602](INFO): NAL9602 initialized
2024-05-06T14:33:30.853Z,1715006010.853 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2024-05-06T14:33:30.853Z,1715006010.853 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-05-06T14:33:30.854Z,1715006010.854 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 4
2024-05-06T14:33:30.854Z,1715006010.854 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2024-05-06T14:33:30.856Z,1715006010.856 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 4
2024-05-06T14:33:30.856Z,1715006010.856 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2024-05-06T14:33:30.924Z,1715006010.924 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-05-06T14:33:30.928Z,1715006010.928 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2024-05-06T14:33:30.928Z,1715006010.928 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2024-05-06T14:33:31.271Z,1715006011.271 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-05-06T14:33:31.271Z,1715006011.271 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2024-05-06T14:33:31.272Z,1715006011.272 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2024-05-06T14:33:31.272Z,1715006011.272 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 4
2024-05-06T14:33:31.273Z,1715006011.273 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2024-05-06T14:33:31.273Z,1715006011.273 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 4
2024-05-06T14:33:31.673Z,1715006011.673 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2024-05-06T14:36:24.992Z,1715006184.992 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-05-06T14:36:24.992Z,1715006184.992 [Default:CheckIn:C.Wait] Stopped
2024-05-06T14:36:24.992Z,1715006184.992 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-05-06T14:36:24.992Z,1715006184.992 [Default:CheckIn:D] Running Loop=1
2024-05-06T14:36:25.403Z,1715006185.403 [Default:CheckIn:D] Stopped
2024-05-06T14:36:25.403Z,1715006185.403 [Default:CheckIn:E] Running Loop=1
2024-05-06T14:36:25.780Z,1715006185.780 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 10.672658 min
2024-05-06T14:36:25.780Z,1715006185.780 [Default:CheckIn:E] Stopped
2024-05-06T14:36:25.780Z,1715006185.780 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-05-06T14:36:25.781Z,1715006185.781 [Default:CheckIn] Stopped
2024-05-06T14:36:25.781Z,1715006185.781 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-05-06T14:36:25.781Z,1715006185.781 [Default:CheckIn](INFO): Running loop #2
2024-05-06T14:36:25.781Z,1715006185.781 [Default:CheckIn] Running Loop=2
2024-05-06T14:36:25.781Z,1715006185.781 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-05-06T14:36:25.781Z,1715006185.781 [Default:CheckIn:Read_GPS] Running Loop=1
2024-05-06T14:36:31.856Z,1715006191.856 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5
2024-05-06T14:36:31.856Z,1715006191.856 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-05-06T14:36:31.857Z,1715006191.857 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 5
2024-05-06T14:36:31.857Z,1715006191.857 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2024-05-06T14:36:31.859Z,1715006191.859 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 5
2024-05-06T14:36:31.859Z,1715006191.859 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2024-05-06T14:36:31.882Z,1715006191.882 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-05-06T14:36:31.882Z,1715006191.882 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2024-05-06T14:36:31.883Z,1715006191.883 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2024-05-06T14:36:32.254Z,1715006192.254 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-05-06T14:36:32.254Z,1715006192.254 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5
2024-05-06T14:36:32.255Z,1715006192.255 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2024-05-06T14:36:32.255Z,1715006192.255 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 5
2024-05-06T14:36:32.255Z,1715006192.255 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2024-05-06T14:36:32.255Z,1715006192.255 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 5
2024-05-06T14:36:32.660Z,1715006192.660 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2024-05-06T14:38:06.561Z,1715006286.561 [DataOverHttps](IMPORTANT): SBD MTMSN=20240506T143805
2024-05-06T14:38:13.816Z,1715006293.816 [DataOverHttps](INFO): Received command: strobe off
2024-05-06T14:38:13.913Z,1715006293.913 [CommandExec](IMPORTANT): got command strobe off
2024-05-06T14:38:13.913Z,1715006293.913 [CommandExec](IMPORTANT): Deactivating strobe
2024-05-06T14:39:32.835Z,1715006372.835 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6
2024-05-06T14:39:32.835Z,1715006372.835 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-05-06T14:39:32.837Z,1715006372.837 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 6
2024-05-06T14:39:32.837Z,1715006372.837 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2024-05-06T14:39:32.838Z,1715006372.838 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 6
2024-05-06T14:39:32.838Z,1715006372.838 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2024-05-06T14:39:32.849Z,1715006372.849 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-05-06T14:39:32.849Z,1715006372.849 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2024-05-06T14:39:32.849Z,1715006372.849 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2024-05-06T14:39:33.256Z,1715006373.256 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-05-06T14:39:33.256Z,1715006373.256 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6
2024-05-06T14:39:33.257Z,1715006373.257 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2024-05-06T14:39:33.257Z,1715006373.257 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 6
2024-05-06T14:39:33.257Z,1715006373.257 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2024-05-06T14:39:33.257Z,1715006373.257 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 6
2024-05-06T14:39:33.685Z,1715006373.685 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2024-05-06T14:41:25.980Z,1715006485.980 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-05-06T14:36:25.8Z
2024-05-06T14:41:25.980Z,1715006485.980 [Default:CheckIn:Read_GPS] Stopped
2024-05-06T14:41:25.980Z,1715006485.980 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-05-06T14:41:33.563Z,1715006493.563 [DataOverHttps](INFO): Sending 37 bytes from file Logs/20240506T142116/Courier0007.lzma
2024-05-06T14:41:34.566Z,1715006494.566 [DataOverHttps](INFO): Moved sent file to Logs/20240506T142116/Courier0007.lzma.bak
2024-05-06T14:41:34.566Z,1715006494.566 [DataOverHttps](INFO): SBD MOMSN=19983616
2024-05-06T14:41:50.172Z,1715006510.172 [DataOverHttps](INFO): Sending 312 bytes from file Logs/20240506T142116/Express0008.lzma
2024-05-06T14:41:51.174Z,1715006511.174 [DataOverHttps](INFO): Moved sent file to Logs/20240506T142116/Express0008.lzma.bak
2024-05-06T14:41:51.174Z,1715006511.174 [DataOverHttps](INFO): SBD MOMSN=19983618
2024-05-06T14:42:06.716Z,1715006526.716 [DataOverHttps](INFO): Sending 38 bytes from file Logs/20240506T142116/Express0011.lzma
2024-05-06T14:42:07.718Z,1715006527.718 [DataOverHttps](INFO): Moved sent file to Logs/20240506T142116/Express0011.lzma.bak
2024-05-06T14:42:07.718Z,1715006527.718 [DataOverHttps](INFO): SBD MOMSN=19983628
2024-05-06T14:42:08.792Z,1715006528.792 [Default:CheckIn:Read_Iridium] Stopped
2024-05-06T14:42:08.792Z,1715006528.792 [Default:CheckIn:C.Wait] Running Loop=1
2024-05-06T14:42:08.792Z,1715006528.792 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-05-06T14:42:33.834Z,1715006553.834 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7
2024-05-06T14:42:33.834Z,1715006553.834 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2024-05-06T14:42:33.835Z,1715006553.835 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 7
2024-05-06T14:42:33.835Z,1715006553.835 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2024-05-06T14:42:33.837Z,1715006553.837 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 7
2024-05-06T14:42:33.837Z,1715006553.837 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2024-05-06T14:42:33.848Z,1715006553.848 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2024-05-06T14:42:33.848Z,1715006553.848 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2024-05-06T14:42:33.848Z,1715006553.848 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2024-05-06T14:42:34.258Z,1715006554.258 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2024-05-06T14:42:34.258Z,1715006554.258 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7
2024-05-06T14:42:34.259Z,1715006554.259 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2024-05-06T14:42:34.259Z,1715006554.259 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 7
2024-05-06T14:42:34.259Z,1715006554.259 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2024-05-06T14:42:34.259Z,1715006554.259 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 7
2024-05-06T14:42:34.629Z,1715006554.629 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2024-05-06T14:42:42.724Z,1715006562.724 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,144241.00,A,3648.17035,N,12147.26504,W,0.408,78.87,060524,,,A*4E
2024-05-06T14:42:42.727Z,1715006562.727 [NAL9602](INFO): GPS fix at 20240506T144241: (36.802839, -121.787751)
2024-05-06T14:43:15.477Z,1715006595.477 [NAL9602](INFO): Not Powering down - fast GPS
2024-05-06T14:45:34.939Z,1715006734.939 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1
2024-05-06T14:45:34.940Z,1715006734.940 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2024-05-06T14:45:34.951Z,1715006734.951 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2024-05-06T14:45:35.366Z,1715006735.366 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2024-05-06T14:45:35.367Z,1715006735.367 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1
2024-05-06T14:47:09.522Z,1715006829.522 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-05-06T14:47:09.522Z,1715006829.522 [Default:CheckIn:C.Wait] Stopped
2024-05-06T14:47:09.522Z,1715006829.522 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-05-06T14:47:09.522Z,1715006829.522 [Default:CheckIn:D] Running Loop=1
2024-05-06T14:47:09.927Z,1715006829.927 [Default:CheckIn:D] Stopped
2024-05-06T14:47:09.927Z,1715006829.927 [Default:CheckIn:E] Running Loop=1
2024-05-06T14:47:10.343Z,1715006830.343 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 21.414722 min
2024-05-06T14:47:10.344Z,1715006830.344 [Default:CheckIn:E] Stopped
2024-05-06T14:47:10.348Z,1715006830.348 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-05-06T14:47:10.348Z,1715006830.348 [Default:CheckIn] Stopped
2024-05-06T14:47:10.348Z,1715006830.348 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-05-06T14:47:10.348Z,1715006830.348 [Default:CheckIn](INFO): Running loop #3
2024-05-06T14:47:10.348Z,1715006830.348 [Default:CheckIn] Running Loop=3
2024-05-06T14:47:10.348Z,1715006830.348 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-05-06T14:47:10.349Z,1715006830.349 [Default:CheckIn:Read_GPS] Running Loop=1
2024-05-06T14:47:12.331Z,1715006832.331 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,144710.00,A,3648.17059,N,12147.28610,W,0.136,313.82,060524,,,A*7E
2024-05-06T14:47:12.334Z,1715006832.334 [NAL9602](INFO): GPS fix at 20240506T144710: (36.802843, -121.788102)
2024-05-06T14:47:12.349Z,1715006832.349 [Default:CheckIn:Read_GPS] Stopped
2024-05-06T14:47:12.349Z,1715006832.349 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-05-06T14:47:19.836Z,1715006839.836 [DataOverHttps](INFO): Sending 223 bytes from file Logs/20240506T142116/Courier0013.lzma
2024-05-06T14:47:20.838Z,1715006840.838 [DataOverHttps](INFO): Moved sent file to Logs/20240506T142116/Courier0013.lzma.bak
2024-05-06T14:47:20.838Z,1715006840.838 [DataOverHttps](INFO): SBD MOMSN=19983636
2024-05-06T14:47:36.892Z,1715006856.892 [DataOverHttps](INFO): Sending 266 bytes from file Logs/20240506T142116/Express0014.lzma
2024-05-06T14:47:37.894Z,1715006857.894 [DataOverHttps](INFO): Moved sent file to Logs/20240506T142116/Express0014.lzma.bak
2024-05-06T14:47:37.894Z,1715006857.894 [DataOverHttps](INFO): SBD MOMSN=19983639
2024-05-06T14:47:39.035Z,1715006859.035 [Default:CheckIn:Read_Iridium] Stopped
2024-05-06T14:47:39.035Z,1715006859.035 [Default:CheckIn:C.Wait] Running Loop=1
2024-05-06T14:47:39.035Z,1715006859.035 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-05-06T14:48:31.121Z,1715006911.121 [NAL9602](INFO): SBD MO Status=2, MOMSN=13535, MT Status=2, MTMSN=0
2024-05-06T14:48:31.121Z,1715006911.121 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2024-05-06T14:48:35.978Z,1715006915.978 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1
2024-05-06T14:48:35.978Z,1715006915.978 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2024-05-06T14:48:35.990Z,1715006915.990 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2024-05-06T14:48:36.415Z,1715006916.415 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2024-05-06T14:48:36.415Z,1715006916.415 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1
2024-05-06T14:48:44.108Z,1715006924.108 [NAL9602](INFO): SBD MO Status=0, MOMSN=13535, MT Status=0, MTMSN=0
2024-05-06T14:48:44.108Z,1715006924.108 [NAL9602](INFO): No messages in MT queue
2024-05-06T14:49:14.813Z,1715006954.813 [NAL9602](INFO): Not Powering down - fast GPS
2024-05-06T14:51:37.083Z,1715007097.083 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 2
2024-05-06T14:51:37.083Z,1715007097.083 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2024-05-06T14:51:37.094Z,1715007097.094 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2024-05-06T14:51:37.505Z,1715007097.505 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2024-05-06T14:51:37.505Z,1715007097.505 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 2
2024-05-06T14:52:39.719Z,1715007159.719 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-05-06T14:52:39.719Z,1715007159.719 [Default:CheckIn:C.Wait] Stopped
2024-05-06T14:52:39.719Z,1715007159.719 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-05-06T14:52:39.719Z,1715007159.719 [Default:CheckIn:D] Running Loop=1
2024-05-06T14:52:40.119Z,1715007160.119 [Default:CheckIn:D] Stopped
2024-05-06T14:52:40.119Z,1715007160.119 [Default:CheckIn:E] Running Loop=1
2024-05-06T14:52:40.515Z,1715007160.515 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 26.917928 min
2024-05-06T14:52:40.515Z,1715007160.515 [Default:CheckIn:E] Stopped
2024-05-06T14:52:40.516Z,1715007160.516 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-05-06T14:52:40.536Z,1715007160.536 [Default:CheckIn] Stopped
2024-05-06T14:52:40.536Z,1715007160.536 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-05-06T14:52:40.536Z,1715007160.536 [Default:CheckIn](INFO): Running loop #4
2024-05-06T14:52:40.536Z,1715007160.536 [Default:CheckIn] Running Loop=4
2024-05-06T14:52:40.536Z,1715007160.536 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-05-06T14:52:40.536Z,1715007160.536 [Default:CheckIn:Read_GPS] Running Loop=1
2024-05-06T14:52:42.531Z,1715007162.531 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,145240.00,A,3648.16676,N,12147.28542,W,0.350,313.82,060524,,,A*73
2024-05-06T14:52:42.533Z,1715007162.533 [NAL9602](INFO): GPS fix at 20240506T145240: (36.802779, -121.788090)
2024-05-06T14:52:42.582Z,1715007162.582 [Default:CheckIn:Read_GPS] Stopped
2024-05-06T14:52:42.582Z,1715007162.582 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-05-06T14:52:52.436Z,1715007172.436 [DataOverHttps](INFO): Sending 71 bytes from file Logs/20240506T142116/Courier0016.lzma
2024-05-06T14:52:53.438Z,1715007173.438 [DataOverHttps](INFO): Moved sent file to Logs/20240506T142116/Courier0016.lzma.bak
2024-05-06T14:52:53.438Z,1715007173.438 [DataOverHttps](INFO): SBD MOMSN=19983656
2024-05-06T14:53:09.384Z,1715007189.384 [DataOverHttps](INFO): Sending 132 bytes from file Logs/20240506T142116/Express0017.lzma
2024-05-06T14:53:10.386Z,1715007190.386 [DataOverHttps](INFO): Moved sent file to Logs/20240506T142116/Express0017.lzma.bak
2024-05-06T14:53:10.386Z,1715007190.386 [DataOverHttps](INFO): SBD MOMSN=19983659
2024-05-06T14:53:11.426Z,1715007191.426 [Default:CheckIn:Read_Iridium] Stopped
2024-05-06T14:53:11.426Z,1715007191.426 [Default:CheckIn:C.Wait] Running Loop=1
2024-05-06T14:53:11.426Z,1715007191.426 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-05-06T14:53:27.967Z,1715007207.967 [NAL9602](INFO): SBD MO Status=0, MOMSN=13536, MT Status=0, MTMSN=0
2024-05-06T14:53:27.967Z,1715007207.967 [NAL9602](INFO): No messages in MT queue
2024-05-06T14:53:58.669Z,1715007238.669 [NAL9602](INFO): Not Powering down - fast GPS
2024-05-06T14:54:38.293Z,1715007278.293 [DeadReckonWithRespectToSeafloor] Software Fault, FailCount= 1
2024-05-06T14:54:38.293Z,1715007278.293 [DeadReckonWithRespectToSeafloor](ERROR): Software Fault
2024-05-06T14:54:38.316Z,1715007278.316 [CBIT](ERROR): Software Fault in component: DeadReckonWithRespectToSeafloor
2024-05-06T14:54:38.688Z,1715007278.688 [CBIT](INFO): Clearing failed state for component DeadReckonWithRespectToSeafloor
2024-05-06T14:54:38.688Z,1715007278.688 [DeadReckonWithRespectToSeafloor] No Fault, FailCount= 1
2024-05-06T14:54:53.349Z,1715007293.349 [DataOverHttps](IMPORTANT): SBD MTMSN=20240506T145452
2024-05-06T14:55:00.836Z,1715007300.836 [DataOverHttps](INFO): Received command: restart app
2024-05-06T14:55:00.901Z,1715007300.901 [CommandExec](IMPORTANT): got command restart application
2024-05-06T14:55:01.904Z,1715007301.904 [Supervisor](INFO): Stop Mission called by Supervisor::terminate
2024-05-06T14:55:01.904Z,1715007301.904 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread.
2024-05-06T14:55:01.904Z,1715007301.904 [CommandExec](INFO): Uninitializing the command executive.
2024-05-06T14:55:01.905Z,1715007301.905 [CommandExec](INFO): Uninitializing the command scheduler.
2024-05-06T14:55:01.905Z,1715007301.905 [CommandExec ThreadHandler](INFO): Thread cancelled.
2024-05-06T14:55:01.905Z,1715007301.905 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye!
2024-05-06T14:55:01.905Z,1715007301.905 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2024-05-06T14:55:01.906Z,1715007301.906 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2024-05-06T14:55:01.906Z,1715007301.906 [NavChartDb](INFO): Join timeout helper Thread ID is 1028
2024-05-06T14:55:01.961Z,1715007301.961 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2024-05-06T14:55:01.961Z,1715007301.961 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2024-05-06T14:55:01.968Z,1715007301.968 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2024-05-06T14:55:01.968Z,1715007301.968 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2024-05-06T14:55:01.968Z,1715007301.968 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 1029
2024-05-06T14:55:02.304Z,1715007302.304 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2024-05-06T14:55:02.304Z,1715007302.304 [WetLabsBB2FL](INFO): Powering down
2024-05-06T14:55:02.305Z,1715007302.305 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2024-05-06T14:55:02.308Z,1715007302.308 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2024-05-06T14:55:02.308Z,1715007302.308 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2024-05-06T14:55:02.308Z,1715007302.308 [CTD_Seabird](INFO): Join timeout helper Thread ID is 1030
2024-05-06T14:55:02.344Z,1715007302.344 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2024-05-06T14:55:02.345Z,1715007302.345 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2024-05-06T14:55:02.352Z,1715007302.352 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler
2024-05-06T14:55:02.352Z,1715007302.352 [DAT ThreadHandler](INFO): Thread cancelled.
2024-05-06T14:55:02.353Z,1715007302.353 [DAT](INFO): Join timeout helper Thread ID is 1031
2024-05-06T14:55:02.380Z,1715007302.380 [DAT](INFO): Powering down
2024-05-06T14:55:02.457Z,1715007302.457 [DAT ThreadHandler](INFO): Uninitializing protected caller thread.
2024-05-06T14:55:02.457Z,1715007302.457 [DAT](INFO): Powering down
2024-05-06T14:55:02.458Z,1715007302.458 [DAT ThreadHandler](INFO): Thread cancelled.
2024-05-06T14:55:02.472Z,1715007302.472 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2024-05-06T14:55:02.472Z,1715007302.472 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2024-05-06T14:55:02.472Z,1715007302.472 [Radio_Surface](INFO): Join timeout helper Thread ID is 1032
2024-05-06T14:55:02.652Z,1715007302.652 [Radio_Surface](INFO): Powering down
2024-05-06T14:55:02.653Z,1715007302.653 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2024-05-06T14:55:02.653Z,1715007302.653 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2024-05-06T14:55:02.673Z,1715007302.673 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2024-05-06T14:55:02.673Z,1715007302.673 [Onboard ThreadHandler](INFO): Thread cancelled.
2024-05-06T14:55:02.673Z,1715007302.673 [Onboard](INFO): Join timeout helper Thread ID is 1033
2024-05-06T14:55:02.840Z,1715007302.840 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2024-05-06T14:55:04.408Z,1715007304.408 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2024-05-06T14:55:04.409Z,1715007304.409 [Onboard ThreadHandler](INFO): Thread cancelled.
2024-05-06T14:55:04.417Z,1715007304.417 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2024-05-06T14:55:04.417Z,1715007304.417 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2024-05-06T14:55:04.417Z,1715007304.417 [DataOverHttps](INFO): Join timeout helper Thread ID is 1034
2024-05-06T14:55:04.848Z,1715007304.848 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2024-05-06T14:55:04.848Z,1715007304.848 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2024-05-06T14:55:04.857Z,1715007304.857 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler
2024-05-06T14:55:04.857Z,1715007304.857 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2024-05-06T14:55:04.857Z,1715007304.857 [BackseatComponent](INFO): Join timeout helper Thread ID is 1035
2024-05-06T14:55:04.860Z,1715007304.860 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread.
2024-05-06T14:55:04.861Z,1715007304.861 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2024-05-06T14:55:04.877Z,1715007304.877 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2024-05-06T14:55:04.877Z,1715007304.877 [logger ThreadHandler](INFO): Thread cancelled.
2024-05-06T14:55:04.877Z,1715007304.877 [logger](INFO): Join timeout helper Thread ID is 1036
2024-05-06T14:55:04.880Z,1715007304.880 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2024-05-06T14:55:04.880Z,1715007304.880 [logger ThreadHandler](INFO): Thread cancelled.
2024-05-06T14:55:04.897Z,1715007304.897 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2024-05-06T14:55:04.897Z,1715007304.897 [CommandLine ThreadHandler](INFO): Thread cancelled.
2024-05-06T14:55:04.897Z,1715007304.897 [CommandLine](INFO): Join timeout helper Thread ID is 1037
2024-05-06T14:55:04.971Z,1715007304.971 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2024-05-06T14:55:04.971Z,1715007304.971 [CommandLine ThreadHandler](INFO): Thread cancelled.
2024-05-06T14:55:04.981Z,1715007304.981 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler
2024-05-06T14:55:04.981Z,1715007304.981 [CommandExec ThreadHandler](INFO): Thread cancelled.
2024-05-06T14:55:04.981Z,1715007304.981 [CommandExec](INFO): Join timeout helper Thread ID is 1038
2024-05-06T14:55:04.985Z,1715007304.985 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2024-05-06T14:55:04.985Z,1715007304.985 [controlThread ThreadHandler](INFO): Thread cancelled.
2024-05-06T14:55:04.985Z,1715007304.985 [controlThread](INFO): Join timeout helper Thread ID is 1039
2024-05-06T14:55:05.009Z,1715007305.009 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2024-05-06T14:55:05.009Z,1715007305.009 [controlThread](DEBUG): Uninitializing ControlThread
2024-05-06T14:55:05.010Z,1715007305.010 [AHRS_M2](INFO): Powering down
2024-05-06T14:55:05.081Z,1715007305.081 [NAL9602](INFO): Powering down
2024-05-06T14:55:05.082Z,1715007305.082 [Sonardyne_Nano](INFO): Powering down
2024-05-06T14:55:05.200Z,1715007305.200 [Waterlinked](INFO): Powering down
2024-05-06T14:55:05.203Z,1715007305.203 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2024-05-06T14:55:05.204Z,1715007305.204 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2024-05-06T14:55:05.205Z,1715007305.205 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2024-05-06T14:55:05.205Z,1715007305.205 [MissionManager](INFO): Uninitializing Mission Default
2024-05-06T14:55:05.205Z,1715007305.205 [Default] Stopped
2024-05-06T14:55:05.205Z,1715007305.205 [Default](DEBUG): Aggregate::uninitialize Default
2024-05-06T14:55:05.205Z,1715007305.205 [Default:B.GoToSurface] Stopped
2024-05-06T14:55:05.205Z,1715007305.205 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2024-05-06T14:55:05.205Z,1715007305.205 [Default:CheckIn] Stopped
2024-05-06T14:55:05.206Z,1715007305.206 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-05-06T14:55:05.206Z,1715007305.206 [Default:CheckIn:C.Wait] Stopped
2024-05-06T14:55:05.206Z,1715007305.206 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-05-06T14:55:05.209Z,1715007305.209 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2024-05-06T14:55:05.209Z,1715007305.209 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2024-05-06T14:55:05.209Z,1715007305.209 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2024-05-06T14:55:05.210Z,1715007305.210 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2024-05-06T14:55:05.210Z,1715007305.210 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2024-05-06T14:55:05.210Z,1715007305.210 [BuoyancyServo](INFO): Powering down
2024-05-06T14:55:05.224Z,1715007305.224 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2024-05-06T14:55:05.224Z,1715007305.224 [ElevatorServo](INFO): Powering down
2024-05-06T14:55:05.225Z,1715007305.225 [MassServo](DEBUG): Uninitialize Mass Servo.
2024-05-06T14:55:05.225Z,1715007305.225 [MassServo](INFO): Powering down
2024-05-06T14:55:05.226Z,1715007305.226 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2024-05-06T14:55:05.226Z,1715007305.226 [RudderServo](INFO): Powering down
2024-05-06T14:55:05.227Z,1715007305.227 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2024-05-06T14:55:05.227Z,1715007305.227 [ThrusterHE](INFO): Powering down
2024-05-06T14:55:05.228Z,1715007305.228 [SBIT](DEBUG): Uninitialize SBIT Component.
2024-05-06T14:55:05.228Z,1715007305.228 [IBIT](DEBUG): Uninitialize IBIT Component.
2024-05-06T14:55:05.229Z,1715007305.229 [CBIT](DEBUG): Uninitialize CBIT Component.
2024-05-06T14:55:05.229Z,1715007305.229 [CBIT](DEBUG): Powering off loads.
2024-05-06T14:55:05.240Z,1715007305.240 [CBIT](DEBUG): Disabling WDT.
2024-05-06T14:55:05.252Z,1715007305.252 [CBIT](DEBUG): Opening all GF detection circuits.
2024-05-06T14:55:05.253Z,1715007305.253 [controlThread ThreadHandler](INFO): Thread cancelled.
2024-05-06T14:55:05.289Z,1715007305.289 [DAT ThreadHandler](INFO): Thread cancelled.
2024-05-06T14:55:05.294Z,1715007305.294 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2024-05-06T14:55:05.296Z,1715007305.296 [Onboard ThreadHandler](INFO): Thread cancelled.
2024-05-06T14:55:05.302Z,1715007305.302 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2024-05-06T14:55:05.344Z,1715007305.344 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2024-05-06T14:55:05.432Z,1715007305.432 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2024-05-06T14:55:05.437Z,1715007305.437 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2024-05-06T14:55:05.445Z,1715007305.445 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2024-05-06T14:55:05.497Z,1715007305.497 [logger ThreadHandler](INFO): Thread cancelled.