2024-05-10T19:20:59.717Z,1715368859.717 [Supervisor](DEBUG): Initializing supervisor.
2024-05-10T19:20:59.728Z,1715368859.728 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2024-05-10T19:20:59.729Z,1715368859.729 [SyncHandler](INFO): Protected caller Thread ID is 833
2024-05-10T19:20:59.729Z,1715368859.729 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2024-05-10T19:20:59.740Z,1715368859.740 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2024-05-10T19:20:59.740Z,1715368859.740 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 834
2024-05-10T19:20:59.744Z,1715368859.744 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2024-05-10T19:20:59.774Z,1715368859.774 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2024-05-10T19:20:59.780Z,1715368859.780 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2024-05-10T19:20:59.780Z,1715368859.780 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 835
2024-05-10T19:20:59.796Z,1715368859.796 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2024-05-10T19:20:59.808Z,1715368859.808 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2024-05-10T19:20:59.808Z,1715368859.808 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 836
2024-05-10T19:20:59.810Z,1715368859.810 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2024-05-10T19:20:59.820Z,1715368859.820 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2024-05-10T19:20:59.820Z,1715368859.820 [logger ThreadHandler](INFO): Protected caller Thread ID is 837
2024-05-10T19:20:59.824Z,1715368859.824 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2024-05-10T19:20:59.824Z,1715368859.824 [Supervisor](INFO): Looking for Config files in directory: Config/
2024-05-10T19:20:59.840Z,1715368859.840 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2024-05-10T19:21:00.044Z,1715368860.044 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2024-05-10T19:21:00.046Z,1715368860.046 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2024-05-10T19:21:00.528Z,1715368860.528 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2024-05-10T19:21:00.530Z,1715368860.530 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2024-05-10T19:21:01.093Z,1715368861.093 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2024-05-10T19:21:01.094Z,1715368861.094 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2024-05-10T19:21:01.306Z,1715368861.306 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2024-05-10T19:21:01.308Z,1715368861.308 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2024-05-10T19:21:02.910Z,1715368862.910 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2024-05-10T19:21:02.912Z,1715368862.912 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2024-05-10T19:21:03.451Z,1715368863.451 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2024-05-10T19:21:03.453Z,1715368863.453 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2024-05-10T19:21:04.026Z,1715368864.026 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2024-05-10T19:21:04.027Z,1715368864.027 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2024-05-10T19:21:04.472Z,1715368864.472 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2024-05-10T19:21:04.473Z,1715368864.473 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2024-05-10T19:21:04.841Z,1715368864.841 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2024-05-10T19:21:04.842Z,1715368864.842 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2024-05-10T19:21:05.245Z,1715368865.245 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2024-05-10T19:21:05.246Z,1715368865.246 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2024-05-10T19:21:05.491Z,1715368865.491 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2024-05-10T19:21:05.492Z,1715368865.492 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2024-05-10T19:21:05.648Z,1715368865.648 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2024-05-10T19:21:05.649Z,1715368865.649 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2024-05-10T19:21:05.742Z,1715368865.742 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2024-05-10T19:21:05.833Z,1715368865.833 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2024-05-10T19:21:06.036Z,1715368866.036 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2024-05-10T19:21:06.037Z,1715368866.037 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2024-05-10T19:21:06.288Z,1715368866.288 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2024-05-10T19:21:06.290Z,1715368866.290 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/
2024-05-10T19:21:06.294Z,1715368866.294 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/secure.cfg
2024-05-10T19:21:06.389Z,1715368866.389 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Battery.cfg
2024-05-10T19:21:06.667Z,1715368866.667 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2024-05-10T19:21:06.668Z,1715368866.668 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Navigation.cfg
2024-05-10T19:21:06.777Z,1715368866.777 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Sensor.cfg
2024-05-10T19:21:06.957Z,1715368866.957 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/vehicle.cfg
2024-05-10T19:21:07.071Z,1715368867.071 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Simulator.cfg
2024-05-10T19:21:07.194Z,1715368867.194 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Servo.cfg
2024-05-10T19:21:07.357Z,1715368867.357 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Control.cfg
2024-05-10T19:21:07.915Z,1715368867.915 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Science.cfg
2024-05-10T19:21:08.557Z,1715368868.557 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Derivation.cfg
2024-05-10T19:21:08.666Z,1715368868.666 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/logger.cfg
2024-05-10T19:21:08.776Z,1715368868.776 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/BIT.cfg
2024-05-10T19:21:08.877Z,1715368868.877 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg
2024-05-10T19:21:08.894Z,1715368868.894 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2024-05-10T19:21:09.142Z,1715368869.142 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2024-05-10T19:21:09.143Z,1715368869.143 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2024-05-10T19:21:09.333Z,1715368869.333 [BuoyancyServo] Loaded
2024-05-10T19:21:09.333Z,1715368869.333 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2024-05-10T19:21:09.354Z,1715368869.354 [ElevatorServo] Loaded
2024-05-10T19:21:09.355Z,1715368869.355 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2024-05-10T19:21:09.375Z,1715368869.375 [MassServo] Loaded
2024-05-10T19:21:09.375Z,1715368869.375 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2024-05-10T19:21:09.396Z,1715368869.396 [RudderServo] Loaded
2024-05-10T19:21:09.396Z,1715368869.396 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2024-05-10T19:21:09.411Z,1715368869.411 [ThrusterHE] Loaded
2024-05-10T19:21:09.412Z,1715368869.412 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread.
2024-05-10T19:21:09.412Z,1715368869.412 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2024-05-10T19:21:09.414Z,1715368869.414 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2024-05-10T19:21:09.585Z,1715368869.585 [SBIT](DEBUG): Construct Startup Built In Test.
2024-05-10T19:21:09.600Z,1715368869.600 [SBIT] Loaded
2024-05-10T19:21:09.600Z,1715368869.600 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2024-05-10T19:21:09.603Z,1715368869.603 [IBIT](DEBUG): Construct Initiated Built In Test.
2024-05-10T19:21:09.624Z,1715368869.624 [IBIT] Loaded
2024-05-10T19:21:09.624Z,1715368869.624 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2024-05-10T19:21:09.629Z,1715368869.629 [CBIT](DEBUG): Construct Continuous Built In Test.
2024-05-10T19:21:09.849Z,1715368869.849 [CBIT] Loaded
2024-05-10T19:21:09.850Z,1715368869.850 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2024-05-10T19:21:09.850Z,1715368869.850 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2024-05-10T19:21:09.851Z,1715368869.851 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2024-05-10T19:21:10.074Z,1715368870.074 [CTD_Seabird] Loaded
2024-05-10T19:21:10.074Z,1715368870.074 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2024-05-10T19:21:10.075Z,1715368870.075 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 406784E0
2024-05-10T19:21:10.076Z,1715368870.076 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 922
2024-05-10T19:21:10.108Z,1715368870.108 [ESPComponent] Loaded
2024-05-10T19:21:10.108Z,1715368870.108 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread.
2024-05-10T19:21:10.128Z,1715368870.128 [PAR_Licor] Loaded
2024-05-10T19:21:10.128Z,1715368870.128 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2024-05-10T19:21:10.171Z,1715368870.171 [WetLabsBB2FL] Loaded
2024-05-10T19:21:10.171Z,1715368870.171 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2024-05-10T19:21:10.172Z,1715368870.172 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 406A84E0
2024-05-10T19:21:10.172Z,1715368870.172 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 923
2024-05-10T19:21:10.173Z,1715368870.173 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2024-05-10T19:21:10.175Z,1715368870.175 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2024-05-10T19:21:10.245Z,1715368870.245 [DepthRateCalculator] Loaded
2024-05-10T19:21:10.245Z,1715368870.245 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2024-05-10T19:21:10.251Z,1715368870.251 [PitchRateCalculator] Loaded
2024-05-10T19:21:10.251Z,1715368870.251 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2024-05-10T19:21:10.261Z,1715368870.261 [SpeedCalculator] Loaded
2024-05-10T19:21:10.261Z,1715368870.261 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2024-05-10T19:21:10.266Z,1715368870.266 [YawRateCalculator] Loaded
2024-05-10T19:21:10.266Z,1715368870.266 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2024-05-10T19:21:10.286Z,1715368870.286 [ElevatorOffsetCalculator] Loaded
2024-05-10T19:21:10.286Z,1715368870.286 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2024-05-10T19:21:10.287Z,1715368870.287 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2024-05-10T19:21:10.287Z,1715368870.287 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2024-05-10T19:21:10.430Z,1715368870.430 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2024-05-10T19:21:10.431Z,1715368870.431 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2024-05-10T19:21:10.474Z,1715368870.474 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2024-05-10T19:21:10.475Z,1715368870.475 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2024-05-10T19:21:10.612Z,1715368870.612 [DeadReckonUsingMultipleVelocitySources] Loaded
2024-05-10T19:21:10.612Z,1715368870.612 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2024-05-10T19:21:10.626Z,1715368870.626 [NavChart] Loaded
2024-05-10T19:21:10.627Z,1715368870.627 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2024-05-10T19:21:10.632Z,1715368870.632 [UniversalFixResidualReporter] Loaded
2024-05-10T19:21:10.632Z,1715368870.632 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2024-05-10T19:21:10.633Z,1715368870.633 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2024-05-10T19:21:10.634Z,1715368870.634 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2024-05-10T19:21:11.467Z,1715368871.467 [AHRS_M2] Loaded
2024-05-10T19:21:11.467Z,1715368871.467 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2024-05-10T19:21:11.717Z,1715368871.717 [BackseatComponent] Loaded
2024-05-10T19:21:11.717Z,1715368871.717 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread.
2024-05-10T19:21:11.718Z,1715368871.718 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 40A534E0
2024-05-10T19:21:11.718Z,1715368871.718 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 924
2024-05-10T19:21:11.721Z,1715368871.721 [LcmUniversalReporter] Loaded
2024-05-10T19:21:11.722Z,1715368871.722 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread.
2024-05-10T19:21:12.466Z,1715368872.466 [BPC1] Loaded
2024-05-10T19:21:12.466Z,1715368872.466 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2024-05-10T19:21:12.609Z,1715368872.609 [DataOverHttps] Loaded
2024-05-10T19:21:12.609Z,1715368872.609 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2024-05-10T19:21:12.610Z,1715368872.610 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 40A834E0
2024-05-10T19:21:12.610Z,1715368872.610 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 925
2024-05-10T19:21:12.631Z,1715368872.631 [Depth_Keller] Loaded
2024-05-10T19:21:12.631Z,1715368872.631 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2024-05-10T19:21:12.636Z,1715368872.636 [DropWeight] Loaded
2024-05-10T19:21:12.637Z,1715368872.637 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2024-05-10T19:21:12.676Z,1715368872.676 [DVL_micro] Loaded
2024-05-10T19:21:12.677Z,1715368872.677 [ComponentRegistry](DEBUG): SyncComponent "DVL_micro" handled in the control thread.
2024-05-10T19:21:12.737Z,1715368872.737 [NAL9602] Loaded
2024-05-10T19:21:12.737Z,1715368872.737 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2024-05-10T19:21:12.763Z,1715368872.763 [Onboard] Loaded
2024-05-10T19:21:12.764Z,1715368872.764 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2024-05-10T19:21:12.765Z,1715368872.765 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 40AB34E0
2024-05-10T19:21:12.765Z,1715368872.765 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 926
2024-05-10T19:21:12.777Z,1715368872.777 [Power24vConverter] Loaded
2024-05-10T19:21:12.778Z,1715368872.778 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2024-05-10T19:21:12.791Z,1715368872.791 [Radio_Surface] Loaded
2024-05-10T19:21:12.791Z,1715368872.791 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2024-05-10T19:21:12.792Z,1715368872.792 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 40AE34E0
2024-05-10T19:21:12.793Z,1715368872.793 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 927
2024-05-10T19:21:12.806Z,1715368872.806 [Sonardyne_Nano] Loaded
2024-05-10T19:21:12.807Z,1715368872.807 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread.
2024-05-10T19:21:12.902Z,1715368872.902 [DAT] Loaded
2024-05-10T19:21:12.902Z,1715368872.902 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread.
2024-05-10T19:21:12.903Z,1715368872.903 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 40B134E0
2024-05-10T19:21:12.903Z,1715368872.903 [DAT ThreadHandler](INFO): Protected caller Thread ID is 928
2024-05-10T19:21:12.904Z,1715368872.904 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2024-05-10T19:21:12.905Z,1715368872.905 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2024-05-10T19:21:13.264Z,1715368873.264 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2024-05-10T19:21:13.266Z,1715368873.266 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2024-05-10T19:21:13.339Z,1715368873.339 [VerticalControl](DEBUG): Construct VerticalControl.
2024-05-10T19:21:13.390Z,1715368873.390 [VerticalControl] Loaded
2024-05-10T19:21:13.390Z,1715368873.390 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2024-05-10T19:21:13.393Z,1715368873.393 [HorizontalControl](DEBUG): Construct HorizontalControl.
2024-05-10T19:21:13.437Z,1715368873.437 [HorizontalControl] Loaded
2024-05-10T19:21:13.438Z,1715368873.438 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2024-05-10T19:21:13.440Z,1715368873.440 [SpeedControl](DEBUG): Construct SpeedControl.
2024-05-10T19:21:13.442Z,1715368873.442 [SpeedControl] Loaded
2024-05-10T19:21:13.442Z,1715368873.442 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2024-05-10T19:21:13.445Z,1715368873.445 [LoopControl](DEBUG): Construct LoopControl.
2024-05-10T19:21:13.445Z,1715368873.445 [LoopControl] Loaded
2024-05-10T19:21:13.446Z,1715368873.446 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2024-05-10T19:21:13.446Z,1715368873.446 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2024-05-10T19:21:13.447Z,1715368873.447 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2024-05-10T19:21:13.462Z,1715368873.462 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2024-05-10T19:21:13.463Z,1715368873.463 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2024-05-10T19:21:13.868Z,1715368873.868 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2024-05-10T19:21:13.874Z,1715368873.874 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2024-05-10T19:21:13.877Z,1715368873.877 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2024-05-10T19:21:13.888Z,1715368873.888 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2024-05-10T19:21:13.889Z,1715368873.889 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C374E0
2024-05-10T19:21:13.890Z,1715368873.890 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 929
2024-05-10T19:21:13.894Z,1715368873.894 [Supervisor](INFO): Main Thread ID is 826
2024-05-10T19:21:13.894Z,1715368873.894 [Supervisor](DEBUG): Running supervisor.
2024-05-10T19:21:13.895Z,1715368873.895 [CommandExec ThreadHandler](INFO): Handler Thread ID is 930
2024-05-10T19:21:13.895Z,1715368873.895 [CommandExec](INFO): Initializing the command executive.
2024-05-10T19:21:13.897Z,1715368873.897 [CommandLine ThreadHandler](INFO): Handler Thread ID is 931
2024-05-10T19:21:13.899Z,1715368873.899 [controlThread ThreadHandler](INFO): Handler Thread ID is 932
2024-05-10T19:21:13.900Z,1715368873.900 [controlThread](DEBUG): Initializing ControlThread
2024-05-10T19:21:13.901Z,1715368873.901 [SBIT](INFO): Initialize SBIT Component.
2024-05-10T19:21:13.902Z,1715368873.902 [SBIT](IMPORTANT): git: 2024-05-10
2024-05-10T19:21:13.902Z,1715368873.902 [SBIT](INFO): git hash: a134c88d686ec779525c21b16fbeda2a3b596732
2024-05-10T19:21:13.902Z,1715368873.902 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2024-05-10T19:21:13.904Z,1715368873.904 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018
Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021
2024-05-10T19:21:13.905Z,1715368873.905 [SBIT](INFO): Beginning SBIT in 39.000000 seconds.
2024-05-10T19:21:13.905Z,1715368873.905 [IBIT](INFO): Initialize IBIT Component.
2024-05-10T19:21:13.906Z,1715368873.906 [CBIT](DEBUG): Initialize CBIT Component.
2024-05-10T19:21:13.907Z,1715368873.907 [logger ThreadHandler](INFO): Handler Thread ID is 933
2024-05-10T19:21:13.920Z,1715368873.920 [CBIT](DEBUG): Initialized mux pins.
2024-05-10T19:21:13.920Z,1715368873.920 [CBIT](DEBUG): Initializing the watchdog timer.
2024-05-10T19:21:13.928Z,1715368873.928 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 934
2024-05-10T19:21:13.929Z,1715368873.929 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2024-05-10T19:21:13.934Z,1715368873.934 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 936
2024-05-10T19:21:13.936Z,1715368873.936 [WetLabsBB2FL](INFO): Powering up
2024-05-10T19:21:13.938Z,1715368873.938 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 938
2024-05-10T19:21:13.944Z,1715368873.944 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2024-05-10T19:21:13.944Z,1715368873.944 [CBIT](DEBUG): Initializing heartbeat.
2024-05-10T19:21:13.945Z,1715368873.945 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 939
2024-05-10T19:21:13.947Z,1715368873.947 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2024-05-10T19:21:13.968Z,1715368873.968 [Onboard ThreadHandler](INFO): Handler Thread ID is 940
2024-05-10T19:21:13.985Z,1715368873.985 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 941
2024-05-10T19:21:14.010Z,1715368874.010 [DAT ThreadHandler](INFO): Handler Thread ID is 942
2024-05-10T19:21:14.010Z,1715368874.010 [DAT](INFO): Powering up
2024-05-10T19:21:14.011Z,1715368874.011 [DAT](DEBUG): Initializing DAT.
2024-05-10T19:21:14.013Z,1715368874.013 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 944
2024-05-10T19:21:14.016Z,1715368874.016 [CBIT](DEBUG): Deactivating GF circuits.
2024-05-10T19:21:14.016Z,1715368874.016 [CBIT](DEBUG): Deactivating emergency mode.
2024-05-10T19:21:14.022Z,1715368874.022 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/DK1NORSO.000
2024-05-10T19:21:14.022Z,1715368874.022 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from DK1NORSO.000
2024-05-10T19:21:14.022Z,1715368874.022 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/DK2NORS.000
2024-05-10T19:21:14.022Z,1715368874.022 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from DK2NORS.000
2024-05-10T19:21:14.023Z,1715368874.023 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/DK3HORRO.000
2024-05-10T19:21:14.023Z,1715368874.023 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from DK3HORRO.000
2024-05-10T19:21:14.056Z,1715368874.056 [CBIT](DEBUG): Backplane powered.
2024-05-10T19:21:14.060Z,1715368874.060 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2024-05-10T19:21:14.061Z,1715368874.061 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2024-05-10T19:21:14.061Z,1715368874.061 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2024-05-10T19:21:14.061Z,1715368874.061 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2024-05-10T19:21:14.062Z,1715368874.062 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2024-05-10T19:21:14.063Z,1715368874.063 [NavChart](DEBUG): Initialize NavChart Navigation.
2024-05-10T19:21:14.063Z,1715368874.063 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2024-05-10T19:21:14.073Z,1715368874.073 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2024-05-10T19:21:14.075Z,1715368874.075 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2024-05-10T19:21:14.076Z,1715368874.076 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2024-05-10T19:21:14.076Z,1715368874.076 [LoopControl](DEBUG): Initialize LoopControlComponent.
2024-05-10T19:21:14.077Z,1715368874.077 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser
2024-05-10T19:21:14.078Z,1715368874.078 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl
2024-05-10T19:21:14.078Z,1715368874.078 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl
2024-05-10T19:21:14.084Z,1715368874.084 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl
2024-05-10T19:21:14.157Z,1715368874.157 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into:
2024-05-10T19:21:14.161Z,1715368874.161 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2024-05-10T19:21:14.210Z,1715368874.210 [MissionManager](DEBUG):
# Copyright (c) 2024 MBARI
# MBARI Proprietary Information. Confidential. All Rights Reserved
# Unauthorized copying or distribution of this file via any medium is strictly
# prohibited.
#
# WARNING - This file contains information whose export is restricted by the
# Export Administration Act of 1979 (Title 50, U.S.C., App. 2401 et seq.), as
# amended. Violations of these export laws are subject to severe civil and/or
# criminal penalties.
mission Startup {
behavior Guidance:GoToSurface {
run in progression
}
aggregate StartupSatComms {
run in sequence
readDatum {
timeout duration=P1M
Universal:latitude_fix
}
readDatum {
timeout duration=P1M
Universal:platform_communications
}
}
}
2024-05-10T19:21:14.211Z,1715368874.211 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl
2024-05-10T19:21:14.211Z,1715368874.211 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl
2024-05-10T19:21:14.215Z,1715368874.215 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl
2024-05-10T19:21:14.392Z,1715368874.392 [Radio_Surface](INFO): Powering up
2024-05-10T19:21:14.548Z,1715368874.548 [MissionManager](DEBUG): TethyslAPI: Missions/Default.tl translated into:
0
13
Burn on
Dropped weight due to communications timeout.
5
Default mission has been running for
Restarting logs and Default mission.
restart logs
2024-05-10T19:21:14.554Z,1715368874.554 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2024-05-10T19:21:14.555Z,1715368874.555 [Default:A.Wait](DEBUG): Construct Wait.
2024-05-10T19:21:14.570Z,1715368874.570 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2024-05-10T19:21:14.615Z,1715368874.615 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2024-05-10T19:21:14.617Z,1715368874.617 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2024-05-10T19:21:14.647Z,1715368874.647 [Default:E.Execute](DEBUG): Construct Execute.
2024-05-10T19:21:14.650Z,1715368874.650 [MissionManager](DEBUG):
# Copyright (c) 2024 MBARI
# MBARI Proprietary Information. Confidential. All Rights Reserved
# Unauthorized copying or distribution of this file via any medium is strictly
# prohibited.
#
# WARNING - This file contains information whose export is restricted by the
# Export Administration Act of 1979 (Title 50, U.S.C., App. 2401 et seq.), as
# amended. Violations of these export laws are subject to severe civil and/or
# criminal penalties.
mission Default {
arguments {
ElapsedSinceDefaultStarted = 0 minute
}
behavior Guidance:Wait {
"""
Wait a moment to see if the scheduler starts a new mission before
starting to actually run Default.
"""
run in sequence
set duration = 13 second
}
behavior Guidance:GoToSurface {
run in progression
}
aggregate CheckIn {
run in sequence repeat=288
readDatum id="Read_GPS" {
timeout duration=P5M
Universal:time_fix
}
readDatum id="Read_Iridium" {
timeout duration=P4H {
behavior Guidance:Execute {
run in sequence
set command = "Burn on"
}
syslog critical "Dropped weight due to communications timeout."
}
Universal:platform_communications
}
behavior Guidance:Wait {
run in sequence
set duration = 5 minute
}
assign in sequence ElapsedSinceDefaultStarted = elapsed ( Universal:mission_started )
syslog important "Default mission has been running for " + ElapsedSinceDefaultStarted~minute
}
syslog important "Restarting logs and Default mission."
behavior Guidance:Execute {
run in sequence
set command = "restart logs"
}
}
2024-05-10T19:21:14.655Z,1715368874.655 [controlThread](DEBUG): Component order: CycleStarter,ESPComponent,PAR_Licor,AHRS_M2,BPC1,Depth_Keller,DropWeight,DVL_micro,NAL9602,Power24vConverter,Sonardyne_Nano,PAR_Licor,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter,
2024-05-10T19:21:14.696Z,1715368874.696 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2024-05-10T19:21:14.813Z,1715368874.813 [Depth_Keller](ERROR): Pressure or depth reading out of range: 1895.444336 decibar, 0.000000 m
2024-05-10T19:21:14.821Z,1715368874.821 [Power24vConverter](INFO): Powering up.
2024-05-10T19:21:14.822Z,1715368874.822 [Sonardyne_Nano](INFO): Initializing.
2024-05-10T19:21:14.848Z,1715368874.848 [DepthRateCalculator](ERROR): Depth measurement is not active
2024-05-10T19:21:14.886Z,1715368874.886 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2024-05-10T19:21:14.892Z,1715368874.892 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2024-05-10T19:21:14.893Z,1715368874.893 [ElevatorServo](DEBUG): Initializing EZServoServo.
2024-05-10T19:21:14.904Z,1715368874.904 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2024-05-10T19:21:14.905Z,1715368874.905 [MassServo](DEBUG): Initializing EZServoServo.
2024-05-10T19:21:14.912Z,1715368874.912 [MassServo](DEBUG): Initializing MassServo.
2024-05-10T19:21:14.913Z,1715368874.913 [RudderServo](DEBUG): Initializing EZServoServo.
2024-05-10T19:21:14.920Z,1715368874.920 [RudderServo](DEBUG): Initializing RudderServo.
2024-05-10T19:21:14.921Z,1715368874.921 [ThrusterHE](DEBUG): Initializing EZServoServo.
2024-05-10T19:21:14.928Z,1715368874.928 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2024-05-10T19:21:16.045Z,1715368876.045 [WetLabsBB2FL](INFO): Powering down
2024-05-10T19:21:17.090Z,1715368877.090 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART
2024-05-10T19:21:18.329Z,1715368878.329 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2407
2024-05-10T19:21:20.684Z,1715368880.684 [ThrusterHE](ERROR): Zero Speed Commanded.
2024-05-10T19:21:26.108Z,1715368886.108 [DAT](INFO): DAT read:
2024-05-10T19:21:26.110Z,1715368886.110 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series
2024-05-10T19:21:27.625Z,1715368887.625 [DAT](INFO): DAT read: MF Frequency Band
2024-05-10T19:21:27.626Z,1715368887.626 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.15.0
2024-05-10T19:21:27.627Z,1715368887.627 [DAT](INFO): DAT read: May 10 2024 19:21:23
2024-05-10T19:21:28.885Z,1715368888.885 [DAT](INFO): DAT read: Features enabled [Bearing]
2024-05-10T19:21:28.886Z,1715368888.886 [DAT](INFO): DAT read: CONNECT 01200 bits/sec 1 of 4, Rate 1/2 CC
2024-05-10T19:21:28.886Z,1715368888.886 [DAT](INFO): commRate: 1200
2024-05-10T19:21:30.952Z,1715368890.952 [DAT](INFO): entering command mode
2024-05-10T19:21:31.152Z,1715368891.152 [DAT](INFO): DAT read:
2024-05-10T19:21:31.153Z,1715368891.153 [DAT](INFO): DAT read: user:1>
2024-05-10T19:21:31.153Z,1715368891.153 [DAT](INFO): setting verbose to 3
2024-05-10T19:21:31.405Z,1715368891.405 [DAT](INFO): DAT read: user:1>
2024-05-10T19:21:31.406Z,1715368891.406 [DAT](INFO): DAT read: Verbose | 3
2024-05-10T19:21:31.406Z,1715368891.406 [DAT](INFO): set verbose to 3
2024-05-10T19:21:31.406Z,1715368891.406 [DAT](INFO): setting DatVerbose to 27440
2024-05-10T19:21:31.662Z,1715368891.662 [DAT](INFO): DAT read: user:2>
2024-05-10T19:21:31.663Z,1715368891.663 [DAT](INFO): DAT read: DatVerbose | 27440
2024-05-10T19:21:31.663Z,1715368891.663 [DAT](INFO): set DatVerbose to 27440
2024-05-10T19:21:31.664Z,1715368891.664 [DAT](INFO): setting transmit power to 8
2024-05-10T19:21:31.912Z,1715368891.912 [DAT](INFO): DAT read: user:3>
2024-05-10T19:21:31.913Z,1715368891.913 [DAT](INFO): DAT read: TxPower | 8 (Max)
2024-05-10T19:21:31.914Z,1715368891.914 [DAT](INFO): set transmit power to 8
2024-05-10T19:21:31.914Z,1715368891.914 [DAT](INFO): setting local address to 5
2024-05-10T19:21:32.164Z,1715368892.164 [DAT](INFO): DAT read: user:4>
2024-05-10T19:21:32.165Z,1715368892.165 [DAT](INFO): DAT read: LocalAddr | 5
2024-05-10T19:21:32.166Z,1715368892.166 [DAT](INFO): set local address to 5
2024-05-10T19:21:32.167Z,1715368892.167 [DAT](INFO): Setting time to: 19:21:32 And date to:5/10/2024
2024-05-10T19:21:32.416Z,1715368892.416 [DAT](INFO): DAT read: user:5>
2024-05-10T19:21:32.417Z,1715368892.417 [DAT](INFO): DAT read: Fri May 10, 2024 19:21:32
2024-05-10T19:21:32.418Z,1715368892.418 [DAT](INFO): Local DAT time set to Fri May 10, 2024 19:21:32
2024-05-10T19:21:42.990Z,1715368902.990 [NAL9602](INFO): Powering up NAL9602
2024-05-10T19:21:53.531Z,1715368913.531 [SBIT](IMPORTANT): Beginning Startup BIT
2024-05-10T19:21:53.561Z,1715368913.561 [CBIT](IMPORTANT): Beginning ground fault scan
2024-05-10T19:21:53.913Z,1715368913.913 [NAL9602](INFO): NAL9602 initialized
2024-05-10T19:22:04.460Z,1715368924.460 [CBIT](IMPORTANT): Ground fault detected
mA:
CHAN A0 (Batt): 0.035709
CHAN A1 (24V): 0.061621
CHAN A2 (12V): -0.016485
CHAN A3 (5V): -0.029175
CHAN B0 (3.3V): -0.017170
CHAN B1 (3.15aV): -0.010680
CHAN B2 (3.15bV): -0.006915
CHAN B3 (GND): -0.016638
OPEN: 0.007863
Full Scale: +/- 1 mA
2024-05-10T19:22:47.669Z,1715368967.669 [SBIT](IMPORTANT): SBIT PASSED
2024-05-10T19:22:47.669Z,1715368967.669 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2024-05-10T19:22:47.670Z,1715368967.670 [SBIT](IMPORTANT): DropWeight.loadAtStartup=1 bool;
2024-05-10T19:22:47.670Z,1715368967.670 [SBIT](IMPORTANT): ESPComponent.sampleTimeout=3 minute;
2024-05-10T19:22:47.671Z,1715368967.671 [SBIT](IMPORTANT): ElevatorServo.offsetAngle=0.7 degree;
2024-05-10T19:22:47.671Z,1715368967.671 [SBIT](IMPORTANT): Express linearApproximation CTD_Seabird.bin_mean_sea_water_temperature 5.000000 celsius;
2024-05-10T19:22:47.671Z,1715368967.671 [SBIT](IMPORTANT): Express none CTD_Seabird.bin_median_sea_water_salinity;
2024-05-10T19:22:47.671Z,1715368967.671 [SBIT](IMPORTANT): Express none WetLabsBB2FL.bin_mean_mass_concentration_of_chlorophyll_in_sea_water;
2024-05-10T19:22:47.671Z,1715368967.671 [SBIT](IMPORTANT): Express none WetLabsBB2FL.bin_median_mass_concentration_of_chlorophyll_in_sea_water;
2024-05-10T19:22:47.671Z,1715368967.671 [SBIT](IMPORTANT): Express linearApproximation WetLabsSeaOWL_UV_A.mass_concentration_of_petroleum_hydrocarbons_in_sea_water 1.000000 kilogram_per_cubic_meter;
2024-05-10T19:22:47.671Z,1715368967.671 [SBIT](IMPORTANT): Express linearApproximation height_above_sea_floor 0.500000 meter;
2024-05-10T19:22:47.671Z,1715368967.671 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=150 cubic_centimeter;
2024-05-10T19:22:47.671Z,1715368967.671 [SBIT](IMPORTANT): VerticalControl.massDefault=0.5 centimeter;
2024-05-10T19:22:48.102Z,1715368968.102 [MissionManager](IMPORTANT): Started mission Startup
2024-05-10T19:22:48.102Z,1715368968.102 [Startup] Running Loop=1
2024-05-10T19:22:48.102Z,1715368968.102 [Startup](DEBUG): Aggregate::initialize Startup
2024-05-10T19:22:48.103Z,1715368968.103 [Startup:A.GoToSurface] Running Loop=1
2024-05-10T19:22:48.103Z,1715368968.103 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2024-05-10T19:22:48.103Z,1715368968.103 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2024-05-10T19:22:48.104Z,1715368968.104 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2024-05-10T19:22:48.104Z,1715368968.104 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2024-05-10T19:22:48.105Z,1715368968.105 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2024-05-10T19:22:48.105Z,1715368968.105 [Startup:A.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2024-05-10T19:22:48.105Z,1715368968.105 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2024-05-10T19:22:48.107Z,1715368968.107 [Startup:StartupSatComms] Running Loop=1
2024-05-10T19:22:48.107Z,1715368968.107 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2024-05-10T19:22:48.107Z,1715368968.107 [Startup:StartupSatComms:A] Running Loop=1
2024-05-10T19:22:48.531Z,1715368968.531 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2024-05-10T19:23:02.215Z,1715368982.215 [NAL9602](INFO): SBD MO Status=0, MOMSN=11745, MT Status=0, MTMSN=0
2024-05-10T19:23:02.215Z,1715368982.215 [NAL9602](INFO): No messages in MT queue
2024-05-10T19:23:03.386Z,1715368983.386 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,192300.00,A,3648.17600,N,12147.27992,W,0.350,46.37,100524,,,A*48
2024-05-10T19:23:03.390Z,1715368983.390 [NAL9602](INFO): GPS fix at 20240510T192300: (36.802933, -121.787999)
2024-05-10T19:23:03.416Z,1715368983.416 [Startup:StartupSatComms:A] Stopped
2024-05-10T19:23:03.416Z,1715368983.416 [Startup:StartupSatComms:B] Running Loop=1
2024-05-10T19:23:03.832Z,1715368983.832 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2024-05-10T19:23:17.584Z,1715368997.584 [NAL9602](INFO): SBD MO Status=1, MOMSN=11746, MT Status=0, MTMSN=0
2024-05-10T19:23:17.640Z,1715368997.640 [NAL9602](INFO): Sent 40 bytes from file Logs/20240510T185202/Courier0016.lzma
2024-05-10T19:23:17.640Z,1715368997.640 [NAL9602](INFO): Packets left to send: 0
2024-05-10T19:23:30.154Z,1715369010.154 [NAL9602](INFO): SBD MO Status=1, MOMSN=11747, MT Status=0, MTMSN=0
2024-05-10T19:23:30.208Z,1715369010.208 [NAL9602](INFO): Sent 271 bytes from file Logs/20240510T192059/Courier0000.lzma
2024-05-10T19:23:30.208Z,1715369010.208 [NAL9602](INFO): Packets left to send: 0
2024-05-10T19:23:39.517Z,1715369019.517 [NAL9602](INFO): SBD MO Status=1, MOMSN=11748, MT Status=0, MTMSN=0
2024-05-10T19:23:39.572Z,1715369019.572 [NAL9602](INFO): Sent 227 bytes from file Logs/20240510T185202/Express0005.lzma
2024-05-10T19:23:39.572Z,1715369019.572 [NAL9602](INFO): Packets left to send: 0
2024-05-10T19:23:56.975Z,1715369036.975 [NAL9602](INFO): SBD MO Status=1, MOMSN=11749, MT Status=0, MTMSN=0
2024-05-10T19:23:57.024Z,1715369037.024 [NAL9602](INFO): Sent 213 bytes from file Logs/20240510T185202/Express0008.lzma
2024-05-10T19:23:57.024Z,1715369037.024 [NAL9602](INFO): Packets left to send: 0
2024-05-10T19:24:03.472Z,1715369043.472 [Startup:StartupSatComms:B](INFO): Timed out from 2024-05-10T19:23:03.4Z
2024-05-10T19:24:03.472Z,1715369043.472 [Startup:StartupSatComms:B] Stopped
2024-05-10T19:24:03.473Z,1715369043.473 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2024-05-10T19:24:03.473Z,1715369043.473 [Startup:StartupSatComms] Stopped
2024-05-10T19:24:03.473Z,1715369043.473 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2024-05-10T19:24:03.474Z,1715369043.474 [Startup](INFO): Completed Startup
2024-05-10T19:24:03.474Z,1715369043.474 [MissionManager](INFO): Startup is completed.
2024-05-10T19:24:03.474Z,1715369043.474 [MissionManager](INFO): Uninitializing Mission Startup
2024-05-10T19:24:03.474Z,1715369043.474 [Startup] Stopped
2024-05-10T19:24:03.474Z,1715369043.474 [Startup](DEBUG): Aggregate::uninitialize Startup
2024-05-10T19:24:03.474Z,1715369043.474 [Startup:A.GoToSurface] Stopped
2024-05-10T19:24:03.474Z,1715369043.474 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2024-05-10T19:24:03.869Z,1715369043.869 [MissionManager](IMPORTANT): Started mission Default
2024-05-10T19:24:03.869Z,1715369043.869 [Default] Running Loop=1
2024-05-10T19:24:03.869Z,1715369043.869 [Default](DEBUG): Aggregate::initialize Default
2024-05-10T19:24:03.869Z,1715369043.869 [Default:B.GoToSurface] Running Loop=1
2024-05-10T19:24:03.869Z,1715369043.869 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2024-05-10T19:24:03.870Z,1715369043.870 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2024-05-10T19:24:03.870Z,1715369043.870 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2024-05-10T19:24:03.870Z,1715369043.870 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2024-05-10T19:24:03.871Z,1715369043.871 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2024-05-10T19:24:03.871Z,1715369043.871 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds.
2024-05-10T19:24:03.871Z,1715369043.871 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2024-05-10T19:24:03.871Z,1715369043.871 [Default:A.Wait] Running Loop=1
2024-05-10T19:24:03.871Z,1715369043.871 [Default:A.Wait](DEBUG): Initialize Wait Component.
2024-05-10T19:24:13.959Z,1715369053.959 [NAL9602](INFO): SBD MO Status=2, MOMSN=11750, MT Status=2, MTMSN=0
2024-05-10T19:24:13.959Z,1715369053.959 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2024-05-10T19:24:17.199Z,1715369057.199 [Default:A.Wait](INFO): Done Waiting.
2024-05-10T19:24:17.199Z,1715369057.199 [Default:A.Wait] Stopped
2024-05-10T19:24:17.199Z,1715369057.199 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2024-05-10T19:24:17.602Z,1715369057.602 [Default:CheckIn] Running Loop=1
2024-05-10T19:24:17.602Z,1715369057.602 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-05-10T19:24:17.602Z,1715369057.602 [Default:CheckIn:Read_GPS] Running Loop=1
2024-05-10T19:24:18.015Z,1715369058.015 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2024-05-10T19:24:19.614Z,1715369059.614 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,192416.00,A,3648.17584,N,12147.28274,W,0.117,46.37,100524,,,D*4F
2024-05-10T19:24:19.627Z,1715369059.627 [NAL9602](INFO): GPS fix at 20240510T192416: (36.802931, -121.788046)
2024-05-10T19:24:19.636Z,1715369059.636 [Default:CheckIn:Read_GPS] Stopped
2024-05-10T19:24:19.637Z,1715369059.637 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-05-10T19:24:20.059Z,1715369060.059 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2024-05-10T19:24:46.342Z,1715369086.342 [NAL9602](INFO): SBD MO Status=1, MOMSN=11750, MT Status=0, MTMSN=0
2024-05-10T19:24:46.404Z,1715369086.404 [NAL9602](INFO): Sent 75 bytes from file Logs/20240510T192059/Courier0004.lzma
2024-05-10T19:24:46.404Z,1715369086.404 [NAL9602](INFO): Packets left to send: 0
2024-05-10T19:25:00.148Z,1715369100.148 [NAL9602](INFO): SBD MO Status=2, MOMSN=11751, MT Status=2, MTMSN=0
2024-05-10T19:25:00.148Z,1715369100.148 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2024-05-10T19:25:25.667Z,1715369125.667 [NAL9602](INFO): SBD MO Status=2, MOMSN=11751, MT Status=2, MTMSN=0
2024-05-10T19:25:25.667Z,1715369125.667 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2024-05-10T19:25:45.109Z,1715369145.109 [NAL9602](INFO): SBD MO Status=1, MOMSN=11751, MT Status=0, MTMSN=0
2024-05-10T19:25:45.160Z,1715369145.160 [NAL9602](INFO): Sent 208 bytes from file Logs/20240510T185202/Express0011.lzma
2024-05-10T19:25:45.161Z,1715369145.161 [NAL9602](INFO): Packets left to send: 0
2024-05-10T19:26:19.085Z,1715369179.085 [NAL9602](INFO): SBD MO Status=2, MOMSN=11752, MT Status=0, MTMSN=0
2024-05-10T19:26:19.085Z,1715369179.085 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2024-05-10T19:27:26.994Z,1715369246.994 [NAL9602](INFO): SBD MO Status=1, MOMSN=11752, MT Status=0, MTMSN=0
2024-05-10T19:27:27.044Z,1715369247.044 [NAL9602](INFO): Sent 256 bytes from file Logs/20240510T185202/Express0014.lzma
2024-05-10T19:27:27.044Z,1715369247.044 [NAL9602](INFO): Packets left to send: 0
2024-05-10T19:27:36.750Z,1715369256.750 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6.
2024-05-10T19:27:36.754Z,1715369256.754 [BPC1](INFO): Received data from all battery sticks.
2024-05-10T19:27:42.802Z,1715369262.802 [NAL9602](INFO): SBD MO Status=1, MOMSN=11753, MT Status=0, MTMSN=0
2024-05-10T19:27:42.860Z,1715369262.860 [NAL9602](INFO): Sent 181 bytes from file Logs/20240510T185202/Express0017.lzma
2024-05-10T19:27:42.860Z,1715369262.860 [NAL9602](INFO): Packets left to send: 0
2024-05-10T19:27:56.182Z,1715369276.182 [NAL9602](INFO): SBD MO Status=1, MOMSN=11754, MT Status=0, MTMSN=0
2024-05-10T19:27:56.233Z,1715369276.233 [NAL9602](INFO): Sent 332 bytes from file Logs/20240510T192059/Express0001.lzma
2024-05-10T19:27:56.233Z,1715369276.233 [NAL9602](INFO): Packets left to send: 3
2024-05-10T19:28:10.383Z,1715369290.383 [NAL9602](INFO): SBD MO Status=1, MOMSN=11755, MT Status=0, MTMSN=0
2024-05-10T19:28:10.432Z,1715369290.432 [NAL9602](INFO): Sent 332 bytes from file Logs/20240510T192059/Express0001.lzma
2024-05-10T19:28:10.432Z,1715369290.432 [NAL9602](INFO): Packets left to send: 2
2024-05-10T19:28:19.314Z,1715369299.314 [NAL9602](INFO): SBD MO Status=1, MOMSN=11756, MT Status=0, MTMSN=0
2024-05-10T19:28:19.366Z,1715369299.366 [NAL9602](INFO): Sent 332 bytes from file Logs/20240510T192059/Express0001.lzma
2024-05-10T19:28:19.366Z,1715369299.366 [NAL9602](INFO): Packets left to send: 1
2024-05-10T19:28:30.274Z,1715369310.274 [NAL9602](INFO): SBD MO Status=1, MOMSN=11757, MT Status=0, MTMSN=0
2024-05-10T19:28:30.332Z,1715369310.332 [NAL9602](INFO): Sent 29 bytes from file Logs/20240510T192059/Express0001.lzma
2024-05-10T19:28:30.332Z,1715369310.332 [NAL9602](INFO): Packets left to send: 0
2024-05-10T19:28:48.526Z,1715369328.526 [NAL9602](INFO): SBD MO Status=1, MOMSN=11758, MT Status=0, MTMSN=0
2024-05-10T19:28:48.577Z,1715369328.577 [NAL9602](INFO): Sent 226 bytes from file Logs/20240510T192059/Express0005.lzma
2024-05-10T19:28:48.578Z,1715369328.578 [NAL9602](INFO): Packets left to send: 0
2024-05-10T19:28:55.399Z,1715369335.399 [NAL9602](INFO): SBD MO Status=0, MOMSN=11759, MT Status=0, MTMSN=0
2024-05-10T19:28:55.477Z,1715369335.477 [Default:CheckIn:Read_Iridium] Stopped
2024-05-10T19:28:55.477Z,1715369335.477 [Default:CheckIn:C.Wait] Running Loop=1
2024-05-10T19:28:55.477Z,1715369335.477 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2024-05-10T19:29:26.087Z,1715369366.087 [NAL9602](INFO): Not Powering down - fast GPS
2024-05-10T19:33:55.976Z,1715369635.976 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2024-05-10T19:33:55.976Z,1715369635.976 [Default:CheckIn:C.Wait] Stopped
2024-05-10T19:33:55.976Z,1715369635.976 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2024-05-10T19:33:55.976Z,1715369635.976 [Default:CheckIn:D] Running Loop=1
2024-05-10T19:33:56.387Z,1715369636.387 [Default:CheckIn:D] Stopped
2024-05-10T19:33:56.387Z,1715369636.387 [Default:CheckIn:E] Running Loop=1
2024-05-10T19:33:56.781Z,1715369636.781 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 9.875301 min
2024-05-10T19:33:56.781Z,1715369636.781 [Default:CheckIn:E] Stopped
2024-05-10T19:33:56.781Z,1715369636.781 [Default:CheckIn](INFO): Completed Default:CheckIn
2024-05-10T19:33:56.781Z,1715369636.781 [Default:CheckIn] Stopped
2024-05-10T19:33:56.781Z,1715369636.781 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-05-10T19:33:56.782Z,1715369636.782 [Default:CheckIn](INFO): Running loop #2
2024-05-10T19:33:56.782Z,1715369636.782 [Default:CheckIn] Running Loop=2
2024-05-10T19:33:56.782Z,1715369636.782 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2024-05-10T19:33:56.782Z,1715369636.782 [Default:CheckIn:Read_GPS] Running Loop=1
2024-05-10T19:33:58.794Z,1715369638.794 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,193359.00,A,3648.17600,N,12147.27447,W,0.019,163.16,100524,,,D*7E
2024-05-10T19:33:58.796Z,1715369638.796 [NAL9602](INFO): GPS fix at 20240510T193359: (36.802933, -121.787908)
2024-05-10T19:33:58.805Z,1715369638.805 [Default:CheckIn:Read_GPS] Stopped
2024-05-10T19:33:58.805Z,1715369638.805 [Default:CheckIn:Read_Iridium] Running Loop=1
2024-05-10T19:34:27.546Z,1715369667.546 [NAL9602](INFO): SBD MO Status=2, MOMSN=11760, MT Status=2, MTMSN=0
2024-05-10T19:34:27.546Z,1715369667.546 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2024-05-10T19:35:22.127Z,1715369722.127 [NAL9602](INFO): SBD MO Status=2, MOMSN=11760, MT Status=2, MTMSN=0
2024-05-10T19:35:22.128Z,1715369722.128 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2024-05-10T19:35:39.539Z,1715369739.539 [NAL9602](INFO): SBD MO Status=2, MOMSN=11760, MT Status=2, MTMSN=0
2024-05-10T19:35:39.539Z,1715369739.539 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2024-05-10T19:35:40.770Z,1715369740.770 [CommandExec](IMPORTANT): got command restart application
2024-05-10T19:35:41.772Z,1715369741.772 [Supervisor](INFO): Stop Mission called by Supervisor::terminate
2024-05-10T19:35:41.772Z,1715369741.772 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread.
2024-05-10T19:35:41.772Z,1715369741.772 [CommandExec](INFO): Uninitializing the command executive.
2024-05-10T19:35:41.772Z,1715369741.772 [CommandExec](INFO): Uninitializing the command scheduler.
2024-05-10T19:35:41.773Z,1715369741.773 [CommandExec ThreadHandler](INFO): Thread cancelled.
2024-05-10T19:35:41.844Z,1715369741.844 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye!
2024-05-10T19:35:41.844Z,1715369741.844 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2024-05-10T19:35:41.844Z,1715369741.844 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2024-05-10T19:35:41.845Z,1715369741.845 [NavChartDb](INFO): Join timeout helper Thread ID is 1147
2024-05-10T19:35:42.017Z,1715369742.017 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2024-05-10T19:35:42.017Z,1715369742.017 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2024-05-10T19:35:42.028Z,1715369742.028 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler
2024-05-10T19:35:42.028Z,1715369742.028 [DAT ThreadHandler](INFO): Thread cancelled.
2024-05-10T19:35:42.029Z,1715369742.029 [DAT](INFO): Join timeout helper Thread ID is 1148
2024-05-10T19:35:42.036Z,1715369742.036 [DAT](INFO): Powering down
2024-05-10T19:35:42.109Z,1715369742.109 [DAT ThreadHandler](INFO): Uninitializing protected caller thread.
2024-05-10T19:35:42.109Z,1715369742.109 [DAT](INFO): Powering down
2024-05-10T19:35:42.110Z,1715369742.110 [DAT ThreadHandler](INFO): Thread cancelled.
2024-05-10T19:35:42.132Z,1715369742.132 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2024-05-10T19:35:42.132Z,1715369742.132 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2024-05-10T19:35:42.132Z,1715369742.132 [Radio_Surface](INFO): Join timeout helper Thread ID is 1149
2024-05-10T19:35:42.420Z,1715369742.420 [Radio_Surface](INFO): Powering down
2024-05-10T19:35:42.421Z,1715369742.421 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2024-05-10T19:35:42.421Z,1715369742.421 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2024-05-10T19:35:42.440Z,1715369742.440 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2024-05-10T19:35:42.440Z,1715369742.440 [Onboard ThreadHandler](INFO): Thread cancelled.
2024-05-10T19:35:42.440Z,1715369742.440 [Onboard](INFO): Join timeout helper Thread ID is 1150
2024-05-10T19:35:44.692Z,1715369744.692 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2024-05-10T19:35:44.692Z,1715369744.692 [Onboard ThreadHandler](INFO): Thread cancelled.
2024-05-10T19:35:44.704Z,1715369744.704 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2024-05-10T19:35:44.704Z,1715369744.704 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2024-05-10T19:35:44.704Z,1715369744.704 [DataOverHttps](INFO): Join timeout helper Thread ID is 1151
2024-05-10T19:35:45.508Z,1715369745.508 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2024-05-10T19:35:45.508Z,1715369745.508 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2024-05-10T19:35:45.529Z,1715369745.529 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler
2024-05-10T19:35:45.529Z,1715369745.529 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2024-05-10T19:35:45.529Z,1715369745.529 [BackseatComponent](INFO): Join timeout helper Thread ID is 1152
2024-05-10T19:35:45.572Z,1715369745.572 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread.
2024-05-10T19:35:45.573Z,1715369745.573 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2024-05-10T19:35:45.593Z,1715369745.593 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2024-05-10T19:35:45.593Z,1715369745.593 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2024-05-10T19:35:45.593Z,1715369745.593 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 1153
2024-05-10T19:35:45.672Z,1715369745.672 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2024-05-10T19:35:45.672Z,1715369745.672 [WetLabsBB2FL](INFO): Powering down
2024-05-10T19:35:45.673Z,1715369745.673 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2024-05-10T19:35:45.693Z,1715369745.693 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2024-05-10T19:35:45.694Z,1715369745.694 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2024-05-10T19:35:45.694Z,1715369745.694 [CTD_Seabird](INFO): Join timeout helper Thread ID is 1154
2024-05-10T19:35:46.496Z,1715369746.496 [CTD_Seabird](INFO): Powering down
2024-05-10T19:35:46.512Z,1715369746.512 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2024-05-10T19:35:46.517Z,1715369746.517 [CTD_Seabird](INFO): Powering down
2024-05-10T19:35:46.528Z,1715369746.528 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2024-05-10T19:35:46.541Z,1715369746.541 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2024-05-10T19:35:46.541Z,1715369746.541 [logger ThreadHandler](INFO): Thread cancelled.
2024-05-10T19:35:46.541Z,1715369746.541 [logger](INFO): Join timeout helper Thread ID is 1155
2024-05-10T19:35:46.572Z,1715369746.572 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2024-05-10T19:35:46.572Z,1715369746.572 [logger ThreadHandler](INFO): Thread cancelled.
2024-05-10T19:35:46.580Z,1715369746.580 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2024-05-10T19:35:46.581Z,1715369746.581 [CommandLine ThreadHandler](INFO): Thread cancelled.
2024-05-10T19:35:46.581Z,1715369746.581 [CommandLine](INFO): Join timeout helper Thread ID is 1156
2024-05-10T19:35:46.628Z,1715369746.628 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2024-05-10T19:35:46.628Z,1715369746.628 [CommandLine ThreadHandler](INFO): Thread cancelled.
2024-05-10T19:35:46.640Z,1715369746.640 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler
2024-05-10T19:35:46.641Z,1715369746.641 [CommandExec ThreadHandler](INFO): Thread cancelled.
2024-05-10T19:35:46.641Z,1715369746.641 [CommandExec](INFO): Join timeout helper Thread ID is 1157
2024-05-10T19:35:46.642Z,1715369746.642 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2024-05-10T19:35:46.642Z,1715369746.642 [controlThread ThreadHandler](INFO): Thread cancelled.
2024-05-10T19:35:46.643Z,1715369746.643 [controlThread](INFO): Join timeout helper Thread ID is 1158
2024-05-10T19:35:47.237Z,1715369747.237 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2024-05-10T19:35:47.237Z,1715369747.237 [controlThread](DEBUG): Uninitializing ControlThread
2024-05-10T19:35:47.239Z,1715369747.239 [AHRS_M2](INFO): Powering down
2024-05-10T19:35:47.404Z,1715369747.404 [DVL_micro](INFO): Powering down
2024-05-10T19:35:47.405Z,1715369747.405 [NAL9602](INFO): Powering down
2024-05-10T19:35:47.406Z,1715369747.406 [Sonardyne_Nano](INFO): Powering down
2024-05-10T19:35:47.525Z,1715369747.524 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2024-05-10T19:35:47.525Z,1715369747.525 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2024-05-10T19:35:47.526Z,1715369747.526 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2024-05-10T19:35:47.526Z,1715369747.526 [MissionManager](INFO): Uninitializing Mission Default
2024-05-10T19:35:47.526Z,1715369747.526 [Default] Stopped
2024-05-10T19:35:47.526Z,1715369747.526 [Default](DEBUG): Aggregate::uninitialize Default
2024-05-10T19:35:47.526Z,1715369747.526 [Default:B.GoToSurface] Stopped
2024-05-10T19:35:47.527Z,1715369747.527 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2024-05-10T19:35:47.527Z,1715369747.527 [Default:CheckIn] Stopped
2024-05-10T19:35:47.527Z,1715369747.527 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2024-05-10T19:35:47.527Z,1715369747.527 [Default:CheckIn:Read_Iridium] Stopped
2024-05-10T19:35:47.530Z,1715369747.530 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2024-05-10T19:35:47.530Z,1715369747.530 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2024-05-10T19:35:47.530Z,1715369747.530 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2024-05-10T19:35:47.531Z,1715369747.531 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2024-05-10T19:35:47.531Z,1715369747.531 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2024-05-10T19:35:47.531Z,1715369747.531 [BuoyancyServo](INFO): Powering down
2024-05-10T19:35:47.544Z,1715369747.544 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2024-05-10T19:35:47.544Z,1715369747.544 [ElevatorServo](INFO): Powering down
2024-05-10T19:35:47.545Z,1715369747.545 [MassServo](DEBUG): Uninitialize Mass Servo.
2024-05-10T19:35:47.545Z,1715369747.545 [MassServo](INFO): Powering down
2024-05-10T19:35:47.546Z,1715369747.546 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2024-05-10T19:35:47.546Z,1715369747.546 [RudderServo](INFO): Powering down
2024-05-10T19:35:47.547Z,1715369747.547 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2024-05-10T19:35:47.547Z,1715369747.547 [ThrusterHE](INFO): Powering down
2024-05-10T19:35:47.548Z,1715369747.548 [SBIT](DEBUG): Uninitialize SBIT Component.
2024-05-10T19:35:47.548Z,1715369747.548 [IBIT](DEBUG): Uninitialize IBIT Component.
2024-05-10T19:35:47.548Z,1715369747.548 [CBIT](DEBUG): Uninitialize CBIT Component.
2024-05-10T19:35:47.549Z,1715369747.549 [CBIT](DEBUG): Powering off loads.
2024-05-10T19:35:47.560Z,1715369747.560 [CBIT](DEBUG): Disabling WDT.
2024-05-10T19:35:47.572Z,1715369747.572 [CBIT](DEBUG): Opening all GF detection circuits.
2024-05-10T19:35:47.573Z,1715369747.573 [controlThread ThreadHandler](INFO): Thread cancelled.
2024-05-10T19:35:47.610Z,1715369747.610 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2024-05-10T19:35:47.616Z,1715369747.616 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2024-05-10T19:35:47.645Z,1715369747.645 [DAT ThreadHandler](INFO): Thread cancelled.
2024-05-10T19:35:47.650Z,1715369747.650 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2024-05-10T19:35:47.652Z,1715369747.652 [Onboard ThreadHandler](INFO): Thread cancelled.
2024-05-10T19:35:47.659Z,1715369747.659 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2024-05-10T19:35:47.703Z,1715369747.703 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2024-05-10T19:35:47.753Z,1715369747.753 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2024-05-10T19:35:47.818Z,1715369747.818 [logger ThreadHandler](INFO): Thread cancelled.