2023-03-02T23:40:38.945Z,1677800438.945 [Supervisor](DEBUG): Initializing supervisor.
2023-03-02T23:40:38.950Z,1677800438.950 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2023-03-02T23:40:38.951Z,1677800438.951 [SyncHandler](INFO): Protected caller Thread ID is 1917
2023-03-02T23:40:38.951Z,1677800438.951 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2023-03-02T23:40:38.952Z,1677800438.952 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2023-03-02T23:40:38.953Z,1677800438.953 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 1918
2023-03-02T23:40:38.957Z,1677800438.957 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2023-03-02T23:40:38.974Z,1677800438.974 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2023-03-02T23:40:38.975Z,1677800438.975 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2023-03-02T23:40:38.976Z,1677800438.976 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 1919
2023-03-02T23:40:38.980Z,1677800438.980 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2023-03-02T23:40:38.981Z,1677800438.981 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2023-03-02T23:40:38.981Z,1677800438.981 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 1920
2023-03-02T23:40:38.983Z,1677800438.983 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2023-03-02T23:40:38.984Z,1677800438.984 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2023-03-02T23:40:38.984Z,1677800438.984 [logger ThreadHandler](INFO): Protected caller Thread ID is 1921
2023-03-02T23:40:38.988Z,1677800438.988 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2023-03-02T23:40:38.988Z,1677800438.988 [Supervisor](INFO): Looking for Config files in directory: Config/
2023-03-02T23:40:38.990Z,1677800438.990 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2023-03-02T23:40:39.512Z,1677800439.512 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2023-03-02T23:40:39.513Z,1677800439.513 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2023-03-02T23:40:39.812Z,1677800439.812 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2023-03-02T23:40:39.813Z,1677800439.813 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2023-03-02T23:40:39.894Z,1677800439.894 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2023-03-02T23:40:40.106Z,1677800440.106 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2023-03-02T23:40:40.106Z,1677800440.106 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2023-03-02T23:40:40.186Z,1677800440.186 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2023-03-02T23:40:40.282Z,1677800440.282 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2023-03-02T23:40:40.283Z,1677800440.283 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2023-03-02T23:40:40.622Z,1677800440.622 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2023-03-02T23:40:40.623Z,1677800440.623 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2023-03-02T23:40:40.753Z,1677800440.753 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2023-03-02T23:40:40.754Z,1677800440.754 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2023-03-02T23:40:41.235Z,1677800441.235 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2023-03-02T23:40:41.236Z,1677800441.236 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2023-03-02T23:40:41.416Z,1677800441.416 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2023-03-02T23:40:41.416Z,1677800441.416 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2023-03-02T23:40:41.800Z,1677800441.800 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2023-03-02T23:40:41.801Z,1677800441.801 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2023-03-02T23:40:42.072Z,1677800442.072 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2023-03-02T23:40:42.073Z,1677800442.073 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2023-03-02T23:40:42.181Z,1677800442.181 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2023-03-02T23:40:42.182Z,1677800442.182 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2023-03-02T23:40:43.624Z,1677800443.624 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2023-03-02T23:40:43.625Z,1677800443.625 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2023-03-02T23:40:43.945Z,1677800443.945 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2023-03-02T23:40:43.945Z,1677800443.945 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2023-03-02T23:40:44.160Z,1677800444.160 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2023-03-02T23:40:44.162Z,1677800444.162 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-triton/
2023-03-02T23:40:44.163Z,1677800444.163 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/vehicle.cfg
2023-03-02T23:40:44.345Z,1677800444.345 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/secure.cfg
2023-03-02T23:40:44.429Z,1677800444.429 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Science.cfg
2023-03-02T23:40:44.561Z,1677800444.561 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Simulator.cfg
2023-03-02T23:40:44.651Z,1677800444.651 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Battery.cfg
2023-03-02T23:40:44.915Z,1677800444.915 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2023-03-02T23:40:44.915Z,1677800444.915 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/logger.cfg
2023-03-02T23:40:45.019Z,1677800445.019 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Servo.cfg
2023-03-02T23:40:45.130Z,1677800445.130 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Navigation.cfg
2023-03-02T23:40:45.242Z,1677800445.242 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Sensor.cfg
2023-03-02T23:40:45.386Z,1677800445.386 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Control.cfg
2023-03-02T23:40:45.486Z,1677800445.486 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/BIT.cfg
2023-03-02T23:40:45.580Z,1677800445.580 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2023-03-02T23:40:45.593Z,1677800445.593 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2023-03-02T23:40:45.604Z,1677800445.604 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2023-03-02T23:40:45.605Z,1677800445.605 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2023-03-02T23:40:45.709Z,1677800445.709 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2023-03-02T23:40:45.710Z,1677800445.710 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2023-03-02T23:40:45.760Z,1677800445.760 [VerticalControl](DEBUG): Construct VerticalControl.
2023-03-02T23:40:45.818Z,1677800445.818 [VerticalControl] Loaded
2023-03-02T23:40:45.819Z,1677800445.819 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2023-03-02T23:40:45.822Z,1677800445.822 [HorizontalControl](DEBUG): Construct HorizontalControl.
2023-03-02T23:40:45.861Z,1677800445.861 [HorizontalControl] Loaded
2023-03-02T23:40:45.862Z,1677800445.862 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2023-03-02T23:40:45.864Z,1677800445.864 [SpeedControl](DEBUG): Construct SpeedControl.
2023-03-02T23:40:45.867Z,1677800445.867 [SpeedControl] Loaded
2023-03-02T23:40:45.867Z,1677800445.867 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2023-03-02T23:40:45.870Z,1677800445.870 [LoopControl](DEBUG): Construct LoopControl.
2023-03-02T23:40:45.870Z,1677800445.870 [LoopControl] Loaded
2023-03-02T23:40:45.870Z,1677800445.870 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2023-03-02T23:40:45.871Z,1677800445.871 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2023-03-02T23:40:45.871Z,1677800445.871 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2023-03-02T23:40:46.004Z,1677800446.004 [BuoyancyServo] Loaded
2023-03-02T23:40:46.004Z,1677800446.004 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2023-03-02T23:40:46.024Z,1677800446.024 [ElevatorServo] Loaded
2023-03-02T23:40:46.024Z,1677800446.024 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2023-03-02T23:40:46.043Z,1677800446.043 [MassServo] Loaded
2023-03-02T23:40:46.043Z,1677800446.043 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2023-03-02T23:40:46.061Z,1677800446.061 [RudderServo] Loaded
2023-03-02T23:40:46.061Z,1677800446.061 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2023-03-02T23:40:46.075Z,1677800446.075 [ThrusterHE] Loaded
2023-03-02T23:40:46.076Z,1677800446.076 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread.
2023-03-02T23:40:46.076Z,1677800446.076 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2023-03-02T23:40:46.077Z,1677800446.077 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2023-03-02T23:40:46.128Z,1677800446.128 [DepthRateCalculator] Loaded
2023-03-02T23:40:46.128Z,1677800446.128 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2023-03-02T23:40:46.133Z,1677800446.133 [PitchRateCalculator] Loaded
2023-03-02T23:40:46.133Z,1677800446.133 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2023-03-02T23:40:46.143Z,1677800446.143 [SpeedCalculator] Loaded
2023-03-02T23:40:46.143Z,1677800446.143 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2023-03-02T23:40:46.147Z,1677800446.147 [YawRateCalculator] Loaded
2023-03-02T23:40:46.147Z,1677800446.147 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2023-03-02T23:40:46.165Z,1677800446.165 [ElevatorOffsetCalculator] Loaded
2023-03-02T23:40:46.166Z,1677800446.166 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2023-03-02T23:40:46.166Z,1677800446.166 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2023-03-02T23:40:46.167Z,1677800446.167 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2023-03-02T23:40:46.280Z,1677800446.280 [DeadReckonUsingMultipleVelocitySources] Loaded
2023-03-02T23:40:46.280Z,1677800446.280 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2023-03-02T23:40:46.294Z,1677800446.294 [NavChart] Loaded
2023-03-02T23:40:46.294Z,1677800446.294 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2023-03-02T23:40:46.299Z,1677800446.299 [UniversalFixResidualReporter] Loaded
2023-03-02T23:40:46.300Z,1677800446.300 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2023-03-02T23:40:46.300Z,1677800446.300 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2023-03-02T23:40:46.301Z,1677800446.301 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2023-03-02T23:40:46.873Z,1677800446.873 [AHRS_M2] Loaded
2023-03-02T23:40:46.873Z,1677800446.873 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2023-03-02T23:40:47.181Z,1677800447.181 [BackseatComponent] Loaded
2023-03-02T23:40:47.182Z,1677800447.182 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread.
2023-03-02T23:40:47.183Z,1677800447.183 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 408E74E0
2023-03-02T23:40:47.183Z,1677800447.183 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 2005
2023-03-02T23:40:47.186Z,1677800447.186 [LcmUniversalReporter] Loaded
2023-03-02T23:40:47.186Z,1677800447.186 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread.
2023-03-02T23:40:48.013Z,1677800448.013 [BPC1] Loaded
2023-03-02T23:40:48.013Z,1677800448.013 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2023-03-02T23:40:48.107Z,1677800448.107 [DataOverHttps] Loaded
2023-03-02T23:40:48.107Z,1677800448.107 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2023-03-02T23:40:48.108Z,1677800448.108 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 409174E0
2023-03-02T23:40:48.109Z,1677800448.109 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 2006
2023-03-02T23:40:48.129Z,1677800448.129 [Depth_Keller] Loaded
2023-03-02T23:40:48.130Z,1677800448.130 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2023-03-02T23:40:48.134Z,1677800448.134 [DropWeight] Loaded
2023-03-02T23:40:48.135Z,1677800448.135 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2023-03-02T23:40:48.196Z,1677800448.196 [NAL9602] Loaded
2023-03-02T23:40:48.196Z,1677800448.196 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2023-03-02T23:40:48.226Z,1677800448.226 [Onboard] Loaded
2023-03-02T23:40:48.226Z,1677800448.226 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2023-03-02T23:40:48.227Z,1677800448.227 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 409474E0
2023-03-02T23:40:48.227Z,1677800448.227 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 2007
2023-03-02T23:40:48.239Z,1677800448.239 [Power24vConverter] Loaded
2023-03-02T23:40:48.240Z,1677800448.240 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2023-03-02T23:40:48.253Z,1677800448.253 [Radio_Surface] Loaded
2023-03-02T23:40:48.253Z,1677800448.253 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2023-03-02T23:40:48.254Z,1677800448.254 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409774E0
2023-03-02T23:40:48.255Z,1677800448.255 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 2008
2023-03-02T23:40:48.381Z,1677800448.381 [DATMMP] Loaded
2023-03-02T23:40:48.381Z,1677800448.381 [ComponentRegistry](DEBUG): Component "DATMMP" handled in its own thread.
2023-03-02T23:40:48.382Z,1677800448.382 [DATMMP ThreadHandler](DEBUG): Created PCaller Thread at 409A84E0
2023-03-02T23:40:48.382Z,1677800448.382 [DATMMP ThreadHandler](INFO): Protected caller Thread ID is 2009
2023-03-02T23:40:48.383Z,1677800448.383 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2023-03-02T23:40:48.383Z,1677800448.383 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2023-03-02T23:40:48.784Z,1677800448.784 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2023-03-02T23:40:48.784Z,1677800448.784 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2023-03-02T23:40:48.000Z,1677800449.000 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2023-03-02T23:40:49.000Z,1677800449.000 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2023-03-02T23:40:49.033Z,1677800449.033 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2023-03-02T23:40:49.033Z,1677800449.033 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2023-03-02T23:40:49.210Z,1677800449.210 [CTD_Seabird] Loaded
2023-03-02T23:40:49.210Z,1677800449.210 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2023-03-02T23:40:49.211Z,1677800449.211 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40AD34E0
2023-03-02T23:40:49.211Z,1677800449.211 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 2010
2023-03-02T23:40:49.244Z,1677800449.244 [ESPComponent] Loaded
2023-03-02T23:40:49.244Z,1677800449.244 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread.
2023-03-02T23:40:49.264Z,1677800449.264 [PAR_Licor] Loaded
2023-03-02T23:40:49.264Z,1677800449.264 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2023-03-02T23:40:49.294Z,1677800449.294 [WetLabsBB2FL] Loaded
2023-03-02T23:40:49.295Z,1677800449.295 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2023-03-02T23:40:49.296Z,1677800449.296 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40B034E0
2023-03-02T23:40:49.296Z,1677800449.296 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 2011
2023-03-02T23:40:49.297Z,1677800449.297 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2023-03-02T23:40:49.297Z,1677800449.297 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2023-03-02T23:40:49.625Z,1677800449.625 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2023-03-02T23:40:49.625Z,1677800449.625 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2023-03-02T23:40:49.772Z,1677800449.772 [SBIT](DEBUG): Construct Startup Built In Test.
2023-03-02T23:40:49.781Z,1677800449.781 [SBIT] Loaded
2023-03-02T23:40:49.781Z,1677800449.781 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2023-03-02T23:40:49.784Z,1677800449.784 [IBIT](DEBUG): Construct Initiated Built In Test.
2023-03-02T23:40:49.796Z,1677800449.796 [IBIT] Loaded
2023-03-02T23:40:49.796Z,1677800449.796 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2023-03-02T23:40:49.802Z,1677800449.802 [CBIT](DEBUG): Construct Continuous Built In Test.
2023-03-02T23:40:49.910Z,1677800449.910 [CBIT] Loaded
2023-03-02T23:40:49.910Z,1677800449.910 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2023-03-02T23:40:49.910Z,1677800449.910 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2023-03-02T23:40:49.916Z,1677800449.916 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2023-03-02T23:40:49.919Z,1677800449.919 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2023-03-02T23:40:49.930Z,1677800449.930 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2023-03-02T23:40:49.933Z,1677800449.933 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40BE64E0
2023-03-02T23:40:49.934Z,1677800449.934 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 2012
2023-03-02T23:40:49.938Z,1677800449.938 [Supervisor](INFO): Main Thread ID is 1916
2023-03-02T23:40:49.939Z,1677800449.939 [Supervisor](DEBUG): Running supervisor.
2023-03-02T23:40:49.939Z,1677800449.939 [CommandExec ThreadHandler](INFO): Handler Thread ID is 2013
2023-03-02T23:40:49.940Z,1677800449.940 [CommandExec](INFO): Initializing the command executive.
2023-03-02T23:40:49.942Z,1677800449.942 [CommandLine ThreadHandler](INFO): Handler Thread ID is 2014
2023-03-02T23:40:49.944Z,1677800449.944 [controlThread ThreadHandler](INFO): Handler Thread ID is 2015
2023-03-02T23:40:49.944Z,1677800449.944 [controlThread](DEBUG): Initializing ControlThread
2023-03-02T23:40:49.945Z,1677800449.945 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2023-03-02T23:40:49.947Z,1677800449.947 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2023-03-02T23:40:49.947Z,1677800449.947 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2023-03-02T23:40:49.948Z,1677800449.948 [LoopControl](DEBUG): Initialize LoopControlComponent.
2023-03-02T23:40:49.949Z,1677800449.949 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2023-03-02T23:40:49.950Z,1677800449.950 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2023-03-02T23:40:49.950Z,1677800449.950 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2023-03-02T23:40:49.950Z,1677800449.950 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2023-03-02T23:40:49.951Z,1677800449.951 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2023-03-02T23:40:49.952Z,1677800449.952 [NavChart](DEBUG): Initialize NavChart Navigation.
2023-03-02T23:40:49.952Z,1677800449.952 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2023-03-02T23:40:49.961Z,1677800449.961 [SBIT](INFO): Initialize SBIT Component.
2023-03-02T23:40:49.961Z,1677800449.961 [SBIT](IMPORTANT): git: 2023-01-24-33-ge31c0aa08
2023-03-02T23:40:49.961Z,1677800449.961 [SBIT](INFO): git hash: e31c0aa08481610685d7d649582c9359a962cb3e
2023-03-02T23:40:49.961Z,1677800449.961 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2023-03-02T23:40:49.962Z,1677800449.963 [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
2023-03-02T23:40:49.964Z,1677800449.964 [SBIT](INFO): Beginning SBIT in 81.000000 seconds.
2023-03-02T23:40:49.965Z,1677800449.965 [IBIT](INFO): Initialize IBIT Component.
2023-03-02T23:40:49.965Z,1677800449.965 [CBIT](DEBUG): Initialize CBIT Component.
2023-03-02T23:40:49.966Z,1677800449.966 [logger ThreadHandler](INFO): Handler Thread ID is 2016
2023-03-02T23:40:49.976Z,1677800449.976 [CBIT](DEBUG): Initialized mux pins.
2023-03-02T23:40:49.976Z,1677800449.976 [CBIT](DEBUG): Initializing the watchdog timer.
2023-03-02T23:40:49.985Z,1677800449.985 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 2017
2023-03-02T23:40:49.997Z,1677800449.997 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 2018
2023-03-02T23:40:49.998Z,1677800449.998 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2023-03-02T23:40:50.000Z,1677800450.000 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2023-03-02T23:40:50.001Z,1677800450.001 [CBIT](DEBUG): Initializing heartbeat.
2023-03-02T23:40:50.009Z,1677800450.009 [Onboard ThreadHandler](INFO): Handler Thread ID is 2019
2023-03-02T23:40:50.046Z,1677800450.046 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 2020
2023-03-02T23:40:50.057Z,1677800450.057 [DATMMP ThreadHandler](INFO): Handler Thread ID is 2021
2023-03-02T23:40:50.057Z,1677800450.057 [DATMMP](INFO): Start
2023-03-02T23:40:50.058Z,1677800450.058 [DATMMP](INFO): Powering up
2023-03-02T23:40:50.058Z,1677800450.058 [DATMMP](DEBUG): Initializing DATMMP.
2023-03-02T23:40:50.062Z,1677800450.062 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 2023
2023-03-02T23:40:50.062Z,1677800450.062 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2023-03-02T23:40:50.066Z,1677800450.066 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 2025
2023-03-02T23:40:50.069Z,1677800450.069 [WetLabsBB2FL](INFO): Powering up
2023-03-02T23:40:50.070Z,1677800450.070 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 2027
2023-03-02T23:40:50.073Z,1677800450.073 [CBIT](DEBUG): Deactivating GF circuits.
2023-03-02T23:40:50.073Z,1677800450.073 [CBIT](DEBUG): Deactivating emergency mode.
2023-03-02T23:40:50.078Z,1677800450.078 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2023-03-02T23:40:50.078Z,1677800450.078 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2023-03-02T23:40:50.078Z,1677800450.078 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2023-03-02T23:40:50.079Z,1677800450.079 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2023-03-02T23:40:50.079Z,1677800450.079 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2023-03-02T23:40:50.079Z,1677800450.079 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2023-03-02T23:40:50.079Z,1677800450.079 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2023-03-02T23:40:50.079Z,1677800450.079 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2023-03-02T23:40:50.108Z,1677800450.108 [CBIT](DEBUG): Backplane powered.
2023-03-02T23:40:50.109Z,1677800450.109 [MissionManager](INFO): Loading Mission from file: Missions/Startup.xml
2023-03-02T23:40:50.123Z,1677800450.123 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2023-03-02T23:40:50.142Z,1677800450.142 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns="Tethys"
       xmlns:Control="Tethys/Control"
       xmlns:Guidance="Tethys/Guidance" 
       xmlns:Units="Tethys/Units"
       xmlns:Universal="Tethys/Universal"
       xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
       xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                           Tethys/Control http://okeanids.mbari.org/tethys/Xml/Control.xsd
                           Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                           Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                           Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
       Id="Startup">

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

    <Aggregate Id="StartupSatComms">

        <Sequence/>

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

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

    </Aggregate>

</Mission>


2023-03-02T23:40:50.143Z,1677800450.143 [MissionManager](INFO): Loading Mission from file: Missions/Default.xml
2023-03-02T23:40:50.234Z,1677800450.234 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2023-03-02T23:40:50.235Z,1677800450.235 [Default:A.Wait](DEBUG): Construct Wait.
2023-03-02T23:40:50.254Z,1677800450.254 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2023-03-02T23:40:50.281Z,1677800450.281 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2023-03-02T23:40:50.284Z,1677800450.284 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2023-03-02T23:40:50.318Z,1677800450.318 [Default:E.Execute](DEBUG): Construct Execute.
2023-03-02T23:40:50.337Z,1677800450.337 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
         xmlns="Tethys"
         xmlns:Units="Tethys/Units"
         xmlns:Guidance="Tethys/Guidance"
         xmlns:Universal="Tethys/Universal"
         xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                             Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                             Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                             Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
         Id="Default">

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

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

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

    <Aggregate Id="CheckIn">

        <Sequence Repeat="288"/>

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

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

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

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

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

    </Aggregate>

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

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

</Mission>


2023-03-02T23:40:50.342Z,1677800450.342 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,NAL9602,Power24vConverter,ESPComponent,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter,
2023-03-02T23:40:50.364Z,1677800450.364 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2023-03-02T23:40:50.452Z,1677800450.452 [Radio_Surface](INFO): Powering up
2023-03-02T23:40:50.515Z,1677800450.515 [Power24vConverter](INFO): Powering up.
2023-03-02T23:40:50.547Z,1677800450.547 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2023-03-02T23:40:50.553Z,1677800450.553 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2023-03-02T23:40:50.554Z,1677800450.554 [ElevatorServo](DEBUG): Initializing EZServoServo.
2023-03-02T23:40:50.561Z,1677800450.561 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2023-03-02T23:40:50.562Z,1677800450.562 [MassServo](DEBUG): Initializing EZServoServo.
2023-03-02T23:40:50.569Z,1677800450.569 [MassServo](DEBUG): Initializing MassServo.
2023-03-02T23:40:50.570Z,1677800450.570 [RudderServo](DEBUG): Initializing EZServoServo.
2023-03-02T23:40:50.577Z,1677800450.577 [RudderServo](DEBUG): Initializing RudderServo.
2023-03-02T23:40:50.577Z,1677800450.577 [ThrusterHE](DEBUG): Initializing EZServoServo.
2023-03-02T23:40:50.585Z,1677800450.585 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2023-03-02T23:40:51.504Z,1677800451.504 [RudderServo](ERROR): Rudder initialization uart error serial timeout
2023-03-02T23:40:51.504Z,1677800451.504 [RudderServo](FAULT): Rudder failed to initialize
2023-03-02T23:40:51.505Z,1677800451.505 [RudderServo] Communications Fault, FailCount= 1
2023-03-02T23:40:51.505Z,1677800451.505 [RudderServo](ERROR): Communications Fault
2023-03-02T23:40:51.508Z,1677800451.508 [CBIT](ERROR): Communications Fault in component: RudderServo
2023-03-02T23:40:51.711Z,1677800451.711 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2023-03-02T23:40:51.712Z,1677800451.712 [RudderServo](INFO): Powering down
2023-03-02T23:40:52.176Z,1677800452.176 [WetLabsBB2FL](INFO): Powering down
2023-03-02T23:40:52.442Z,1677800452.442 [RudderServo](DEBUG): Initializing EZServoServo.
2023-03-02T23:40:52.561Z,1677800452.561 [RudderServo](DEBUG): Initializing RudderServo.
2023-03-02T23:40:52.565Z,1677800452.565 [CBIT](INFO): Clearing failed state for component RudderServo
2023-03-02T23:40:52.565Z,1677800452.565 [RudderServo] No Fault, FailCount= 1
2023-03-02T23:40:56.365Z,1677800456.365 [ThrusterHE](ERROR): Zero Speed Commanded.
2023-03-02T23:41:02.157Z,1677800462.157 [DATMMP](INFO): DAT read: 

2023-03-02T23:41:02.158Z,1677800462.158 [DATMMP](INFO): DAT read: Teledyne Benthos DAT-900 Series

2023-03-02T23:41:03.027Z,1677800463.027 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004728
2023-03-02T23:41:03.921Z,1677800463.921 [DATMMP](INFO): DAT read: MF Frequency Band

2023-03-02T23:41:03.922Z,1677800463.922 [DATMMP](INFO): DAT read: Directional Acoustic Transponder version 8.15.0

2023-03-02T23:41:03.923Z,1677800463.923 [DATMMP](INFO): DAT read: Mar  2 2023 23:43:36 

2023-03-02T23:41:04.929Z,1677800464.929 [DATMMP](INFO): DAT read: Features enabled [Bearing]

2023-03-02T23:41:04.930Z,1677800464.930 [DATMMP](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP

2023-03-02T23:41:04.931Z,1677800464.931 [DATMMP](INFO): commRate: 800
2023-03-02T23:41:06.996Z,1677800466.996 [DATMMP](INFO): entering command mode
2023-03-02T23:41:07.197Z,1677800467.197 [DATMMP](INFO): DAT read: 

2023-03-02T23:41:07.197Z,1677800467.197 [DATMMP](INFO): DAT read: user:1>

2023-03-02T23:41:07.197Z,1677800467.197 [DATMMP](DEBUG): read user prompt 1: user:1>

2023-03-02T23:41:07.198Z,1677800467.198 [DATMMP](INFO): entering MMP mode
2023-03-02T23:41:07.449Z,1677800467.449 [DATMMP](INFO): GSXN type: 49
2023-03-02T23:41:07.449Z,1677800467.449 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:07.700Z,1677800467.700 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:07.953Z,1677800467.953 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:08.204Z,1677800468.204 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:08.456Z,1677800468.456 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:08.709Z,1677800468.709 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:08.960Z,1677800468.960 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:09.212Z,1677800469.212 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:09.464Z,1677800469.464 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:09.717Z,1677800469.717 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:09.968Z,1677800469.968 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:10.221Z,1677800470.221 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:10.472Z,1677800470.472 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:10.725Z,1677800470.725 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:10.976Z,1677800470.976 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:11.228Z,1677800471.228 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:11.480Z,1677800471.480 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:11.732Z,1677800471.732 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:11.984Z,1677800471.984 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:12.237Z,1677800472.237 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:12.488Z,1677800472.488 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:12.740Z,1677800472.740 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:12.992Z,1677800472.992 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:13.244Z,1677800473.244 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:13.497Z,1677800473.497 [DATMMP](INFO): GSXN type: 0
2023-03-02T23:41:13.497Z,1677800473.497 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:13.748Z,1677800473.748 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:14.000Z,1677800474.000 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:14.253Z,1677800474.253 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:14.504Z,1677800474.504 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:14.757Z,1677800474.757 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:15.008Z,1677800475.008 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:15.260Z,1677800475.260 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:15.523Z,1677800475.523 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:15.776Z,1677800475.776 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:16.028Z,1677800476.028 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:16.281Z,1677800476.281 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:16.532Z,1677800476.532 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:16.785Z,1677800476.785 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:17.036Z,1677800477.036 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:17.289Z,1677800477.289 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:17.540Z,1677800477.540 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:17.792Z,1677800477.792 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:18.045Z,1677800478.045 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:18.258Z,1677800478.258 [NAL9602](INFO): Powering up NAL9602
2023-03-02T23:41:18.297Z,1677800478.297 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:18.548Z,1677800478.548 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:18.801Z,1677800478.801 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:19.053Z,1677800479.053 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:19.304Z,1677800479.304 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:19.557Z,1677800479.557 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:19.808Z,1677800479.808 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:20.060Z,1677800480.060 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:20.319Z,1677800480.319 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:20.572Z,1677800480.572 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:20.825Z,1677800480.825 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:21.081Z,1677800481.081 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:21.332Z,1677800481.332 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:21.584Z,1677800481.584 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:21.836Z,1677800481.836 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:22.088Z,1677800482.088 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:22.341Z,1677800482.341 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:22.341Z,1677800482.341 [DATMMP](FAULT): failed to enter MMP mode
2023-03-02T23:41:22.593Z,1677800482.593 [DATMMP](INFO): DAT read: 
2023-03-02T23:41:22.593Z,1677800482.593 [DATMMP](INFO): entering MMP mode
2023-03-02T23:41:22.845Z,1677800482.845 [DATMMP](INFO): GSXN type: 50
2023-03-02T23:41:22.845Z,1677800482.845 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:23.096Z,1677800483.096 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:23.349Z,1677800483.349 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:23.601Z,1677800483.601 [DATMMP](INFO): GSXN type: 0
2023-03-02T23:41:23.601Z,1677800483.601 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:23.853Z,1677800483.853 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:24.105Z,1677800484.105 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:24.357Z,1677800484.357 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:24.609Z,1677800484.609 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:24.860Z,1677800484.860 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:25.112Z,1677800485.112 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:25.364Z,1677800485.364 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:25.616Z,1677800485.616 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:25.869Z,1677800485.869 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:26.121Z,1677800486.121 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:26.373Z,1677800486.373 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:26.624Z,1677800486.624 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:26.876Z,1677800486.876 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:27.129Z,1677800487.129 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:27.380Z,1677800487.380 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:27.633Z,1677800487.633 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:27.884Z,1677800487.884 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:28.136Z,1677800488.136 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:28.389Z,1677800488.389 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:28.640Z,1677800488.640 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:28.893Z,1677800488.893 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:29.145Z,1677800489.145 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:29.166Z,1677800489.166 [NAL9602](INFO): NAL9602 initialized
2023-03-02T23:41:29.397Z,1677800489.397 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:29.649Z,1677800489.649 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:29.901Z,1677800489.901 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:30.153Z,1677800490.153 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:30.405Z,1677800490.405 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:30.657Z,1677800490.657 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:30.908Z,1677800490.908 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:31.160Z,1677800491.160 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:31.413Z,1677800491.413 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:31.664Z,1677800491.664 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:31.917Z,1677800491.917 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:32.168Z,1677800492.168 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:32.421Z,1677800492.421 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:32.672Z,1677800492.672 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:32.925Z,1677800492.925 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:33.176Z,1677800493.176 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:33.428Z,1677800493.428 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:33.680Z,1677800493.680 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:33.933Z,1677800493.933 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:34.184Z,1677800494.184 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:34.437Z,1677800494.437 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:34.688Z,1677800494.688 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:34.940Z,1677800494.940 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:35.192Z,1677800495.192 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:35.444Z,1677800495.444 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:35.696Z,1677800495.696 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:35.948Z,1677800495.948 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:36.200Z,1677800496.200 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:36.453Z,1677800496.453 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:36.704Z,1677800496.704 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:36.956Z,1677800496.956 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:37.208Z,1677800497.208 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:37.461Z,1677800497.461 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:37.713Z,1677800497.713 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:37.713Z,1677800497.713 [DATMMP](FAULT): failed to enter MMP mode
2023-03-02T23:41:37.965Z,1677800497.965 [DATMMP](INFO): DAT read: 
2023-03-02T23:41:37.966Z,1677800497.966 [DATMMP](INFO): entering MMP mode
2023-03-02T23:41:38.217Z,1677800498.217 [DATMMP](INFO): GSXN type: 51
2023-03-02T23:41:38.217Z,1677800498.217 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:38.468Z,1677800498.468 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:38.720Z,1677800498.720 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:38.972Z,1677800498.972 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:39.224Z,1677800499.224 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:39.476Z,1677800499.476 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:39.737Z,1677800499.737 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:39.989Z,1677800499.989 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:40.240Z,1677800500.240 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:40.493Z,1677800500.493 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:40.744Z,1677800500.744 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:40.996Z,1677800500.996 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:41.248Z,1677800501.248 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:41.501Z,1677800501.501 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:41.752Z,1677800501.752 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:42.004Z,1677800502.004 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:42.256Z,1677800502.256 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:42.508Z,1677800502.508 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:42.760Z,1677800502.760 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:43.012Z,1677800503.012 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:43.265Z,1677800503.265 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:43.517Z,1677800503.517 [DATMMP](INFO): GSXN type: 0
2023-03-02T23:41:43.517Z,1677800503.517 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:43.769Z,1677800503.769 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:44.020Z,1677800504.020 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:44.272Z,1677800504.272 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:44.525Z,1677800504.525 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:44.777Z,1677800504.777 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:45.028Z,1677800505.028 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:45.280Z,1677800505.280 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:45.532Z,1677800505.532 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:45.784Z,1677800505.784 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:46.036Z,1677800506.036 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:46.288Z,1677800506.288 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:46.541Z,1677800506.541 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:46.792Z,1677800506.792 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:47.044Z,1677800507.044 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:47.296Z,1677800507.296 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:47.548Z,1677800507.548 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:47.801Z,1677800507.801 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:48.052Z,1677800508.052 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:48.304Z,1677800508.304 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:48.557Z,1677800508.557 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:48.808Z,1677800508.808 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:49.060Z,1677800509.060 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:49.313Z,1677800509.313 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:49.564Z,1677800509.564 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:49.816Z,1677800509.816 [DATMMP](DEBUG): checking for MMP mode acknowledgment
2023-03-02T23:41:50.074Z,1677800510.074 [DATMMP](FAULT): failed to initialize; deviceResponse_ loaded: , available: 
2023-03-02T23:41:50.074Z,1677800510.074 [DATMMP] Communications Fault, FailCount= 1
2023-03-02T23:41:50.074Z,1677800510.074 [DATMMP](ERROR): Communications Fault
2023-03-02T23:41:50.205Z,1677800510.205 [CBIT](ERROR): Communications Fault in component: DATMMP
2023-03-02T23:41:50.476Z,1677800510.476 [DATMMP](INFO): Stop
2023-03-02T23:41:50.476Z,1677800510.476 [DATMMP](INFO): uninitialize
2023-03-02T23:41:50.477Z,1677800510.477 [DATMMP](INFO): Powering down
2023-03-02T23:41:50.952Z,1677800510.952 [DATMMP](INFO): Stopping
2023-03-02T23:41:51.356Z,1677800511.356 [DATMMP](INFO): Stopped
2023-03-02T23:41:51.429Z,1677800511.429 [CBIT](INFO): Clearing failed state for component DATMMP
2023-03-02T23:41:51.429Z,1677800511.429 [DATMMP] No Fault, FailCount= 1
2023-03-02T23:41:51.760Z,1677800511.760 [DATMMP](INFO): Start
2023-03-02T23:41:52.012Z,1677800512.012 [DATMMP](INFO): Start
2023-03-02T23:41:52.266Z,1677800512.266 [DATMMP](INFO): Start
2023-03-02T23:41:52.516Z,1677800512.516 [DATMMP](INFO): Start
2023-03-02T23:41:52.768Z,1677800512.768 [DATMMP](INFO): Start
2023-03-02T23:41:53.020Z,1677800513.020 [DATMMP](INFO): Start
2023-03-02T23:41:53.272Z,1677800513.272 [DATMMP](INFO): Start
2023-03-02T23:41:53.524Z,1677800513.524 [DATMMP](INFO): Start
2023-03-02T23:41:53.525Z,1677800513.525 [DATMMP](INFO): Powering up
2023-03-02T23:41:53.525Z,1677800513.525 [DATMMP](DEBUG): Initializing DATMMP.
2023-03-02T23:42:11.634Z,1677800531.634 [SBIT](IMPORTANT): Beginning Startup BIT
2023-03-02T23:42:11.638Z,1677800531.638 [CBIT](IMPORTANT): Beginning ground fault scan
2023-03-02T23:42:22.533Z,1677800542.533 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.004113
CHAN A1 (24V): -0.008578
CHAN A2 (12V): -0.005085
CHAN A3 (5V): -0.002801
CHAN B0 (3.3V): -0.000769
CHAN B1 (3.15aV): -0.001549
CHAN B2 (3.15bV): -0.000775
CHAN B3 (GND): 0.000314
OPEN: 0.004541
Full Scale: +/- 1 mA
2023-03-02T23:42:25.113Z,1677800545.113 [CommandExec](IMPORTANT): got command failComponent
2023-03-02T23:42:25.113Z,1677800545.113 [CommandExec](IMPORTANT): Failed components:
2023-03-02T23:42:25.113Z,1677800545.113 [CommandExec](IMPORTANT): No failed Components.
2023-03-02T23:42:53.533Z,1677800573.533 [DATMMP](FAULT): failed to initialize; deviceResponse_ loaded: , available: 
Teledyne Benthos DAT-900 Series
MF Frequency Band
Directional Acoustic Transponder version 8.15.0
Mar  2 2023 23:44:40 
Features enabled [Bearing]
CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP
L
2023-03-02T23:42:53.533Z,1677800573.533 [DATMMP] Communications Fault, FailCount= 2
2023-03-02T23:42:53.533Z,1677800573.533 [DATMMP](ERROR): Communications Fault
2023-03-02T23:42:53.789Z,1677800573.789 [CBIT](ERROR): Communications Fault in component: DATMMP
2023-03-02T23:42:53.937Z,1677800573.937 [DATMMP](INFO): Stop
2023-03-02T23:42:53.937Z,1677800573.937 [DATMMP](INFO): uninitialize
2023-03-02T23:42:53.937Z,1677800573.937 [DATMMP](INFO): Powering down
2023-03-02T23:42:54.436Z,1677800574.436 [DATMMP](INFO): Stopping
2023-03-02T23:42:54.843Z,1677800574.843 [DATMMP](INFO): Stopped
2023-03-02T23:42:54.941Z,1677800574.941 [CBIT](INFO): Clearing failed state for component DATMMP
2023-03-02T23:42:54.941Z,1677800574.941 [DATMMP] No Fault, FailCount= 2
2023-03-02T23:42:55.245Z,1677800575.245 [DATMMP](INFO): Start
2023-03-02T23:42:55.496Z,1677800575.496 [DATMMP](INFO): Start
2023-03-02T23:42:55.748Z,1677800575.748 [DATMMP](INFO): Start
2023-03-02T23:42:56.000Z,1677800576.000 [DATMMP](INFO): Start
2023-03-02T23:42:56.252Z,1677800576.252 [DATMMP](INFO): Start
2023-03-02T23:42:56.504Z,1677800576.504 [DATMMP](INFO): Start
2023-03-02T23:42:56.757Z,1677800576.757 [DATMMP](INFO): Start
2023-03-02T23:42:57.008Z,1677800577.008 [DATMMP](INFO): Start
2023-03-02T23:42:57.009Z,1677800577.009 [DATMMP](INFO): Powering up
2023-03-02T23:42:57.009Z,1677800577.009 [DATMMP](DEBUG): Initializing DATMMP.
2023-03-02T23:43:05.465Z,1677800585.465 [SBIT](IMPORTANT): SBIT PASSED
2023-03-02T23:43:05.465Z,1677800585.465 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2023-03-02T23:43:05.466Z,1677800585.466 [SBIT](IMPORTANT): BPC1.batteryMissingStickThreshold=6 count;

2023-03-02T23:43:05.466Z,1677800585.466 [SBIT](IMPORTANT): BackseatComponent.alwaysOn=0 bool;

2023-03-02T23:43:05.466Z,1677800585.466 [SBIT](IMPORTANT): DAT.verbosity=1 count;

2023-03-02T23:43:05.466Z,1677800585.466 [SBIT](IMPORTANT): ESPComponent.loadAtStartup=1 bool;

2023-03-02T23:43:05.466Z,1677800585.466 [SBIT](IMPORTANT): ESPComponent.sampleTimeout=10 minute;

2023-03-02T23:43:05.466Z,1677800585.466 [SBIT](IMPORTANT): ESPComponent.simulateHardware=1 bool;

2023-03-02T23:43:05.466Z,1677800585.466 [SBIT](IMPORTANT): Express none WetLabsBB2FL.bin_mean_mass_concentration_of_chlorophyll_in_sea_water;

2023-03-02T23:43:05.467Z,1677800585.467 [SBIT](IMPORTANT): Express none WetLabsBB2FL.bin_median_mass_concentration_of_chlorophyll_in_sea_water;

2023-03-02T23:43:05.467Z,1677800585.467 [SBIT](IMPORTANT): Express linearApproximation platform_roll_angle 5.000000 degree;

2023-03-02T23:43:05.467Z,1677800585.467 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=184.896478 cubic_centimeter;

2023-03-02T23:43:05.467Z,1677800585.467 [SBIT](IMPORTANT): VerticalControl.elevDeadband=0.1 angular_degree;

2023-03-02T23:43:05.467Z,1677800585.467 [SBIT](IMPORTANT): VerticalControl.massDefault=15.484465 millimeter;

2023-03-02T23:43:05.818Z,1677800585.818 [MissionManager](IMPORTANT): Started mission Startup
2023-03-02T23:43:05.819Z,1677800585.819 [Startup] Running Loop=1
2023-03-02T23:43:05.819Z,1677800585.819 [Startup](DEBUG): Aggregate::initialize Startup
2023-03-02T23:43:05.819Z,1677800585.819 [Startup:A.GoToSurface] Running Loop=1
2023-03-02T23:43:05.819Z,1677800585.819 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2023-03-02T23:43:05.820Z,1677800585.820 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2023-03-02T23:43:05.829Z,1677800585.829 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2023-03-02T23:43:05.833Z,1677800585.833 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2023-03-02T23:43:05.833Z,1677800585.833 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2023-03-02T23:43:05.834Z,1677800585.834 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2023-03-02T23:43:05.835Z,1677800585.835 [Startup:StartupSatComms] Running Loop=1
2023-03-02T23:43:05.835Z,1677800585.835 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2023-03-02T23:43:05.835Z,1677800585.835 [Startup:StartupSatComms:A] Running Loop=1
2023-03-02T23:43:06.206Z,1677800586.206 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2023-03-02T23:43:18.659Z,1677800598.659 [BPC1](ERROR): BPC1B: No match for serial number 0C29 in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2023-03-02T23:43:31.985Z,1677800611.985 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2023-03-02T23:43:45.330Z,1677800625.330 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2023-03-02T23:43:50.207Z,1677800630.207 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2023-03-02T23:43:50.207Z,1677800630.207 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-02T23:43:50.229Z,1677800630.229 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-02T23:43:50.628Z,1677800630.628 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-02T23:43:50.629Z,1677800630.629 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2023-03-02T23:43:57.257Z,1677800637.257 [DATMMP](FAULT): failed to initialize; deviceResponse_ loaded: , available: 
Teledyne Benthos DAT-900 Series
MF Frequency Band
Directional Acoustic Transponder version 8.15.0
Mar  2 2023 23:45:43 
Features enabled [Bearing]
CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP
L
2023-03-02T23:43:57.257Z,1677800637.257 [DATMMP] Communications Fault, FailCount= 3
2023-03-02T23:43:57.257Z,1677800637.257 [DATMMP](ERROR): Communications Fault
2023-03-02T23:43:57.455Z,1677800637.455 [CBIT](ERROR): Communications Fault in component: DATMMP
2023-03-02T23:43:57.660Z,1677800637.660 [DATMMP](INFO): Stop
2023-03-02T23:43:57.661Z,1677800637.661 [DATMMP](INFO): uninitialize
2023-03-02T23:43:57.661Z,1677800637.661 [DATMMP](INFO): Powering down
2023-03-02T23:43:58.137Z,1677800638.137 [DATMMP](INFO): Stopping
2023-03-02T23:43:58.541Z,1677800638.541 [DATMMP](INFO): Stopped
2023-03-02T23:43:58.778Z,1677800638.778 [CBIT](INFO): Clearing failed state for component DATMMP
2023-03-02T23:43:58.778Z,1677800638.778 [DATMMP] No Fault, FailCount= 3
2023-03-02T23:43:58.944Z,1677800638.944 [DATMMP](INFO): Start
2023-03-02T23:43:59.058Z,1677800639.058 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2023-03-02T23:43:59.197Z,1677800639.197 [DATMMP](INFO): Start
2023-03-02T23:43:59.449Z,1677800639.449 [DATMMP](INFO): Start
2023-03-02T23:43:59.700Z,1677800639.700 [DATMMP](INFO): Start
2023-03-02T23:43:59.952Z,1677800639.952 [DATMMP](INFO): Start
2023-03-02T23:44:00.204Z,1677800640.204 [DATMMP](INFO): Start
2023-03-02T23:44:00.456Z,1677800640.456 [DATMMP](INFO): Start
2023-03-02T23:44:00.708Z,1677800640.708 [DATMMP](INFO): Start
2023-03-02T23:44:00.709Z,1677800640.709 [DATMMP](INFO): Powering up
2023-03-02T23:44:00.709Z,1677800640.709 [DATMMP](DEBUG): Initializing DATMMP.
2023-03-02T23:44:05.929Z,1677800645.929 [Startup:StartupSatComms:A](INFO): Timed out from 2023-03-02T23:43:05.8Z
2023-03-02T23:44:05.930Z,1677800645.930 [Startup:StartupSatComms:A] Stopped
2023-03-02T23:44:05.930Z,1677800645.930 [Startup:StartupSatComms:B] Running Loop=1
2023-03-02T23:44:06.334Z,1677800646.334 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2023-03-02T23:44:12.390Z,1677800652.390 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2023-03-02T23:44:13.337Z,1677800653.337 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230222T222748/Courier0013.lzma
2023-03-02T23:44:14.338Z,1677800654.338 [DataOverHttps](INFO): Moved sent file to Logs/20230222T222748/Courier0013.lzma.bak
2023-03-02T23:44:14.338Z,1677800654.338 [DataOverHttps](INFO): SBD MOMSN=17501731
2023-03-02T23:44:25.723Z,1677800665.723 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2023-03-02T23:44:29.900Z,1677800669.900 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20230302T234038/Courier0000.lzma
2023-03-02T23:44:30.902Z,1677800670.902 [DataOverHttps](INFO): Moved sent file to Logs/20230302T234038/Courier0000.lzma.bak
2023-03-02T23:44:30.902Z,1677800670.902 [DataOverHttps](INFO): SBD MOMSN=17501737
2023-03-02T23:44:39.054Z,1677800679.054 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2023-03-02T23:44:46.369Z,1677800686.369 [DataOverHttps](INFO): Sending 85 bytes from file Logs/20230222T222748/Express0014.lzma
2023-03-02T23:44:47.370Z,1677800687.370 [DataOverHttps](INFO): Moved sent file to Logs/20230222T222748/Express0014.lzma.bak
2023-03-02T23:44:47.370Z,1677800687.370 [DataOverHttps](INFO): SBD MOMSN=17501744
2023-03-02T23:44:52.790Z,1677800692.790 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2023-03-02T23:45:00.713Z,1677800700.713 [DATMMP](FAULT): failed to initialize; deviceResponse_ loaded: , available: 
Teledyne Benthos DAT-900 Series
MF Frequency Band
Directional Acoustic Transponder version 8.15.0
Mar  2 2023 23:46:47 
Features enabled [Bearing]
CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP
L
2023-03-02T23:45:00.713Z,1677800700.713 [DATMMP] Communications Fault, FailCount= 4
2023-03-02T23:45:00.713Z,1677800700.713 [DATMMP](ERROR): Communications Fault
2023-03-02T23:45:00.882Z,1677800700.882 [CBIT](ERROR): Communications Fault in component: DATMMP
2023-03-02T23:45:01.117Z,1677800701.117 [DATMMP](INFO): Stop
2023-03-02T23:45:01.117Z,1677800701.117 [DATMMP](INFO): uninitialize
2023-03-02T23:45:01.117Z,1677800701.117 [DATMMP](INFO): Powering down
2023-03-02T23:45:01.596Z,1677800701.596 [DATMMP](INFO): Stopping
2023-03-02T23:45:02.000Z,1677800702.000 [DATMMP](INFO): Stopped
2023-03-02T23:45:02.119Z,1677800702.119 [CBIT](INFO): Clearing failed state for component DATMMP
2023-03-02T23:45:02.119Z,1677800702.119 [DATMMP] No Fault, FailCount= 4
2023-03-02T23:45:02.404Z,1677800702.404 [DATMMP](INFO): Start
2023-03-02T23:45:02.656Z,1677800702.656 [DATMMP](INFO): Start
2023-03-02T23:45:02.909Z,1677800702.909 [DATMMP](INFO): Start
2023-03-02T23:45:03.033Z,1677800703.033 [DataOverHttps](INFO): Sending 1318 bytes from file Logs/20230302T234038/Express0001.lzma
2023-03-02T23:45:03.160Z,1677800703.160 [DATMMP](INFO): Start
2023-03-02T23:45:03.412Z,1677800703.412 [DATMMP](INFO): Start
2023-03-02T23:45:03.664Z,1677800703.664 [DATMMP](INFO): Start
2023-03-02T23:45:03.917Z,1677800703.917 [DATMMP](INFO): Start
2023-03-02T23:45:04.030Z,1677800704.030 [DataOverHttps](INFO): Moved sent file to Logs/20230302T234038/Express0001.lzma.bak
2023-03-02T23:45:04.030Z,1677800704.030 [DataOverHttps](INFO): SBD MOMSN=17501751
2023-03-02T23:45:04.168Z,1677800704.168 [DATMMP](INFO): Start
2023-03-02T23:45:04.169Z,1677800704.169 [DATMMP](INFO): Powering up
2023-03-02T23:45:04.169Z,1677800704.169 [DATMMP](DEBUG): Initializing DATMMP.
2023-03-02T23:45:05.792Z,1677800705.792 [Startup:StartupSatComms:B] Stopped
2023-03-02T23:45:05.793Z,1677800705.793 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2023-03-02T23:45:05.793Z,1677800705.793 [Startup:StartupSatComms] Stopped
2023-03-02T23:45:05.793Z,1677800705.793 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2023-03-02T23:45:05.794Z,1677800705.794 [Startup](INFO): Completed Startup
2023-03-02T23:45:05.794Z,1677800705.794 [MissionManager](INFO): Startup is completed.
2023-03-02T23:45:05.794Z,1677800705.794 [MissionManager](INFO): Uninitializing Mission Startup
2023-03-02T23:45:05.794Z,1677800705.794 [Startup] Stopped
2023-03-02T23:45:05.794Z,1677800705.794 [Startup](DEBUG): Aggregate::uninitialize Startup
2023-03-02T23:45:05.794Z,1677800705.794 [Startup:A.GoToSurface] Stopped
2023-03-02T23:45:05.794Z,1677800705.794 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2023-03-02T23:45:06.110Z,1677800706.110 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2023-03-02T23:45:06.123Z,1677800706.123 [MissionManager](IMPORTANT): Started mission Default
2023-03-02T23:45:06.123Z,1677800706.123 [Default] Running Loop=1
2023-03-02T23:45:06.123Z,1677800706.123 [Default](DEBUG): Aggregate::initialize Default
2023-03-02T23:45:06.124Z,1677800706.124 [Default:B.GoToSurface] Running Loop=1
2023-03-02T23:45:06.124Z,1677800706.124 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2023-03-02T23:45:06.124Z,1677800706.124 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2023-03-02T23:45:06.124Z,1677800706.124 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2023-03-02T23:45:06.125Z,1677800706.125 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2023-03-02T23:45:06.125Z,1677800706.125 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2023-03-02T23:45:06.125Z,1677800706.125 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2023-03-02T23:45:06.126Z,1677800706.126 [Default:A.Wait] Running Loop=1
2023-03-02T23:45:06.126Z,1677800706.126 [Default:A.Wait](DEBUG): Initialize Wait Component.
2023-03-02T23:45:19.443Z,1677800719.443 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2023-03-02T23:45:19.458Z,1677800719.458 [Default:A.Wait](INFO): Done Waiting.
2023-03-02T23:45:19.458Z,1677800719.458 [Default:A.Wait] Stopped
2023-03-02T23:45:19.458Z,1677800719.458 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2023-03-02T23:45:19.875Z,1677800719.875 [Default:CheckIn] Running Loop=1
2023-03-02T23:45:19.875Z,1677800719.875 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-03-02T23:45:19.875Z,1677800719.875 [Default:CheckIn:Read_GPS] Running Loop=1
2023-03-02T23:45:20.281Z,1677800720.281 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2023-03-02T23:45:33.179Z,1677800733.179 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2023-03-02T23:46:04.181Z,1677800764.181 [DATMMP](FAULT): failed to initialize; deviceResponse_ loaded: , available: 
Teledyne Benthos DAT-900 Series
MF Frequency Band
Directional Acoustic Transponder version 8.15.0
Mar  2 2023 23:47:51 
Features enabled [Bearing]
CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP
L
2023-03-02T23:46:04.181Z,1677800764.181 [DATMMP] Communications Fault, FailCount= 5
2023-03-02T23:46:04.181Z,1677800764.181 [DATMMP](ERROR): Communications Fault
2023-03-02T23:46:04.312Z,1677800764.312 [CBIT](ERROR): Communications Fault in component: DATMMP
2023-03-02T23:46:04.584Z,1677800764.584 [DATMMP](INFO): Stop
2023-03-02T23:46:04.585Z,1677800764.585 [DATMMP](INFO): uninitialize
2023-03-02T23:46:04.585Z,1677800764.585 [DATMMP](INFO): Powering down
2023-03-02T23:46:05.056Z,1677800765.056 [DATMMP](INFO): Stopping
2023-03-02T23:46:05.460Z,1677800765.460 [DATMMP](INFO): Stopped
2023-03-02T23:46:05.547Z,1677800765.547 [CBIT](INFO): Clearing failed state for component DATMMP
2023-03-02T23:46:05.547Z,1677800765.547 [DATMMP] No Fault, FailCount= 5
2023-03-02T23:46:05.864Z,1677800765.864 [DATMMP](INFO): Start
2023-03-02T23:46:06.116Z,1677800766.116 [DATMMP](INFO): Start
2023-03-02T23:46:06.368Z,1677800766.368 [DATMMP](INFO): Start
2023-03-02T23:46:06.620Z,1677800766.620 [DATMMP](INFO): Start
2023-03-02T23:46:06.872Z,1677800766.872 [DATMMP](INFO): Start
2023-03-02T23:46:07.131Z,1677800767.131 [DATMMP](INFO): Start
2023-03-02T23:46:07.385Z,1677800767.385 [DATMMP](INFO): Start
2023-03-02T23:46:07.636Z,1677800767.636 [DATMMP](INFO): Start
2023-03-02T23:46:07.637Z,1677800767.637 [DATMMP](INFO): Powering up
2023-03-02T23:46:07.637Z,1677800767.637 [DATMMP](DEBUG): Initializing DATMMP.
2023-03-02T23:46:32.978Z,1677800792.978 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2023-03-02T23:46:51.242Z,1677800811.242 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2023-03-02T23:46:51.242Z,1677800811.242 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-02T23:46:51.252Z,1677800811.252 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-02T23:46:51.619Z,1677800811.619 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-02T23:46:51.619Z,1677800811.619 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2023-03-02T23:47:07.653Z,1677800827.653 [DATMMP](FAULT): failed to initialize; deviceResponse_ loaded: , available: 
Teledyne Benthos DAT-900 Series
MF Frequency Band
Directional Acoustic Transponder version 8.15.0
Mar  2 2023 23:48:54 
Features enabled [Bearing]
CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP
L
2023-03-02T23:47:07.653Z,1677800827.653 [DATMMP] Communications Fault, FailCount= 6
2023-03-02T23:47:07.654Z,1677800827.654 [DATMMP](ERROR): Communications Fault
2023-03-02T23:47:07.786Z,1677800827.786 [CBIT](ERROR): Communications Fault in component: DATMMP
2023-03-02T23:47:08.056Z,1677800828.056 [DATMMP](INFO): Stop
2023-03-02T23:47:08.056Z,1677800828.056 [DATMMP](INFO): uninitialize
2023-03-02T23:47:08.057Z,1677800828.057 [DATMMP](INFO): Powering down
2023-03-02T23:47:08.540Z,1677800828.540 [DATMMP](INFO): Stopping
2023-03-02T23:47:08.945Z,1677800828.945 [DATMMP](INFO): Stopped
2023-03-02T23:47:08.961Z,1677800828.961 [CBIT](INFO): Clearing failed state for component DATMMP
2023-03-02T23:47:08.961Z,1677800828.961 [DATMMP] No Fault, FailCount= 6
2023-03-02T23:47:09.348Z,1677800829.348 [DATMMP](INFO): Start
2023-03-02T23:47:09.600Z,1677800829.600 [DATMMP](INFO): Start
2023-03-02T23:47:09.852Z,1677800829.852 [DATMMP](INFO): Start
2023-03-02T23:47:10.104Z,1677800830.104 [DATMMP](INFO): Start
2023-03-02T23:47:10.356Z,1677800830.356 [DATMMP](INFO): Start
2023-03-02T23:47:10.608Z,1677800830.608 [DATMMP](INFO): Start
2023-03-02T23:47:10.860Z,1677800830.860 [DATMMP](INFO): Start
2023-03-02T23:47:11.112Z,1677800831.112 [DATMMP](INFO): Start
2023-03-02T23:47:11.113Z,1677800831.113 [DATMMP](INFO): Powering up
2023-03-02T23:47:11.113Z,1677800831.113 [DATMMP](DEBUG): Initializing DATMMP.
2023-03-02T23:48:11.361Z,1677800891.361 [DATMMP](FAULT): failed to initialize; deviceResponse_ loaded: , available: 
Teledyne Benthos DAT-900 Series
MF Frequency Band
Directional Acoustic Transponder version 8.15.0
Mar  2 2023 23:49:57 
Features enabled [Bearing]
CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP
L
2023-03-02T23:48:11.361Z,1677800891.361 [DATMMP] Communications Fault, FailCount= 7
2023-03-02T23:48:11.361Z,1677800891.361 [DATMMP](ERROR): Communications Fault
2023-03-02T23:48:11.588Z,1677800891.588 [CBIT](ERROR): Communications Fault in component: DATMMP
2023-03-02T23:48:11.764Z,1677800891.764 [DATMMP](INFO): Stop
2023-03-02T23:48:11.764Z,1677800891.764 [DATMMP](INFO): uninitialize
2023-03-02T23:48:11.765Z,1677800891.765 [DATMMP](INFO): Powering down
2023-03-02T23:48:12.248Z,1677800892.248 [DATMMP](INFO): Stopping
2023-03-02T23:48:12.652Z,1677800892.652 [DATMMP](INFO): Stopped
2023-03-02T23:48:12.782Z,1677800892.782 [CBIT](INFO): Clearing failed state for component DATMMP
2023-03-02T23:48:12.783Z,1677800892.783 [DATMMP] No Fault, FailCount= 7
2023-03-02T23:48:13.056Z,1677800893.056 [DATMMP](INFO): Start
2023-03-02T23:48:13.308Z,1677800893.308 [DATMMP](INFO): Start
2023-03-02T23:48:13.560Z,1677800893.560 [DATMMP](INFO): Start
2023-03-02T23:48:13.812Z,1677800893.812 [DATMMP](INFO): Start
2023-03-02T23:48:14.064Z,1677800894.064 [DATMMP](INFO): Start
2023-03-02T23:48:14.316Z,1677800894.316 [DATMMP](INFO): Start
2023-03-02T23:48:14.570Z,1677800894.570 [DATMMP](INFO): Start
2023-03-02T23:48:14.820Z,1677800894.820 [DATMMP](INFO): Start
2023-03-02T23:48:14.821Z,1677800894.821 [DATMMP](INFO): Powering up
2023-03-02T23:48:14.821Z,1677800894.821 [DATMMP](DEBUG): Initializing DATMMP.
2023-03-02T23:48:17.613Z,1677800897.613 [BPC1](ERROR): Battery stick #23 (s/n: 02B0) reported OVER_TEMP_ALARM. Status code: 0x1717.
2023-03-02T23:48:17.614Z,1677800897.614 [BPC1](INFO): Calculating totals. Valid battery stick count: 51. Valid reserve battery stick count: 5.
2023-03-02T23:48:17.617Z,1677800897.617 [BPC1](INFO): Received data from all battery sticks.
2023-03-02T23:49:14.833Z,1677800954.833 [DATMMP](FAULT): failed to initialize; deviceResponse_ loaded: , available: 
Teledyne Benthos DAT-900 Series
MF Frequency Band
Directional Acoustic Transponder version 8.15.0
Mar  2 2023 23:51:01 
Features enabled [Bearing]
CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP
L
2023-03-02T23:49:14.833Z,1677800954.833 [DATMMP] Communications Fault, FailCount= 8
2023-03-02T23:49:14.833Z,1677800954.833 [DATMMP](ERROR): Communications Fault
2023-03-02T23:49:15.028Z,1677800955.028 [CBIT](ERROR): Communications Fault in component: DATMMP
2023-03-02T23:49:15.049Z,1677800955.049 [CBIT](FAULT): Communications Fault in component: DATMMP
2023-03-02T23:49:15.237Z,1677800955.237 [DATMMP](INFO): Stop
2023-03-02T23:49:15.237Z,1677800955.237 [DATMMP](INFO): uninitialize
2023-03-02T23:49:15.237Z,1677800955.237 [DATMMP](INFO): Powering down
2023-03-02T23:49:15.712Z,1677800955.712 [DATMMP](INFO): Stopping
2023-03-02T23:49:16.116Z,1677800956.116 [DATMMP](INFO): Stopped
2023-03-02T23:49:40.017Z,1677800980.017 [CommandExec](IMPORTANT): got command quit
2023-03-02T23:49:41.020Z,1677800981.020 [Supervisor](INFO): Stop Mission called by Supervisor::terminate
2023-03-02T23:49:41.021Z,1677800981.021 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread.
2023-03-02T23:49:41.021Z,1677800981.021 [CommandExec](INFO): Uninitializing the command executive.
2023-03-02T23:49:41.021Z,1677800981.021 [CommandExec](INFO): Uninitializing the command scheduler.
2023-03-02T23:49:41.021Z,1677800981.021 [CommandExec ThreadHandler](INFO): Thread cancelled.
2023-03-02T23:49:41.120Z,1677800981.120 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2023-03-02T23:49:41.120Z,1677800981.120 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2023-03-02T23:49:41.121Z,1677800981.121 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2023-03-02T23:49:41.121Z,1677800981.121 [NavChartDb](INFO): Join timeout helper Thread ID is 2059
2023-03-02T23:49:41.348Z,1677800981.348 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2023-03-02T23:49:41.349Z,1677800981.349 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2023-03-02T23:49:41.363Z,1677800981.363 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2023-03-02T23:49:41.363Z,1677800981.363 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2023-03-02T23:49:41.363Z,1677800981.363 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 2060
2023-03-02T23:49:41.529Z,1677800981.529 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2023-03-02T23:49:41.529Z,1677800981.529 [WetLabsBB2FL](INFO): Powering down
2023-03-02T23:49:41.530Z,1677800981.530 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2023-03-02T23:49:41.548Z,1677800981.548 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2023-03-02T23:49:41.548Z,1677800981.548 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2023-03-02T23:49:41.549Z,1677800981.549 [CTD_Seabird](INFO): Join timeout helper Thread ID is 2061
2023-03-02T23:49:42.300Z,1677800982.300 [CTD_Seabird](INFO): Powering down
2023-03-02T23:49:42.312Z,1677800982.312 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2023-03-02T23:49:42.312Z,1677800982.312 [CTD_Seabird](INFO): Powering down
2023-03-02T23:49:42.324Z,1677800982.324 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2023-03-02T23:49:42.328Z,1677800982.328 [ComponentRegistry](INFO): Shutting down DATMMP ThreadHandler
2023-03-02T23:49:42.328Z,1677800982.328 [DATMMP ThreadHandler](INFO): Thread cancelled.
2023-03-02T23:49:42.329Z,1677800982.329 [DATMMP](INFO): Join timeout helper Thread ID is 2062
2023-03-02T23:49:42.384Z,1677800982.384 [DATMMP ThreadHandler](INFO): Uninitializing protected caller thread.
2023-03-02T23:49:42.385Z,1677800982.385 [DATMMP](INFO): uninitialize
2023-03-02T23:49:42.385Z,1677800982.385 [DATMMP](INFO): Powering down
2023-03-02T23:49:42.385Z,1677800982.385 [DATMMP ThreadHandler](INFO): Thread cancelled.
2023-03-02T23:49:42.392Z,1677800982.392 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2023-03-02T23:49:42.393Z,1677800982.393 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2023-03-02T23:49:42.393Z,1677800982.393 [Radio_Surface](INFO): Join timeout helper Thread ID is 2063
2023-03-02T23:49:42.593Z,1677800982.593 [Radio_Surface](INFO): Powering down
2023-03-02T23:49:42.593Z,1677800982.593 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2023-03-02T23:49:42.594Z,1677800982.594 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2023-03-02T23:49:42.597Z,1677800982.597 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2023-03-02T23:49:42.597Z,1677800982.597 [Onboard ThreadHandler](INFO): Thread cancelled.
2023-03-02T23:49:42.598Z,1677800982.598 [Onboard](INFO): Join timeout helper Thread ID is 2064
2023-03-02T23:49:42.793Z,1677800982.793 [DataOverHttps](INFO): Radio surface powered OFF, will not connect.
2023-03-02T23:49:45.444Z,1677800985.444 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2023-03-02T23:49:45.445Z,1677800985.445 [Onboard ThreadHandler](INFO): Thread cancelled.
2023-03-02T23:49:45.449Z,1677800985.449 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2023-03-02T23:49:45.449Z,1677800985.449 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2023-03-02T23:49:45.449Z,1677800985.449 [DataOverHttps](INFO): Join timeout helper Thread ID is 2065
2023-03-02T23:49:45.804Z,1677800985.804 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2023-03-02T23:49:45.805Z,1677800985.805 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2023-03-02T23:49:45.809Z,1677800985.809 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler
2023-03-02T23:49:45.809Z,1677800985.809 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2023-03-02T23:49:45.809Z,1677800985.809 [BackseatComponent](INFO): Join timeout helper Thread ID is 2066
2023-03-02T23:49:45.924Z,1677800985.924 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread.
2023-03-02T23:49:45.925Z,1677800985.925 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2023-03-02T23:49:45.933Z,1677800985.933 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2023-03-02T23:49:45.934Z,1677800985.934 [logger ThreadHandler](INFO): Thread cancelled.
2023-03-02T23:49:45.935Z,1677800985.935 [logger](INFO): Join timeout helper Thread ID is 2067
2023-03-02T23:49:45.940Z,1677800985.940 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2023-03-02T23:49:45.941Z,1677800985.941 [logger ThreadHandler](INFO): Thread cancelled.
2023-03-02T23:49:45.953Z,1677800985.953 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2023-03-02T23:49:45.953Z,1677800985.953 [CommandLine ThreadHandler](INFO): Thread cancelled.
2023-03-02T23:49:45.953Z,1677800985.953 [CommandLine](INFO): Join timeout helper Thread ID is 2068
2023-03-02T23:49:45.960Z,1677800985.960 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2023-03-02T23:49:45.961Z,1677800985.961 [CommandLine ThreadHandler](INFO): Thread cancelled.
2023-03-02T23:49:45.973Z,1677800985.973 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler
2023-03-02T23:49:45.973Z,1677800985.973 [CommandExec ThreadHandler](INFO): Thread cancelled.
2023-03-02T23:49:45.973Z,1677800985.973 [CommandExec](INFO): Join timeout helper Thread ID is 2069
2023-03-02T23:49:45.975Z,1677800985.975 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2023-03-02T23:49:45.975Z,1677800985.975 [controlThread ThreadHandler](INFO): Thread cancelled.
2023-03-02T23:49:45.975Z,1677800985.975 [controlThread](INFO): Join timeout helper Thread ID is 2070
2023-03-02T23:49:46.072Z,1677800986.072 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2023-03-02T23:49:46.073Z,1677800986.073 [controlThread](DEBUG): Uninitializing ControlThread
2023-03-02T23:49:46.073Z,1677800986.073 [AHRS_M2](INFO): Powering down
2023-03-02T23:49:46.145Z,1677800986.145 [NAL9602](INFO): Powering down
2023-03-02T23:49:46.147Z,1677800986.147 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2023-03-02T23:49:46.148Z,1677800986.148 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2023-03-02T23:49:46.148Z,1677800986.148 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2023-03-02T23:49:46.149Z,1677800986.149 [MissionManager](INFO): Uninitializing Mission Default
2023-03-02T23:49:46.149Z,1677800986.149 [Default] Stopped
2023-03-02T23:49:46.149Z,1677800986.149 [Default](DEBUG): Aggregate::uninitialize Default
2023-03-02T23:49:46.149Z,1677800986.149 [Default:B.GoToSurface] Stopped
2023-03-02T23:49:46.149Z,1677800986.149 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2023-03-02T23:49:46.149Z,1677800986.149 [Default:CheckIn] Stopped
2023-03-02T23:49:46.149Z,1677800986.149 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-03-02T23:49:46.150Z,1677800986.150 [Default:CheckIn:Read_GPS] Stopped
2023-03-02T23:49:46.152Z,1677800986.152 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2023-03-02T23:49:46.153Z,1677800986.153 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2023-03-02T23:49:46.153Z,1677800986.153 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2023-03-02T23:49:46.153Z,1677800986.153 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2023-03-02T23:49:46.154Z,1677800986.154 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2023-03-02T23:49:46.154Z,1677800986.154 [BuoyancyServo](INFO): Powering down
2023-03-02T23:49:46.168Z,1677800986.168 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2023-03-02T23:49:46.168Z,1677800986.168 [ElevatorServo](INFO): Powering down
2023-03-02T23:49:46.169Z,1677800986.169 [MassServo](DEBUG): Uninitialize Mass Servo.
2023-03-02T23:49:46.169Z,1677800986.169 [MassServo](INFO): Powering down
2023-03-02T23:49:46.170Z,1677800986.170 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2023-03-02T23:49:46.170Z,1677800986.170 [RudderServo](INFO): Powering down
2023-03-02T23:49:46.171Z,1677800986.171 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2023-03-02T23:49:46.171Z,1677800986.171 [ThrusterHE](INFO): Powering down
2023-03-02T23:49:46.172Z,1677800986.172 [SBIT](DEBUG): Uninitialize SBIT Component.
2023-03-02T23:49:46.173Z,1677800986.173 [IBIT](DEBUG): Uninitialize IBIT Component.
2023-03-02T23:49:46.173Z,1677800986.173 [CBIT](DEBUG): Uninitialize CBIT Component.
2023-03-02T23:49:46.173Z,1677800986.173 [CBIT](DEBUG): Powering off loads.
2023-03-02T23:49:46.184Z,1677800986.184 [CBIT](DEBUG): Disabling WDT.
2023-03-02T23:49:46.196Z,1677800986.196 [CBIT](DEBUG): Opening all GF detection circuits.
2023-03-02T23:49:46.197Z,1677800986.197 [controlThread ThreadHandler](INFO): Thread cancelled.
2023-03-02T23:49:46.251Z,1677800986.251 [DATMMP ThreadHandler](INFO): Thread cancelled.
2023-03-02T23:49:46.256Z,1677800986.256 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2023-03-02T23:49:46.258Z,1677800986.258 [Onboard ThreadHandler](INFO): Thread cancelled.
2023-03-02T23:49:46.264Z,1677800986.264 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2023-03-02T23:49:46.307Z,1677800986.307 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2023-03-02T23:49:46.344Z,1677800986.344 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2023-03-02T23:49:46.348Z,1677800986.348 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2023-03-02T23:49:46.380Z,1677800986.380 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2023-03-02T23:49:46.440Z,1677800986.440 [logger ThreadHandler](INFO): Thread cancelled.