2023-03-30T15:37:06.958Z,1680190626.958 [Supervisor](DEBUG): Initializing supervisor.
2023-03-30T15:37:06.964Z,1680190626.964 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2023-03-30T15:37:06.964Z,1680190626.964 [SyncHandler](INFO): Protected caller Thread ID is 6775
2023-03-30T15:37:06.965Z,1680190626.965 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2023-03-30T15:37:06.965Z,1680190626.965 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2023-03-30T15:37:06.966Z,1680190626.966 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 6776
2023-03-30T15:37:06.970Z,1680190626.970 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2023-03-30T15:37:06.989Z,1680190626.989 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2023-03-30T15:37:06.990Z,1680190626.990 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2023-03-30T15:37:06.990Z,1680190626.990 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 6777
2023-03-30T15:37:06.994Z,1680190626.994 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2023-03-30T15:37:06.995Z,1680190626.995 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2023-03-30T15:37:06.996Z,1680190626.996 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 6778
2023-03-30T15:37:06.998Z,1680190626.998 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2023-03-30T15:37:06.999Z,1680190626.999 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2023-03-30T15:37:06.999Z,1680190626.999 [logger ThreadHandler](INFO): Protected caller Thread ID is 6779
2023-03-30T15:37:07.003Z,1680190627.003 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2023-03-30T15:37:07.003Z,1680190627.003 [Supervisor](INFO): Looking for Config files in directory: Config/
2023-03-30T15:37:07.005Z,1680190627.005 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2023-03-30T15:37:07.523Z,1680190627.523 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2023-03-30T15:37:07.523Z,1680190627.523 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2023-03-30T15:37:07.729Z,1680190627.729 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2023-03-30T15:37:07.730Z,1680190627.730 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2023-03-30T15:37:07.808Z,1680190627.808 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2023-03-30T15:37:08.024Z,1680190628.024 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2023-03-30T15:37:08.024Z,1680190628.024 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2023-03-30T15:37:08.101Z,1680190628.101 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2023-03-30T15:37:08.195Z,1680190628.195 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2023-03-30T15:37:08.195Z,1680190628.195 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2023-03-30T15:37:08.529Z,1680190628.529 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2023-03-30T15:37:08.529Z,1680190628.529 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2023-03-30T15:37:08.659Z,1680190628.659 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2023-03-30T15:37:08.659Z,1680190628.659 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2023-03-30T15:37:09.144Z,1680190629.144 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2023-03-30T15:37:09.145Z,1680190629.145 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2023-03-30T15:37:09.327Z,1680190629.327 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2023-03-30T15:37:09.328Z,1680190629.328 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2023-03-30T15:37:09.725Z,1680190629.725 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2023-03-30T15:37:09.725Z,1680190629.725 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2023-03-30T15:37:10.003Z,1680190630.003 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2023-03-30T15:37:10.004Z,1680190630.004 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2023-03-30T15:37:10.113Z,1680190630.113 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2023-03-30T15:37:10.114Z,1680190630.114 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2023-03-30T15:37:10.933Z,1680190630.933 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2023-03-30T15:37:10.933Z,1680190630.933 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2023-03-30T15:37:11.261Z,1680190631.261 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2023-03-30T15:37:11.262Z,1680190631.262 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2023-03-30T15:37:11.479Z,1680190631.479 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2023-03-30T15:37:11.481Z,1680190631.481 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-triton/
2023-03-30T15:37:11.482Z,1680190631.482 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/vehicle.cfg
2023-03-30T15:37:11.667Z,1680190631.667 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/secure.cfg
2023-03-30T15:37:11.749Z,1680190631.749 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Science.cfg
2023-03-30T15:37:11.883Z,1680190631.883 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Simulator.cfg
2023-03-30T15:37:11.994Z,1680190631.994 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Battery.cfg
2023-03-30T15:37:12.673Z,1680190632.673 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2023-03-30T15:37:12.673Z,1680190632.673 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/logger.cfg
2023-03-30T15:37:12.775Z,1680190632.775 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Servo.cfg
2023-03-30T15:37:12.880Z,1680190632.880 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Navigation.cfg
2023-03-30T15:37:12.990Z,1680190632.990 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Sensor.cfg
2023-03-30T15:37:13.131Z,1680190633.131 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Control.cfg
2023-03-30T15:37:13.227Z,1680190633.227 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/BIT.cfg
2023-03-30T15:37:13.320Z,1680190633.320 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-triton/root/
2023-03-30T15:37:13.320Z,1680190633.320 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2023-03-30T15:37:13.333Z,1680190633.333 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2023-03-30T15:37:13.344Z,1680190633.344 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2023-03-30T15:37:13.345Z,1680190633.345 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2023-03-30T15:37:13.450Z,1680190633.450 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2023-03-30T15:37:13.451Z,1680190633.451 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2023-03-30T15:37:13.505Z,1680190633.505 [VerticalControl](DEBUG): Construct VerticalControl.
2023-03-30T15:37:13.565Z,1680190633.565 [VerticalControl] Loaded
2023-03-30T15:37:13.565Z,1680190633.565 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2023-03-30T15:37:13.568Z,1680190633.568 [HorizontalControl](DEBUG): Construct HorizontalControl.
2023-03-30T15:37:13.609Z,1680190633.609 [HorizontalControl] Loaded
2023-03-30T15:37:13.609Z,1680190633.609 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2023-03-30T15:37:13.612Z,1680190633.612 [SpeedControl](DEBUG): Construct SpeedControl.
2023-03-30T15:37:13.615Z,1680190633.615 [SpeedControl] Loaded
2023-03-30T15:37:13.615Z,1680190633.615 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2023-03-30T15:37:13.618Z,1680190633.618 [LoopControl](DEBUG): Construct LoopControl.
2023-03-30T15:37:13.618Z,1680190633.618 [LoopControl] Loaded
2023-03-30T15:37:13.619Z,1680190633.619 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2023-03-30T15:37:13.619Z,1680190633.619 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2023-03-30T15:37:13.619Z,1680190633.619 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2023-03-30T15:37:13.756Z,1680190633.756 [BuoyancyServo] Loaded
2023-03-30T15:37:13.756Z,1680190633.756 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2023-03-30T15:37:13.776Z,1680190633.776 [ElevatorServo] Loaded
2023-03-30T15:37:13.777Z,1680190633.777 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2023-03-30T15:37:13.796Z,1680190633.796 [MassServo] Loaded
2023-03-30T15:37:13.796Z,1680190633.796 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2023-03-30T15:37:13.815Z,1680190633.815 [RudderServo] Loaded
2023-03-30T15:37:13.815Z,1680190633.815 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2023-03-30T15:37:13.830Z,1680190633.830 [ThrusterHE] Loaded
2023-03-30T15:37:13.831Z,1680190633.831 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread.
2023-03-30T15:37:13.831Z,1680190633.831 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2023-03-30T15:37:13.832Z,1680190633.832 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2023-03-30T15:37:13.884Z,1680190633.884 [DepthRateCalculator] Loaded
2023-03-30T15:37:13.884Z,1680190633.884 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2023-03-30T15:37:13.889Z,1680190633.889 [PitchRateCalculator] Loaded
2023-03-30T15:37:13.889Z,1680190633.889 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2023-03-30T15:37:13.899Z,1680190633.899 [SpeedCalculator] Loaded
2023-03-30T15:37:13.899Z,1680190633.899 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2023-03-30T15:37:13.903Z,1680190633.903 [YawRateCalculator] Loaded
2023-03-30T15:37:13.904Z,1680190633.904 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2023-03-30T15:37:13.922Z,1680190633.922 [ElevatorOffsetCalculator] Loaded
2023-03-30T15:37:13.922Z,1680190633.922 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2023-03-30T15:37:13.923Z,1680190633.923 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2023-03-30T15:37:13.923Z,1680190633.923 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2023-03-30T15:37:14.039Z,1680190634.039 [DeadReckonUsingMultipleVelocitySources] Loaded
2023-03-30T15:37:14.039Z,1680190634.039 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2023-03-30T15:37:14.053Z,1680190634.053 [NavChart] Loaded
2023-03-30T15:37:14.053Z,1680190634.053 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2023-03-30T15:37:14.059Z,1680190634.059 [UniversalFixResidualReporter] Loaded
2023-03-30T15:37:14.060Z,1680190634.060 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2023-03-30T15:37:14.060Z,1680190634.060 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2023-03-30T15:37:14.061Z,1680190634.061 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2023-03-30T15:37:14.503Z,1680190634.503 [AHRS_M2] Loaded
2023-03-30T15:37:14.503Z,1680190634.503 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2023-03-30T15:37:14.539Z,1680190634.539 [BackseatComponent] Loaded
2023-03-30T15:37:14.539Z,1680190634.539 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread.
2023-03-30T15:37:14.540Z,1680190634.540 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 408E04E0
2023-03-30T15:37:14.541Z,1680190634.541 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 6862
2023-03-30T15:37:14.544Z,1680190634.544 [LcmUniversalReporter] Loaded
2023-03-30T15:37:14.544Z,1680190634.544 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread.
2023-03-30T15:37:15.392Z,1680190635.392 [BPC1] Loaded
2023-03-30T15:37:15.393Z,1680190635.393 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2023-03-30T15:37:15.466Z,1680190635.466 [DataOverHttps] Loaded
2023-03-30T15:37:15.466Z,1680190635.466 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2023-03-30T15:37:15.467Z,1680190635.467 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 409104E0
2023-03-30T15:37:15.467Z,1680190635.467 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 6863
2023-03-30T15:37:15.489Z,1680190635.489 [Depth_Keller] Loaded
2023-03-30T15:37:15.489Z,1680190635.489 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2023-03-30T15:37:15.494Z,1680190635.494 [DropWeight] Loaded
2023-03-30T15:37:15.494Z,1680190635.494 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2023-03-30T15:37:15.514Z,1680190635.514 [MultiRay] Loaded
2023-03-30T15:37:15.514Z,1680190635.514 [ComponentRegistry](DEBUG): SyncComponent "MultiRay" handled in the control thread.
2023-03-30T15:37:15.577Z,1680190635.577 [NAL9602] Loaded
2023-03-30T15:37:15.577Z,1680190635.577 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2023-03-30T15:37:15.608Z,1680190635.608 [Onboard] Loaded
2023-03-30T15:37:15.608Z,1680190635.608 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2023-03-30T15:37:15.609Z,1680190635.609 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 409404E0
2023-03-30T15:37:15.609Z,1680190635.609 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 6864
2023-03-30T15:37:15.622Z,1680190635.622 [Power24vConverter] Loaded
2023-03-30T15:37:15.622Z,1680190635.622 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2023-03-30T15:37:15.636Z,1680190635.636 [Radio_Surface] Loaded
2023-03-30T15:37:15.636Z,1680190635.636 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2023-03-30T15:37:15.637Z,1680190635.637 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409704E0
2023-03-30T15:37:15.638Z,1680190635.638 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 6865
2023-03-30T15:37:15.732Z,1680190635.732 [DAT] Loaded
2023-03-30T15:37:15.732Z,1680190635.732 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread.
2023-03-30T15:37:15.733Z,1680190635.733 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 409A04E0
2023-03-30T15:37:15.733Z,1680190635.733 [DAT ThreadHandler](INFO): Protected caller Thread ID is 6866
2023-03-30T15:37:15.734Z,1680190635.734 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2023-03-30T15:37:15.735Z,1680190635.735 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2023-03-30T15:37:15.793Z,1680190635.793 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2023-03-30T15:37:15.794Z,1680190635.794 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2023-03-30T15:37:15.956Z,1680190635.956 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2023-03-30T15:37:15.956Z,1680190635.956 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2023-03-30T15:37:15.986Z,1680190635.986 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2023-03-30T15:37:15.986Z,1680190635.986 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2023-03-30T15:37:16.165Z,1680190636.165 [CTD_Seabird] Loaded
2023-03-30T15:37:16.165Z,1680190636.165 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2023-03-30T15:37:16.166Z,1680190636.166 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40ACB4E0
2023-03-30T15:37:16.167Z,1680190636.167 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 6867
2023-03-30T15:37:16.200Z,1680190636.200 [ESPComponent] Loaded
2023-03-30T15:37:16.200Z,1680190636.200 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread.
2023-03-30T15:37:16.221Z,1680190636.221 [PAR_Licor] Loaded
2023-03-30T15:37:16.221Z,1680190636.221 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2023-03-30T15:37:16.253Z,1680190636.253 [WetLabsBB2FL] Loaded
2023-03-30T15:37:16.254Z,1680190636.254 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2023-03-30T15:37:16.255Z,1680190636.255 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40AFB4E0
2023-03-30T15:37:16.255Z,1680190636.255 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 6868
2023-03-30T15:37:16.256Z,1680190636.256 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2023-03-30T15:37:16.256Z,1680190636.256 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2023-03-30T15:37:16.575Z,1680190636.575 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2023-03-30T15:37:16.575Z,1680190636.575 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2023-03-30T15:37:16.720Z,1680190636.720 [SBIT](DEBUG): Construct Startup Built In Test.
2023-03-30T15:37:16.729Z,1680190636.729 [SBIT] Loaded
2023-03-30T15:37:16.729Z,1680190636.729 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2023-03-30T15:37:16.732Z,1680190636.732 [IBIT](DEBUG): Construct Initiated Built In Test.
2023-03-30T15:37:16.745Z,1680190636.745 [IBIT] Loaded
2023-03-30T15:37:16.745Z,1680190636.745 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2023-03-30T15:37:16.751Z,1680190636.751 [CBIT](DEBUG): Construct Continuous Built In Test.
2023-03-30T15:37:16.858Z,1680190636.858 [CBIT] Loaded
2023-03-30T15:37:16.858Z,1680190636.858 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2023-03-30T15:37:16.858Z,1680190636.858 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2023-03-30T15:37:16.865Z,1680190636.865 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2023-03-30T15:37:16.868Z,1680190636.868 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2023-03-30T15:37:16.879Z,1680190636.879 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2023-03-30T15:37:16.880Z,1680190636.880 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40BDE4E0
2023-03-30T15:37:16.881Z,1680190636.881 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 6869
2023-03-30T15:37:16.885Z,1680190636.885 [Supervisor](INFO): Main Thread ID is 6774
2023-03-30T15:37:16.885Z,1680190636.885 [Supervisor](DEBUG): Running supervisor.
2023-03-30T15:37:16.886Z,1680190636.886 [CommandExec ThreadHandler](INFO): Handler Thread ID is 6870
2023-03-30T15:37:16.887Z,1680190636.887 [CommandExec](INFO): Initializing the command executive.
2023-03-30T15:37:16.888Z,1680190636.888 [CommandLine ThreadHandler](INFO): Handler Thread ID is 6871
2023-03-30T15:37:16.890Z,1680190636.890 [controlThread ThreadHandler](INFO): Handler Thread ID is 6872
2023-03-30T15:37:16.891Z,1680190636.891 [controlThread](DEBUG): Initializing ControlThread
2023-03-30T15:37:16.892Z,1680190636.892 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2023-03-30T15:37:16.893Z,1680190636.893 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2023-03-30T15:37:16.894Z,1680190636.894 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2023-03-30T15:37:16.895Z,1680190636.895 [LoopControl](DEBUG): Initialize LoopControlComponent.
2023-03-30T15:37:16.896Z,1680190636.896 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2023-03-30T15:37:16.897Z,1680190636.897 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2023-03-30T15:37:16.897Z,1680190636.897 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2023-03-30T15:37:16.898Z,1680190636.898 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2023-03-30T15:37:16.898Z,1680190636.898 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2023-03-30T15:37:16.899Z,1680190636.899 [NavChart](DEBUG): Initialize NavChart Navigation.
2023-03-30T15:37:16.899Z,1680190636.899 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2023-03-30T15:37:16.907Z,1680190636.907 [SBIT](INFO): Initialize SBIT Component.
2023-03-30T15:37:16.907Z,1680190636.907 [SBIT](IMPORTANT): git: 2023-03-21-3-g7db59bcdb
2023-03-30T15:37:16.907Z,1680190636.907 [SBIT](INFO): git hash: 7db59bcdb6362513662bc3f7582b3d3b1dd3a28a
2023-03-30T15:37:16.908Z,1680190636.908 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2023-03-30T15:37:16.909Z,1680190636.909 [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-30T15:37:16.910Z,1680190636.910 [SBIT](INFO): Beginning SBIT in 81.000000 seconds.
2023-03-30T15:37:16.911Z,1680190636.911 [IBIT](INFO): Initialize IBIT Component.
2023-03-30T15:37:16.912Z,1680190636.912 [CBIT](DEBUG): Initialize CBIT Component.
2023-03-30T15:37:16.912Z,1680190636.912 [logger ThreadHandler](INFO): Handler Thread ID is 6873
2023-03-30T15:37:16.922Z,1680190636.922 [CBIT](DEBUG): Initialized mux pins.
2023-03-30T15:37:16.923Z,1680190636.923 [CBIT](DEBUG): Initializing the watchdog timer.
2023-03-30T15:37:16.931Z,1680190636.931 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 6874
2023-03-30T15:37:16.943Z,1680190636.943 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 6875
2023-03-30T15:37:16.944Z,1680190636.944 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2023-03-30T15:37:16.947Z,1680190636.947 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2023-03-30T15:37:16.947Z,1680190636.947 [CBIT](DEBUG): Initializing heartbeat.
2023-03-30T15:37:16.955Z,1680190636.955 [Onboard ThreadHandler](INFO): Handler Thread ID is 6876
2023-03-30T15:37:16.972Z,1680190636.972 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 6877
2023-03-30T15:37:16.991Z,1680190636.991 [DAT ThreadHandler](INFO): Handler Thread ID is 6878
2023-03-30T15:37:16.992Z,1680190636.992 [DAT](INFO): Powering up
2023-03-30T15:37:16.992Z,1680190636.992 [DAT](DEBUG): Initializing DAT.
2023-03-30T15:37:16.996Z,1680190636.996 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 6880
2023-03-30T15:37:16.996Z,1680190636.996 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2023-03-30T15:37:16.000Z,1680190637.000 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 6882
2023-03-30T15:37:17.003Z,1680190637.003 [WetLabsBB2FL](INFO): Powering up
2023-03-30T15:37:17.004Z,1680190637.004 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 6884
2023-03-30T15:37:17.012Z,1680190637.012 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2023-03-30T15:37:17.013Z,1680190637.013 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2023-03-30T15:37:17.013Z,1680190637.013 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2023-03-30T15:37:17.013Z,1680190637.013 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2023-03-30T15:37:17.013Z,1680190637.013 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2023-03-30T15:37:17.013Z,1680190637.013 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2023-03-30T15:37:17.014Z,1680190637.014 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2023-03-30T15:37:17.014Z,1680190637.014 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2023-03-30T15:37:17.026Z,1680190637.026 [CBIT](DEBUG): Deactivating GF circuits.
2023-03-30T15:37:17.027Z,1680190637.027 [CBIT](DEBUG): Deactivating emergency mode.
2023-03-30T15:37:17.066Z,1680190637.066 [CBIT](DEBUG): Backplane powered.
2023-03-30T15:37:17.067Z,1680190637.067 [MissionManager](INFO): Loading Mission from file: Missions/Startup.xml
2023-03-30T15:37:17.117Z,1680190637.117 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2023-03-30T15:37:17.264Z,1680190637.264 [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-30T15:37:17.265Z,1680190637.265 [MissionManager](INFO): Loading Mission from file: Missions/Default.xml
2023-03-30T15:37:17.379Z,1680190637.379 [Radio_Surface](INFO): Powering up
2023-03-30T15:37:17.666Z,1680190637.666 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2023-03-30T15:37:17.679Z,1680190637.679 [Default:A.Wait](DEBUG): Construct Wait.
2023-03-30T15:37:17.681Z,1680190637.681 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2023-03-30T15:37:17.708Z,1680190637.708 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2023-03-30T15:37:17.731Z,1680190637.731 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2023-03-30T15:37:17.737Z,1680190637.737 [Default:E.Execute](DEBUG): Construct Execute.
2023-03-30T15:37:17.756Z,1680190637.756 [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-30T15:37:17.761Z,1680190637.761 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,MultiRay,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-30T15:37:17.784Z,1680190637.784 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2023-03-30T15:37:17.857Z,1680190637.857 [MultiRay](INFO): Powering up MultiRay Lights
2023-03-30T15:37:17.895Z,1680190637.895 [Power24vConverter](INFO): Powering up.
2023-03-30T15:37:17.962Z,1680190637.962 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2023-03-30T15:37:17.971Z,1680190637.971 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2023-03-30T15:37:17.972Z,1680190637.972 [ElevatorServo](DEBUG): Initializing EZServoServo.
2023-03-30T15:37:17.979Z,1680190637.979 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2023-03-30T15:37:17.980Z,1680190637.980 [MassServo](DEBUG): Initializing EZServoServo.
2023-03-30T15:37:17.987Z,1680190637.987 [MassServo](DEBUG): Initializing MassServo.
2023-03-30T15:37:17.988Z,1680190637.988 [RudderServo](DEBUG): Initializing EZServoServo.
2023-03-30T15:37:17.995Z,1680190637.995 [RudderServo](DEBUG): Initializing RudderServo.
2023-03-30T15:37:17.995Z,1680190637.995 [ThrusterHE](DEBUG): Initializing EZServoServo.
2023-03-30T15:37:18.003Z,1680190638.003 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2023-03-30T15:37:18.200Z,1680190638.200 [DropWeight](CRITICAL): DROP WEIGHT MISSING.

2023-03-30T15:37:18.200Z,1680190638.200 [DropWeight] Hardware Fault, FailCount= 1
2023-03-30T15:37:18.200Z,1680190638.200 [DropWeight](ERROR): Hardware Fault
2023-03-30T15:37:18.267Z,1680190638.267 [CommandExec](FAULT): Scheduling is paused
2023-03-30T15:37:18.267Z,1680190638.267 [CBIT](INFO): Critical error at 20230330T153718
2023-03-30T15:37:18.267Z,1680190638.267 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2023-03-30T15:37:18.270Z,1680190638.270 [CBIT](ERROR): Hardware Fault in component: DropWeight
2023-03-30T15:37:18.278Z,1680190638.278 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2023-03-30T15:37:18.922Z,1680190638.922 [RudderServo](ERROR): Rudder initialization uart error serial timeout
2023-03-30T15:37:18.923Z,1680190638.923 [RudderServo](FAULT): Rudder failed to initialize
2023-03-30T15:37:18.923Z,1680190638.923 [RudderServo] Communications Fault, FailCount= 1
2023-03-30T15:37:18.923Z,1680190638.923 [RudderServo](ERROR): Communications Fault
2023-03-30T15:37:18.924Z,1680190638.924 [CBIT](INFO): Critical error at 20230330T153718
2023-03-30T15:37:18.927Z,1680190638.927 [CBIT](ERROR): Communications Fault in component: RudderServo
2023-03-30T15:37:19.111Z,1680190639.111 [WetLabsBB2FL](INFO): Powering down
2023-03-30T15:37:19.396Z,1680190639.396 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2023-03-30T15:37:19.396Z,1680190639.396 [RudderServo](INFO): Powering down
2023-03-30T15:37:19.827Z,1680190639.827 [RudderServo](DEBUG): Initializing EZServoServo.
2023-03-30T15:37:19.947Z,1680190639.947 [RudderServo](DEBUG): Initializing RudderServo.
2023-03-30T15:37:19.951Z,1680190639.951 [CBIT](INFO): Clearing failed state for component RudderServo
2023-03-30T15:37:19.951Z,1680190639.951 [RudderServo] No Fault, FailCount= 1
2023-03-30T15:37:23.667Z,1680190643.667 [ThrusterHE](ERROR): Zero Speed Commanded.
2023-03-30T15:37:29.091Z,1680190649.091 [DAT](INFO): DAT read: 

2023-03-30T15:37:29.092Z,1680190649.092 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series

2023-03-30T15:37:30.855Z,1680190650.855 [DAT](INFO): DAT read: MF Frequency Band

2023-03-30T15:37:30.856Z,1680190650.856 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.15.0

2023-03-30T15:37:30.857Z,1680190650.857 [DAT](INFO): DAT read: Mar 30 2023 00:23:15 

2023-03-30T15:37:30.885Z,1680190650.885 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004712
2023-03-30T15:37:31.868Z,1680190651.868 [DAT](INFO): DAT read: Features enabled [Bearing]

2023-03-30T15:37:31.870Z,1680190651.870 [DAT](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP

2023-03-30T15:37:31.871Z,1680190651.871 [DAT](INFO): commRate: 800
2023-03-30T15:37:33.930Z,1680190653.930 [DAT](INFO): entering command mode
2023-03-30T15:37:34.131Z,1680190654.131 [DAT](INFO): DAT read: 

2023-03-30T15:37:34.132Z,1680190654.132 [DAT](INFO): DAT read: user:1>

2023-03-30T15:37:34.132Z,1680190654.132 [DAT](INFO): setting verbose to 3
2023-03-30T15:37:34.383Z,1680190654.383 [DAT](INFO): DAT read: user:1>

2023-03-30T15:37:34.384Z,1680190654.384 [DAT](INFO): DAT read: Verbose         | 3           

2023-03-30T15:37:34.384Z,1680190654.384 [DAT](INFO): set verbose to 3
2023-03-30T15:37:34.385Z,1680190654.385 [DAT](INFO): setting DatVerbose to 27440
2023-03-30T15:37:34.635Z,1680190654.635 [DAT](INFO): DAT read: user:2>

2023-03-30T15:37:34.636Z,1680190654.636 [DAT](INFO): DAT read: DatVerbose      | 27440       

2023-03-30T15:37:34.636Z,1680190654.636 [DAT](INFO): set DatVerbose to 27440
2023-03-30T15:37:34.637Z,1680190654.637 [DAT](INFO): setting transmit power to 8
2023-03-30T15:37:34.887Z,1680190654.887 [DAT](INFO): DAT read: user:3>

2023-03-30T15:37:34.888Z,1680190654.888 [DAT](INFO): DAT read: TxPower         | 8 (Max)     

2023-03-30T15:37:34.889Z,1680190654.889 [DAT](INFO): set transmit power to 8
2023-03-30T15:37:34.889Z,1680190654.889 [DAT](INFO): setting local address to 5
2023-03-30T15:37:35.139Z,1680190655.139 [DAT](INFO): DAT read: user:4>

2023-03-30T15:37:35.140Z,1680190655.140 [DAT](INFO): DAT read: LocalAddr       | 5           

2023-03-30T15:37:35.140Z,1680190655.140 [DAT](INFO): set local address to 5
2023-03-30T15:37:35.141Z,1680190655.141 [DAT](INFO): Setting time to: 15:37:35 And date to:3/30/2023
2023-03-30T15:37:35.391Z,1680190655.391 [DAT](INFO): DAT read: user:5>

2023-03-30T15:37:35.392Z,1680190655.392 [DAT](INFO): DAT read: Thu Mar 30, 2023  15:37:35  

2023-03-30T15:37:35.393Z,1680190655.393 [DAT](INFO): Local DAT time set to Thu Mar 30, 2023  15:37:35  

2023-03-30T15:37:45.672Z,1680190665.672 [NAL9602](INFO): Powering up NAL9602
2023-03-30T15:37:49.823Z,1680190669.823 [CommandExec](IMPORTANT): got command gfscan
2023-03-30T15:37:50.187Z,1680190670.187 [CBIT](IMPORTANT): Beginning ground fault scan
2023-03-30T15:37:56.584Z,1680190676.584 [NAL9602](INFO): NAL9602 initialized
2023-03-30T15:38:01.112Z,1680190681.112 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.012393
CHAN A1 (24V): -0.008319
CHAN A2 (12V): -0.005402
CHAN A3 (5V): -0.003087
CHAN B0 (3.3V): -0.001161
CHAN B1 (3.15aV): -0.000667
CHAN B2 (3.15bV): -0.001332
CHAN B3 (GND): -0.000363
OPEN: -0.001012
Full Scale: +/- 1 mA
2023-03-30T15:38:38.653Z,1680190718.653 [SBIT](IMPORTANT): Beginning Startup BIT
2023-03-30T15:38:38.658Z,1680190718.658 [CBIT](IMPORTANT): Beginning ground fault scan
2023-03-30T15:38:49.528Z,1680190729.528 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.012138
CHAN A1 (24V): -0.007624
CHAN A2 (12V): -0.005123
CHAN A3 (5V): -0.003166
CHAN B0 (3.3V): -0.001610
CHAN B1 (3.15aV): -0.000547
CHAN B2 (3.15bV): -0.000470
CHAN B3 (GND): -0.000477
OPEN: 0.005111
Full Scale: +/- 1 mA
2023-03-30T15:39:32.787Z,1680190772.787 [SBIT](IMPORTANT): SBIT PASSED
2023-03-30T15:39:32.788Z,1680190772.788 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2023-03-30T15:39:32.788Z,1680190772.788 [SBIT](IMPORTANT): BPC1.batteryMissingStickThreshold=6 count;

2023-03-30T15:39:32.789Z,1680190772.789 [SBIT](IMPORTANT): BackseatComponent.alwaysOn=0 bool;

2023-03-30T15:39:32.789Z,1680190772.789 [SBIT](IMPORTANT): ESPComponent.loadAtStartup=1 bool;

2023-03-30T15:39:32.789Z,1680190772.789 [SBIT](IMPORTANT): ESPComponent.sampleTimeout=10 minute;

2023-03-30T15:39:32.789Z,1680190772.789 [SBIT](IMPORTANT): ESPComponent.simulateHardware=1 bool;

2023-03-30T15:39:32.789Z,1680190772.789 [SBIT](IMPORTANT): Express none WetLabsBB2FL.bin_mean_mass_concentration_of_chlorophyll_in_sea_water;

2023-03-30T15:39:32.789Z,1680190772.789 [SBIT](IMPORTANT): Express none WetLabsBB2FL.bin_median_mass_concentration_of_chlorophyll_in_sea_water;

2023-03-30T15:39:32.789Z,1680190772.789 [SBIT](IMPORTANT): Express linearApproximation platform_roll_angle 5.000000 degree;

2023-03-30T15:39:32.789Z,1680190772.789 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=184.896478 cubic_centimeter;

2023-03-30T15:39:32.790Z,1680190772.790 [SBIT](IMPORTANT): VerticalControl.elevDeadband=0.1 angular_degree;

2023-03-30T15:39:32.790Z,1680190772.790 [SBIT](IMPORTANT): VerticalControl.massDefault=15.484465 millimeter;

2023-03-30T15:39:33.164Z,1680190773.164 [MissionManager](IMPORTANT): Started mission Startup
2023-03-30T15:39:33.164Z,1680190773.164 [Startup] Running Loop=1
2023-03-30T15:39:33.164Z,1680190773.164 [Startup](DEBUG): Aggregate::initialize Startup
2023-03-30T15:39:33.164Z,1680190773.164 [Startup:A.GoToSurface] Running Loop=1
2023-03-30T15:39:33.165Z,1680190773.165 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2023-03-30T15:39:33.165Z,1680190773.165 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2023-03-30T15:39:33.166Z,1680190773.166 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2023-03-30T15:39:33.166Z,1680190773.166 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2023-03-30T15:39:33.167Z,1680190773.167 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2023-03-30T15:39:33.167Z,1680190773.167 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2023-03-30T15:39:33.169Z,1680190773.169 [Startup:StartupSatComms] Running Loop=1
2023-03-30T15:39:33.169Z,1680190773.169 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2023-03-30T15:39:33.169Z,1680190773.169 [Startup:StartupSatComms:A] Running Loop=1
2023-03-30T15:39:33.565Z,1680190773.565 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2023-03-30T15:39:45.674Z,1680190785.674 [BPC1](ERROR): BPC1B: No match for serial number 0C29 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2023-03-30T15:39:59.013Z,1680190799.013 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2023-03-30T15:39:59.027Z,1680190799.027 [BPC1](ERROR): BPC1B: No match for serial number 0C29 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2023-03-30T15:40:12.337Z,1680190812.337 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2023-03-30T15:40:12.343Z,1680190812.343 [BPC1](ERROR): BPC1B: No match for serial number 0C29 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2023-03-30T15:40:17.217Z,1680190817.217 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2023-03-30T15:40:17.217Z,1680190817.217 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-30T15:40:17.241Z,1680190817.241 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-30T15:40:17.612Z,1680190817.612 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-30T15:40:17.612Z,1680190817.612 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2023-03-30T15:40:26.126Z,1680190826.126 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2023-03-30T15:40:26.133Z,1680190826.133 [BPC1](ERROR): BPC1B: No match for serial number 0C29 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2023-03-30T15:40:33.348Z,1680190833.348 [Startup:StartupSatComms:A](INFO): Timed out from 2023-03-30T15:39:33.2Z
2023-03-30T15:40:33.348Z,1680190833.348 [Startup:StartupSatComms:A] Stopped
2023-03-30T15:40:33.348Z,1680190833.348 [Startup:StartupSatComms:B] Running Loop=1
2023-03-30T15:40:33.752Z,1680190833.752 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2023-03-30T15:40:39.496Z,1680190839.496 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2023-03-30T15:40:39.500Z,1680190839.500 [BPC1](ERROR): BPC1B: No match for serial number 1717 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2023-03-30T15:40:39.509Z,1680190839.509 [BPC1](ERROR): BPC1B: No match for serial number 0C29 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2023-03-30T15:40:40.490Z,1680190840.490 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230329T161250/Courier0139.lzma
2023-03-30T15:40:41.497Z,1680190841.497 [DataOverHttps](INFO): Moved sent file to Logs/20230329T161250/Courier0139.lzma.bak
2023-03-30T15:40:41.497Z,1680190841.497 [DataOverHttps](INFO): SBD MOMSN=17820821
2023-03-30T15:40:53.136Z,1680190853.136 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2023-03-30T15:40:53.162Z,1680190853.162 [BPC1](ERROR): BPC1B: No match for serial number 0C29 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2023-03-30T15:40:57.158Z,1680190857.158 [DataOverHttps](INFO): Sending 242 bytes from file Logs/20230330T153706/Courier0000.lzma
2023-03-30T15:40:58.160Z,1680190858.160 [DataOverHttps](INFO): Moved sent file to Logs/20230330T153706/Courier0000.lzma.bak
2023-03-30T15:40:58.160Z,1680190858.160 [DataOverHttps](INFO): SBD MOMSN=17820823
2023-03-30T15:41:06.872Z,1680190866.872 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2023-03-30T15:41:06.878Z,1680190866.878 [BPC1](ERROR): BPC1B: No match for serial number 0C29 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2023-03-30T15:41:13.694Z,1680190873.694 [DataOverHttps](INFO): Sending 182 bytes from file Logs/20230329T161250/Express0140.lzma
2023-03-30T15:41:14.697Z,1680190874.697 [DataOverHttps](INFO): Moved sent file to Logs/20230329T161250/Express0140.lzma.bak
2023-03-30T15:41:14.697Z,1680190874.697 [DataOverHttps](INFO): SBD MOMSN=17820851
2023-03-30T15:41:20.204Z,1680190880.204 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2023-03-30T15:41:20.210Z,1680190880.210 [BPC1](ERROR): BPC1B: No match for serial number 0C29 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2023-03-30T15:41:30.424Z,1680190890.424 [DataOverHttps](INFO): Sending 1101 bytes from file Logs/20230330T153706/Express0001.lzma
2023-03-30T15:41:31.424Z,1680190891.424 [DataOverHttps](INFO): Moved sent file to Logs/20230330T153706/Express0001.lzma.bak
2023-03-30T15:41:31.425Z,1680190891.425 [DataOverHttps](INFO): SBD MOMSN=17820857
2023-03-30T15:41:33.258Z,1680190893.258 [Startup:StartupSatComms:B] Stopped
2023-03-30T15:41:33.258Z,1680190893.258 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2023-03-30T15:41:33.258Z,1680190893.258 [Startup:StartupSatComms] Stopped
2023-03-30T15:41:33.258Z,1680190893.258 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2023-03-30T15:41:33.259Z,1680190893.259 [Startup](INFO): Completed Startup
2023-03-30T15:41:33.259Z,1680190893.259 [MissionManager](INFO): Startup is completed.
2023-03-30T15:41:33.259Z,1680190893.259 [MissionManager](INFO): Uninitializing Mission Startup
2023-03-30T15:41:33.259Z,1680190893.259 [Startup] Stopped
2023-03-30T15:41:33.259Z,1680190893.259 [Startup](DEBUG): Aggregate::uninitialize Startup
2023-03-30T15:41:33.259Z,1680190893.259 [Startup:A.GoToSurface] Stopped
2023-03-30T15:41:33.259Z,1680190893.259 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2023-03-30T15:41:33.536Z,1680190893.536 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2023-03-30T15:41:33.541Z,1680190893.541 [BPC1](ERROR): BPC1B: No match for serial number 0C29 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2023-03-30T15:41:33.552Z,1680190893.552 [MissionManager](IMPORTANT): Started mission Default
2023-03-30T15:41:33.552Z,1680190893.552 [Default] Running Loop=1
2023-03-30T15:41:33.552Z,1680190893.552 [Default](DEBUG): Aggregate::initialize Default
2023-03-30T15:41:33.552Z,1680190893.552 [Default:B.GoToSurface] Running Loop=1
2023-03-30T15:41:33.553Z,1680190893.553 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2023-03-30T15:41:33.553Z,1680190893.553 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2023-03-30T15:41:33.553Z,1680190893.553 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2023-03-30T15:41:33.553Z,1680190893.553 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2023-03-30T15:41:33.554Z,1680190893.554 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2023-03-30T15:41:33.554Z,1680190893.554 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2023-03-30T15:41:33.570Z,1680190893.570 [Default:A.Wait] Running Loop=1
2023-03-30T15:41:33.571Z,1680190893.571 [Default:A.Wait](DEBUG): Initialize Wait Component.
2023-03-30T15:41:46.995Z,1680190906.995 [Default:A.Wait](INFO): Done Waiting.
2023-03-30T15:41:46.995Z,1680190906.995 [Default:A.Wait] Stopped
2023-03-30T15:41:46.996Z,1680190906.996 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2023-03-30T15:41:47.272Z,1680190907.272 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2023-03-30T15:41:47.278Z,1680190907.278 [BPC1](ERROR): BPC1B: No match for serial number 0C29 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2023-03-30T15:41:47.289Z,1680190907.289 [Default:CheckIn] Running Loop=1
2023-03-30T15:41:47.289Z,1680190907.289 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-03-30T15:41:47.289Z,1680190907.289 [Default:CheckIn:Read_GPS] Running Loop=1
2023-03-30T15:41:47.708Z,1680190907.708 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2023-03-30T15:42:01.012Z,1680190921.012 [BPC1](ERROR): BPC1B: No match for serial number 0BEC in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2023-03-30T15:42:01.019Z,1680190921.019 [BPC1](ERROR): BPC1B: No match for serial number 0C29 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file).
2023-03-30T15:43:00.420Z,1680190980.420 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2023-03-30T15:43:18.221Z,1680190998.221 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2023-03-30T15:43:18.221Z,1680190998.221 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-30T15:43:18.231Z,1680190998.231 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-30T15:43:18.648Z,1680190998.648 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-30T15:43:18.648Z,1680190998.648 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2023-03-30T15:44:43.034Z,1680191083.034 [BPC1](INFO): Calculating totals. Valid battery stick count: 55. Valid reserve battery stick count: 5.
2023-03-30T15:44:43.038Z,1680191083.038 [BPC1](INFO): Received data from all battery sticks.
2023-03-30T15:46:19.219Z,1680191179.219 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2023-03-30T15:46:19.219Z,1680191179.219 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-30T15:46:19.238Z,1680191179.238 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-30T15:46:19.617Z,1680191179.617 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-30T15:46:19.617Z,1680191179.617 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2023-03-30T15:46:47.485Z,1680191207.485 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-03-30T15:41:47.3Z
2023-03-30T15:46:47.485Z,1680191207.485 [Default:CheckIn:Read_GPS] Stopped
2023-03-30T15:46:47.485Z,1680191207.485 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-03-30T15:46:47.880Z,1680191207.880 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2023-03-30T15:46:54.742Z,1680191214.742 [DataOverHttps](INFO): Sending 168 bytes from file Logs/20230330T153706/Courier0004.lzma
2023-03-30T15:46:55.744Z,1680191215.744 [DataOverHttps](INFO): Moved sent file to Logs/20230330T153706/Courier0004.lzma.bak
2023-03-30T15:46:55.744Z,1680191215.744 [DataOverHttps](INFO): SBD MOMSN=17821232
2023-03-30T15:47:11.246Z,1680191231.246 [DataOverHttps](INFO): Sending 198 bytes from file Logs/20230330T153706/Express0005.lzma
2023-03-30T15:47:12.248Z,1680191232.248 [DataOverHttps](INFO): Moved sent file to Logs/20230330T153706/Express0005.lzma.bak
2023-03-30T15:47:12.248Z,1680191232.248 [DataOverHttps](INFO): SBD MOMSN=17821234
2023-03-30T15:47:14.164Z,1680191234.164 [Default:CheckIn:Read_Iridium] Stopped
2023-03-30T15:47:14.164Z,1680191234.164 [Default:CheckIn:C.Wait] Running Loop=1
2023-03-30T15:47:14.164Z,1680191234.164 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-03-30T15:47:57.764Z,1680191277.764 [NAL9602](FAULT): GPS failed to acquire within timeout.
2023-03-30T15:47:57.764Z,1680191277.764 [NAL9602] Data Fault, FailCount= 1
2023-03-30T15:47:57.764Z,1680191277.764 [NAL9602](ERROR): Data Fault
2023-03-30T15:47:57.809Z,1680191277.809 [CBIT](ERROR): Data Fault in component: NAL9602
2023-03-30T15:47:58.168Z,1680191278.168 [NAL9602](INFO): Powering down
2023-03-30T15:47:58.998Z,1680191278.998 [CBIT](INFO): Clearing failed state for component NAL9602
2023-03-30T15:47:58.998Z,1680191278.998 [NAL9602] No Fault, FailCount= 1
2023-03-30T15:48:28.464Z,1680191308.464 [NAL9602](INFO): Powering up NAL9602
2023-03-30T15:48:39.373Z,1680191319.373 [NAL9602](INFO): NAL9602 initialized
2023-03-30T15:49:20.188Z,1680191360.188 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2023-03-30T15:49:20.188Z,1680191360.188 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-30T15:49:20.203Z,1680191360.203 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-30T15:49:20.605Z,1680191360.605 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-30T15:49:20.605Z,1680191360.605 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2023-03-30T15:49:25.139Z,1680191365.139 [CommandExec](IMPORTANT): got command gfscan
2023-03-30T15:49:25.464Z,1680191365.464 [CBIT](IMPORTANT): Beginning ground fault scan
2023-03-30T15:49:36.391Z,1680191376.391 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.013953
CHAN A1 (24V): -0.007917
CHAN A2 (12V): -0.005031
CHAN A3 (5V): -0.002695
CHAN B0 (3.3V): -0.000525
CHAN B1 (3.15aV): -0.001169
CHAN B2 (3.15bV): -0.000831
CHAN B3 (GND): 0.000521
OPEN: 0.004890
Full Scale: +/- 1 mA
2023-03-30T15:52:14.728Z,1680191534.728 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2023-03-30T15:52:14.728Z,1680191534.728 [Default:CheckIn:C.Wait] Stopped
2023-03-30T15:52:14.728Z,1680191534.728 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-03-30T15:52:14.728Z,1680191534.728 [Default:CheckIn:D] Running Loop=1
2023-03-30T15:52:15.143Z,1680191535.143 [Default:CheckIn:D] Stopped
2023-03-30T15:52:15.143Z,1680191535.143 [Default:CheckIn:E] Running Loop=1
2023-03-30T15:52:15.560Z,1680191535.560 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 10.693178 min 
2023-03-30T15:52:15.560Z,1680191535.560 [Default:CheckIn:E] Stopped
2023-03-30T15:52:15.560Z,1680191535.560 [Default:CheckIn](INFO): Completed Default:CheckIn
2023-03-30T15:52:15.560Z,1680191535.560 [Default:CheckIn] Stopped
2023-03-30T15:52:15.561Z,1680191535.561 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-03-30T15:52:15.561Z,1680191535.561 [Default:CheckIn](INFO): Running loop #2
2023-03-30T15:52:15.561Z,1680191535.561 [Default:CheckIn] Running Loop=2
2023-03-30T15:52:15.561Z,1680191535.561 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2023-03-30T15:52:15.561Z,1680191535.561 [Default:CheckIn:Read_GPS] Running Loop=1
2023-03-30T15:52:18.378Z,1680191538.378 [CBIT](INFO): Clearing failed state for component DropWeight
2023-03-30T15:52:18.378Z,1680191538.378 [DropWeight] No Fault, FailCount= 1
2023-03-30T15:52:21.189Z,1680191541.189 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5
2023-03-30T15:52:21.189Z,1680191541.189 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-30T15:52:21.199Z,1680191541.199 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-30T15:52:21.607Z,1680191541.607 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-30T15:52:21.607Z,1680191541.607 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5
2023-03-30T15:55:22.227Z,1680191722.227 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6
2023-03-30T15:55:22.227Z,1680191722.227 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-30T15:55:22.238Z,1680191722.238 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-30T15:55:22.653Z,1680191722.653 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-30T15:55:22.653Z,1680191722.653 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6
2023-03-30T15:57:15.761Z,1680191835.761 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-03-30T15:52:15.6Z
2023-03-30T15:57:15.761Z,1680191835.761 [Default:CheckIn:Read_GPS] Stopped
2023-03-30T15:57:15.761Z,1680191835.761 [Default:CheckIn:Read_Iridium] Running Loop=1
2023-03-30T15:57:21.766Z,1680191841.766 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230330T153706/Courier0007.lzma
2023-03-30T15:57:22.768Z,1680191842.768 [DataOverHttps](INFO): Moved sent file to Logs/20230330T153706/Courier0007.lzma.bak
2023-03-30T15:57:22.768Z,1680191842.768 [DataOverHttps](INFO): SBD MOMSN=17821636
2023-03-30T15:57:38.238Z,1680191858.238 [DataOverHttps](INFO): Sending 382 bytes from file Logs/20230330T153706/Express0008.lzma
2023-03-30T15:57:39.240Z,1680191859.240 [DataOverHttps](INFO): Moved sent file to Logs/20230330T153706/Express0008.lzma.bak
2023-03-30T15:57:39.240Z,1680191859.240 [DataOverHttps](INFO): SBD MOMSN=17821638
2023-03-30T15:57:41.233Z,1680191861.233 [Default:CheckIn:Read_Iridium] Stopped
2023-03-30T15:57:41.233Z,1680191861.233 [Default:CheckIn:C.Wait] Running Loop=1
2023-03-30T15:57:41.233Z,1680191861.233 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2023-03-30T15:58:23.260Z,1680191903.260 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7
2023-03-30T15:58:23.260Z,1680191903.260 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2023-03-30T15:58:23.271Z,1680191903.271 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2023-03-30T15:58:23.661Z,1680191903.661 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2023-03-30T15:58:23.662Z,1680191903.662 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7
2023-03-30T15:58:40.197Z,1680191920.197 [NAL9602](FAULT): GPS failed to acquire within timeout.
2023-03-30T15:58:40.197Z,1680191920.197 [NAL9602] Data Fault, FailCount= 2
2023-03-30T15:58:40.197Z,1680191920.197 [NAL9602](ERROR): Data Fault
2023-03-30T15:58:40.246Z,1680191920.246 [CBIT](ERROR): Data Fault in component: NAL9602
2023-03-30T15:58:40.600Z,1680191920.600 [NAL9602](INFO): Powering down
2023-03-30T15:58:41.424Z,1680191921.424 [CBIT](INFO): Clearing failed state for component NAL9602
2023-03-30T15:58:41.424Z,1680191921.424 [NAL9602] No Fault, FailCount= 2
2023-03-30T15:59:10.900Z,1680191950.900 [NAL9602](INFO): Powering up NAL9602
2023-03-30T15:59:21.805Z,1680191961.805 [NAL9602](INFO): NAL9602 initialized
2023-03-30T16:01:10.703Z,1680192070.703 [CommandExec](IMPORTANT): got command quit
2023-03-30T16:01:11.707Z,1680192071.707 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread.
2023-03-30T16:01:11.707Z,1680192071.707 [CommandExec](INFO): Uninitializing the command executive.
2023-03-30T16:01:11.707Z,1680192071.707 [CommandExec](INFO): Uninitializing the command scheduler.
2023-03-30T16:01:11.707Z,1680192071.707 [CommandExec ThreadHandler](INFO): Thread cancelled.
2023-03-30T16:01:11.763Z,1680192071.763 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2023-03-30T16:01:11.763Z,1680192071.763 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2023-03-30T16:01:11.763Z,1680192071.763 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2023-03-30T16:01:11.764Z,1680192071.764 [NavChartDb](INFO): Join timeout helper Thread ID is 6924
2023-03-30T16:01:11.839Z,1680192071.839 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2023-03-30T16:01:11.839Z,1680192071.839 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2023-03-30T16:01:11.843Z,1680192071.843 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2023-03-30T16:01:11.843Z,1680192071.843 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2023-03-30T16:01:11.843Z,1680192071.843 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 6925
2023-03-30T16:01:11.899Z,1680192071.899 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2023-03-30T16:01:11.899Z,1680192071.899 [WetLabsBB2FL](INFO): Powering down
2023-03-30T16:01:11.900Z,1680192071.900 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2023-03-30T16:01:11.910Z,1680192071.910 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2023-03-30T16:01:11.911Z,1680192071.911 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2023-03-30T16:01:11.911Z,1680192071.911 [CTD_Seabird](INFO): Join timeout helper Thread ID is 6926
2023-03-30T16:01:11.943Z,1680192071.943 [CTD_Seabird](INFO): Powering down
2023-03-30T16:01:11.955Z,1680192071.955 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2023-03-30T16:01:11.955Z,1680192071.955 [CTD_Seabird](INFO): Powering down
2023-03-30T16:01:11.966Z,1680192071.966 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2023-03-30T16:01:11.982Z,1680192071.982 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler
2023-03-30T16:01:11.982Z,1680192071.982 [DAT ThreadHandler](INFO): Thread cancelled.
2023-03-30T16:01:11.983Z,1680192071.983 [DAT](INFO): Join timeout helper Thread ID is 6927
2023-03-30T16:01:12.171Z,1680192072.171 [DAT](INFO): Powering down
2023-03-30T16:01:12.243Z,1680192072.243 [DAT ThreadHandler](INFO): Uninitializing protected caller thread.
2023-03-30T16:01:12.243Z,1680192072.243 [DAT](INFO): Powering down
2023-03-30T16:01:12.245Z,1680192072.245 [DAT ThreadHandler](INFO): Thread cancelled.
2023-03-30T16:01:12.250Z,1680192072.250 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2023-03-30T16:01:12.251Z,1680192072.251 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2023-03-30T16:01:12.251Z,1680192072.251 [Radio_Surface](INFO): Join timeout helper Thread ID is 6928
2023-03-30T16:01:12.606Z,1680192072.606 [Radio_Surface](INFO): Powering down
2023-03-30T16:01:12.607Z,1680192072.607 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2023-03-30T16:01:12.608Z,1680192072.608 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2023-03-30T16:01:12.611Z,1680192072.611 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2023-03-30T16:01:12.611Z,1680192072.611 [Onboard ThreadHandler](INFO): Thread cancelled.
2023-03-30T16:01:12.612Z,1680192072.612 [Onboard](INFO): Join timeout helper Thread ID is 6929
2023-03-30T16:01:13.110Z,1680192073.110 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2023-03-30T16:01:13.111Z,1680192073.111 [Onboard ThreadHandler](INFO): Thread cancelled.
2023-03-30T16:01:13.127Z,1680192073.127 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2023-03-30T16:01:13.127Z,1680192073.127 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2023-03-30T16:01:13.128Z,1680192073.128 [DataOverHttps](INFO): Join timeout helper Thread ID is 6930
2023-03-30T16:01:13.258Z,1680192073.258 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2023-03-30T16:01:13.259Z,1680192073.259 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2023-03-30T16:01:13.267Z,1680192073.267 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler
2023-03-30T16:01:13.267Z,1680192073.267 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2023-03-30T16:01:13.268Z,1680192073.268 [BackseatComponent](INFO): Join timeout helper Thread ID is 6931
2023-03-30T16:01:13.311Z,1680192073.311 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread.
2023-03-30T16:01:13.311Z,1680192073.311 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2023-03-30T16:01:13.315Z,1680192073.315 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2023-03-30T16:01:13.315Z,1680192073.315 [logger ThreadHandler](INFO): Thread cancelled.
2023-03-30T16:01:13.316Z,1680192073.316 [logger](INFO): Join timeout helper Thread ID is 6932
2023-03-30T16:01:13.360Z,1680192073.360 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2023-03-30T16:01:13.360Z,1680192073.360 [logger ThreadHandler](INFO): Thread cancelled.
2023-03-30T16:01:13.367Z,1680192073.367 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2023-03-30T16:01:13.367Z,1680192073.367 [CommandLine ThreadHandler](INFO): Thread cancelled.
2023-03-30T16:01:13.368Z,1680192073.368 [CommandLine](INFO): Join timeout helper Thread ID is 6933
2023-03-30T16:01:13.427Z,1680192073.427 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2023-03-30T16:01:13.427Z,1680192073.427 [CommandLine ThreadHandler](INFO): Thread cancelled.
2023-03-30T16:01:13.435Z,1680192073.435 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler
2023-03-30T16:01:13.435Z,1680192073.435 [CommandExec ThreadHandler](INFO): Thread cancelled.
2023-03-30T16:01:13.436Z,1680192073.436 [CommandExec](INFO): Join timeout helper Thread ID is 6934
2023-03-30T16:01:13.437Z,1680192073.437 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2023-03-30T16:01:13.437Z,1680192073.437 [controlThread ThreadHandler](INFO): Thread cancelled.
2023-03-30T16:01:13.437Z,1680192073.437 [controlThread](INFO): Join timeout helper Thread ID is 6935
2023-03-30T16:01:13.698Z,1680192073.698 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2023-03-30T16:01:13.699Z,1680192073.699 [controlThread](DEBUG): Uninitializing ControlThread
2023-03-30T16:01:13.699Z,1680192073.699 [AHRS_M2](INFO): Powering down
2023-03-30T16:01:13.771Z,1680192073.771 [MultiRay](INFO): Powering down.
2023-03-30T16:01:13.772Z,1680192073.772 [NAL9602](INFO): Powering down
2023-03-30T16:01:13.774Z,1680192073.774 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2023-03-30T16:01:13.775Z,1680192073.775 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2023-03-30T16:01:13.776Z,1680192073.776 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2023-03-30T16:01:13.776Z,1680192073.776 [MissionManager](INFO): Uninitializing Mission Default
2023-03-30T16:01:13.776Z,1680192073.776 [Default] Stopped
2023-03-30T16:01:13.776Z,1680192073.776 [Default](DEBUG): Aggregate::uninitialize Default
2023-03-30T16:01:13.776Z,1680192073.776 [Default:B.GoToSurface] Stopped
2023-03-30T16:01:13.776Z,1680192073.776 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2023-03-30T16:01:13.776Z,1680192073.776 [Default:CheckIn] Stopped
2023-03-30T16:01:13.777Z,1680192073.777 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2023-03-30T16:01:13.777Z,1680192073.777 [Default:CheckIn:C.Wait] Stopped
2023-03-30T16:01:13.777Z,1680192073.777 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2023-03-30T16:01:13.779Z,1680192073.779 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2023-03-30T16:01:13.780Z,1680192073.780 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2023-03-30T16:01:13.780Z,1680192073.780 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2023-03-30T16:01:13.780Z,1680192073.780 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2023-03-30T16:01:13.781Z,1680192073.781 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2023-03-30T16:01:13.781Z,1680192073.781 [BuoyancyServo](INFO): Powering down
2023-03-30T16:01:13.795Z,1680192073.795 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2023-03-30T16:01:13.795Z,1680192073.795 [ElevatorServo](INFO): Powering down
2023-03-30T16:01:13.796Z,1680192073.796 [MassServo](DEBUG): Uninitialize Mass Servo.
2023-03-30T16:01:13.796Z,1680192073.796 [MassServo](INFO): Powering down
2023-03-30T16:01:13.796Z,1680192073.796 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2023-03-30T16:01:13.797Z,1680192073.797 [RudderServo](INFO): Powering down
2023-03-30T16:01:13.797Z,1680192073.797 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2023-03-30T16:01:13.797Z,1680192073.797 [ThrusterHE](INFO): Powering down
2023-03-30T16:01:13.798Z,1680192073.798 [SBIT](DEBUG): Uninitialize SBIT Component.
2023-03-30T16:01:13.799Z,1680192073.799 [IBIT](DEBUG): Uninitialize IBIT Component.
2023-03-30T16:01:13.799Z,1680192073.799 [CBIT](DEBUG): Uninitialize CBIT Component.
2023-03-30T16:01:13.799Z,1680192073.799 [CBIT](DEBUG): Powering off loads.
2023-03-30T16:01:13.810Z,1680192073.810 [CBIT](DEBUG): Disabling WDT.
2023-03-30T16:01:13.822Z,1680192073.822 [CBIT](DEBUG): Opening all GF detection circuits.
2023-03-30T16:01:13.823Z,1680192073.823 [controlThread ThreadHandler](INFO): Thread cancelled.
2023-03-30T16:01:13.873Z,1680192073.873 [DAT ThreadHandler](INFO): Thread cancelled.
2023-03-30T16:01:13.879Z,1680192073.879 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2023-03-30T16:01:13.880Z,1680192073.880 [Onboard ThreadHandler](INFO): Thread cancelled.
2023-03-30T16:01:13.887Z,1680192073.887 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2023-03-30T16:01:13.931Z,1680192073.931 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2023-03-30T16:01:13.968Z,1680192073.968 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2023-03-30T16:01:13.973Z,1680192073.973 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2023-03-30T16:01:14.005Z,1680192074.005 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2023-03-30T16:01:14.064Z,1680192074.064 [logger ThreadHandler](INFO): Thread cancelled.