2024-11-01T17:13:02.695Z,1730481182.695 [Supervisor](DEBUG): Initializing supervisor. 2024-11-01T17:13:02.700Z,1730481182.700 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2024-11-01T17:13:02.701Z,1730481182.701 [SyncHandler](INFO): Protected caller Thread ID is 434 2024-11-01T17:13:02.701Z,1730481182.701 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2024-11-01T17:13:02.702Z,1730481182.702 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2024-11-01T17:13:02.703Z,1730481182.703 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 435 2024-11-01T17:13:02.707Z,1730481182.707 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2024-11-01T17:13:02.724Z,1730481182.724 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2024-11-01T17:13:02.725Z,1730481182.725 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2024-11-01T17:13:02.725Z,1730481182.725 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 436 2024-11-01T17:13:02.729Z,1730481182.729 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2024-11-01T17:13:02.730Z,1730481182.730 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2024-11-01T17:13:02.731Z,1730481182.731 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 437 2024-11-01T17:13:02.733Z,1730481182.733 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2024-11-01T17:13:02.734Z,1730481182.734 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2024-11-01T17:13:02.734Z,1730481182.734 [logger ThreadHandler](INFO): Protected caller Thread ID is 438 2024-11-01T17:13:02.738Z,1730481182.738 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2024-11-01T17:13:02.738Z,1730481182.738 [Supervisor](INFO): Looking for Config files in directory: Config/ 2024-11-01T17:13:02.740Z,1730481182.740 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2024-11-01T17:13:02.850Z,1730481182.850 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2024-11-01T17:13:02.850Z,1730481182.850 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2024-11-01T17:13:03.693Z,1730481183.693 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2024-11-01T17:13:03.694Z,1730481183.694 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2024-11-01T17:13:03.943Z,1730481183.943 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2024-11-01T17:13:03.944Z,1730481183.944 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2024-11-01T17:13:04.036Z,1730481184.036 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2024-11-01T17:13:04.182Z,1730481184.182 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2024-11-01T17:13:04.182Z,1730481184.182 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2024-11-01T17:13:04.295Z,1730481184.295 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2024-11-01T17:13:04.454Z,1730481184.454 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2024-11-01T17:13:04.454Z,1730481184.454 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2024-11-01T17:13:04.986Z,1730481184.986 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2024-11-01T17:13:04.986Z,1730481184.986 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2024-11-01T17:13:05.547Z,1730481185.547 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2024-11-01T17:13:05.547Z,1730481185.547 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2024-11-01T17:13:05.784Z,1730481185.784 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2024-11-01T17:13:05.785Z,1730481185.785 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2024-11-01T17:13:05.989Z,1730481185.989 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2024-11-01T17:13:05.990Z,1730481185.990 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2024-11-01T17:13:06.558Z,1730481186.558 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2024-11-01T17:13:06.558Z,1730481186.558 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2024-11-01T17:13:06.868Z,1730481186.868 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2024-11-01T17:13:06.869Z,1730481186.869 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2024-11-01T17:13:07.118Z,1730481187.118 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2024-11-01T17:13:07.118Z,1730481187.118 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2024-11-01T17:13:07.515Z,1730481187.515 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2024-11-01T17:13:07.515Z,1730481187.515 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2024-11-01T17:13:07.885Z,1730481187.885 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2024-11-01T17:13:07.887Z,1730481187.887 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-pontus/ 2024-11-01T17:13:07.888Z,1730481187.888 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/secure.cfg 2024-11-01T17:13:07.986Z,1730481187.986 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Sensor.cfg 2024-11-01T17:13:08.172Z,1730481188.172 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Dock.cfg 2024-11-01T17:13:08.294Z,1730481188.294 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/workSite.cfg 2024-11-01T17:13:08.403Z,1730481188.403 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Servo.cfg 2024-11-01T17:13:08.526Z,1730481188.526 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Simulator.cfg 2024-11-01T17:13:08.626Z,1730481188.626 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/logger.cfg 2024-11-01T17:13:08.735Z,1730481188.735 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/vehicle.cfg 2024-11-01T17:13:08.863Z,1730481188.863 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Battery.cfg 2024-11-01T17:13:09.137Z,1730481189.137 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2024-11-01T17:13:09.138Z,1730481189.138 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Navigation.cfg 2024-11-01T17:13:09.247Z,1730481189.247 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/BIT.cfg 2024-11-01T17:13:09.404Z,1730481189.404 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Science.cfg 2024-11-01T17:13:09.939Z,1730481189.939 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Control.cfg 2024-11-01T17:13:10.159Z,1730481190.159 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-pontus/root/ 2024-11-01T17:13:10.159Z,1730481190.159 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg 2024-11-01T17:13:10.288Z,1730481190.288 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2024-11-01T17:13:10.396Z,1730481190.396 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2024-11-01T17:13:10.396Z,1730481190.396 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2024-11-01T17:13:10.447Z,1730481190.447 [VerticalControl](DEBUG): Construct VerticalControl. 2024-11-01T17:13:10.505Z,1730481190.505 [VerticalControl] Loaded 2024-11-01T17:13:10.505Z,1730481190.505 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2024-11-01T17:13:10.508Z,1730481190.508 [HorizontalControl](DEBUG): Construct HorizontalControl. 2024-11-01T17:13:10.553Z,1730481190.553 [HorizontalControl] Loaded 2024-11-01T17:13:10.554Z,1730481190.554 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2024-11-01T17:13:10.556Z,1730481190.556 [SpeedControl](DEBUG): Construct SpeedControl. 2024-11-01T17:13:10.559Z,1730481190.559 [SpeedControl] Loaded 2024-11-01T17:13:10.559Z,1730481190.559 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2024-11-01T17:13:10.562Z,1730481190.562 [LoopControl](DEBUG): Construct LoopControl. 2024-11-01T17:13:10.562Z,1730481190.562 [LoopControl] Loaded 2024-11-01T17:13:10.562Z,1730481190.562 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2024-11-01T17:13:10.563Z,1730481190.563 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2024-11-01T17:13:10.563Z,1730481190.563 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2024-11-01T17:13:10.611Z,1730481190.611 [DepthRateCalculator] Loaded 2024-11-01T17:13:10.611Z,1730481190.611 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2024-11-01T17:13:10.616Z,1730481190.616 [PitchRateCalculator] Loaded 2024-11-01T17:13:10.616Z,1730481190.616 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2024-11-01T17:13:10.626Z,1730481190.626 [SpeedCalculator] Loaded 2024-11-01T17:13:10.626Z,1730481190.626 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2024-11-01T17:13:10.630Z,1730481190.630 [YawRateCalculator] Loaded 2024-11-01T17:13:10.630Z,1730481190.630 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2024-11-01T17:13:10.648Z,1730481190.648 [ElevatorOffsetCalculator] Loaded 2024-11-01T17:13:10.648Z,1730481190.648 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2024-11-01T17:13:10.648Z,1730481190.648 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2024-11-01T17:13:10.649Z,1730481190.649 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2024-11-01T17:13:10.675Z,1730481190.675 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2024-11-01T17:13:10.675Z,1730481190.675 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2024-11-01T17:13:10.730Z,1730481190.730 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2024-11-01T17:13:10.730Z,1730481190.730 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2024-11-01T17:13:11.053Z,1730481191.053 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2024-11-01T17:13:11.053Z,1730481191.053 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2024-11-01T17:13:11.218Z,1730481191.218 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2024-11-01T17:13:11.218Z,1730481191.218 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2024-11-01T17:13:11.701Z,1730481191.701 [AHRS_M2] Loaded 2024-11-01T17:13:11.702Z,1730481191.702 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2024-11-01T17:13:11.739Z,1730481191.739 [BackseatComponent] Loaded 2024-11-01T17:13:11.739Z,1730481191.739 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2024-11-01T17:13:11.740Z,1730481191.740 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 409D54E0 2024-11-01T17:13:11.741Z,1730481191.741 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 526 2024-11-01T17:13:11.744Z,1730481191.744 [LcmUniversalReporter] Loaded 2024-11-01T17:13:11.744Z,1730481191.744 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread. 2024-11-01T17:13:12.534Z,1730481192.534 [BPC1] Loaded 2024-11-01T17:13:12.534Z,1730481192.534 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2024-11-01T17:13:12.628Z,1730481192.628 [DAT] Loaded 2024-11-01T17:13:12.628Z,1730481192.628 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread. 2024-11-01T17:13:12.629Z,1730481192.629 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 40A054E0 2024-11-01T17:13:12.629Z,1730481192.629 [DAT ThreadHandler](INFO): Protected caller Thread ID is 527 2024-11-01T17:13:12.702Z,1730481192.702 [DataOverHttps] Loaded 2024-11-01T17:13:12.702Z,1730481192.702 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2024-11-01T17:13:12.703Z,1730481192.703 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 40A354E0 2024-11-01T17:13:12.704Z,1730481192.704 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 528 2024-11-01T17:13:12.726Z,1730481192.726 [Depth_Keller] Loaded 2024-11-01T17:13:12.726Z,1730481192.726 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2024-11-01T17:13:12.789Z,1730481192.789 [NAL9602] Loaded 2024-11-01T17:13:12.789Z,1730481192.789 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2024-11-01T17:13:12.818Z,1730481192.818 [Onboard] Loaded 2024-11-01T17:13:12.819Z,1730481192.819 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2024-11-01T17:13:12.819Z,1730481192.819 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 40A654E0 2024-11-01T17:13:12.820Z,1730481192.820 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 529 2024-11-01T17:13:12.833Z,1730481192.833 [Power24vConverter] Loaded 2024-11-01T17:13:12.834Z,1730481192.834 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2024-11-01T17:13:12.848Z,1730481192.848 [Radio_Surface] Loaded 2024-11-01T17:13:12.848Z,1730481192.848 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2024-11-01T17:13:12.849Z,1730481192.849 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 40A954E0 2024-11-01T17:13:12.850Z,1730481192.850 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 530 2024-11-01T17:13:12.945Z,1730481192.945 [RDI_Pathfinder] Loaded 2024-11-01T17:13:12.946Z,1730481192.946 [ComponentRegistry](DEBUG): SyncComponent "RDI_Pathfinder" handled in the control thread. 2024-11-01T17:13:12.961Z,1730481192.961 [Sonardyne_Nano] Loaded 2024-11-01T17:13:12.961Z,1730481192.961 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread. 2024-11-01T17:13:13.019Z,1730481193.019 [TrnDataBridge] Loaded 2024-11-01T17:13:13.019Z,1730481193.019 [ComponentRegistry](DEBUG): Component "TrnDataBridge" handled in its own thread. 2024-11-01T17:13:13.020Z,1730481193.020 [TrnDataBridge ThreadHandler](DEBUG): Created PCaller Thread at 40AC54E0 2024-11-01T17:13:13.021Z,1730481193.021 [TrnDataBridge ThreadHandler](INFO): Protected caller Thread ID is 531 2024-11-01T17:13:13.021Z,1730481193.021 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2024-11-01T17:13:13.022Z,1730481193.022 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2024-11-01T17:13:13.130Z,1730481193.130 [DeadReckonUsingMultipleVelocitySources] Loaded 2024-11-01T17:13:13.130Z,1730481193.130 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2024-11-01T17:13:13.143Z,1730481193.143 [NavChart] Loaded 2024-11-01T17:13:13.143Z,1730481193.143 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2024-11-01T17:13:13.149Z,1730481193.149 [UniversalFixResidualReporter] Loaded 2024-11-01T17:13:13.149Z,1730481193.149 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2024-11-01T17:13:13.150Z,1730481193.150 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2024-11-01T17:13:13.150Z,1730481193.150 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2024-11-01T17:13:13.285Z,1730481193.285 [SBIT](DEBUG): Construct Startup Built In Test. 2024-11-01T17:13:13.294Z,1730481193.294 [SBIT] Loaded 2024-11-01T17:13:13.294Z,1730481193.294 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2024-11-01T17:13:13.297Z,1730481193.297 [IBIT](DEBUG): Construct Initiated Built In Test. 2024-11-01T17:13:13.309Z,1730481193.309 [IBIT] Loaded 2024-11-01T17:13:13.310Z,1730481193.310 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2024-11-01T17:13:13.315Z,1730481193.315 [CBIT](DEBUG): Construct Continuous Built In Test. 2024-11-01T17:13:13.418Z,1730481193.418 [CBIT] Loaded 2024-11-01T17:13:13.419Z,1730481193.419 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2024-11-01T17:13:13.419Z,1730481193.419 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2024-11-01T17:13:13.420Z,1730481193.420 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2024-11-01T17:13:13.550Z,1730481193.550 [BuoyancyServo] Loaded 2024-11-01T17:13:13.550Z,1730481193.550 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2024-11-01T17:13:13.573Z,1730481193.573 [ElevatorServo] Loaded 2024-11-01T17:13:13.573Z,1730481193.573 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2024-11-01T17:13:13.602Z,1730481193.602 [DockingStepper] Loaded 2024-11-01T17:13:13.602Z,1730481193.602 [ComponentRegistry](DEBUG): SyncComponent "DockingStepper" handled in the control thread. 2024-11-01T17:13:13.624Z,1730481193.624 [MassServo] Loaded 2024-11-01T17:13:13.624Z,1730481193.624 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2024-11-01T17:13:13.644Z,1730481193.644 [RudderServo] Loaded 2024-11-01T17:13:13.644Z,1730481193.644 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2024-11-01T17:13:13.662Z,1730481193.662 [ThrusterServo] Loaded 2024-11-01T17:13:13.663Z,1730481193.663 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread. 2024-11-01T17:13:13.663Z,1730481193.663 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2024-11-01T17:13:13.664Z,1730481193.664 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2024-11-01T17:13:13.674Z,1730481193.674 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2024-11-01T17:13:13.674Z,1730481193.674 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2024-11-01T17:13:13.803Z,1730481193.803 [PAR_Licor] Loaded 2024-11-01T17:13:13.803Z,1730481193.803 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2024-11-01T17:13:13.848Z,1730481193.848 [WetLabsBB2FL] Loaded 2024-11-01T17:13:13.848Z,1730481193.848 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2024-11-01T17:13:13.849Z,1730481193.849 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40C194E0 2024-11-01T17:13:13.849Z,1730481193.849 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 532 2024-11-01T17:13:13.850Z,1730481193.850 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2024-11-01T17:13:13.856Z,1730481193.856 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2024-11-01T17:13:13.859Z,1730481193.859 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2024-11-01T17:13:13.870Z,1730481193.870 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2024-11-01T17:13:13.871Z,1730481193.871 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C494E0 2024-11-01T17:13:13.872Z,1730481193.872 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 533 2024-11-01T17:13:13.876Z,1730481193.876 [Supervisor](INFO): Main Thread ID is 8389 2024-11-01T17:13:13.876Z,1730481193.876 [Supervisor](DEBUG): Running supervisor. 2024-11-01T17:13:13.877Z,1730481193.877 [CommandExec ThreadHandler](INFO): Handler Thread ID is 534 2024-11-01T17:13:13.877Z,1730481193.877 [CommandExec](INFO): Initializing the command executive. 2024-11-01T17:13:13.879Z,1730481193.879 [CommandLine ThreadHandler](INFO): Handler Thread ID is 535 2024-11-01T17:13:13.881Z,1730481193.881 [controlThread ThreadHandler](INFO): Handler Thread ID is 536 2024-11-01T17:13:13.881Z,1730481193.881 [controlThread](DEBUG): Initializing ControlThread 2024-11-01T17:13:13.882Z,1730481193.882 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2024-11-01T17:13:13.884Z,1730481193.884 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2024-11-01T17:13:13.884Z,1730481193.884 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2024-11-01T17:13:13.885Z,1730481193.885 [LoopControl](DEBUG): Initialize LoopControlComponent. 2024-11-01T17:13:13.885Z,1730481193.885 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2024-11-01T17:13:13.886Z,1730481193.886 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2024-11-01T17:13:13.886Z,1730481193.886 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2024-11-01T17:13:13.886Z,1730481193.886 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2024-11-01T17:13:13.887Z,1730481193.887 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2024-11-01T17:13:13.891Z,1730481193.891 [NavChart](DEBUG): Initialize NavChart Navigation. 2024-11-01T17:13:13.891Z,1730481193.891 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2024-11-01T17:13:13.892Z,1730481193.892 [SBIT](INFO): Initialize SBIT Component. 2024-11-01T17:13:13.892Z,1730481193.892 [SBIT](IMPORTANT): git: 2024-10-30_A-4-gf74df006b 2024-11-01T17:13:13.892Z,1730481193.892 [SBIT](INFO): git hash: f74df006bde059d8e6673a3aded79e1c06227039 2024-11-01T17:13:13.892Z,1730481193.892 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2024-11-01T17:13:13.894Z,1730481193.894 [SBIT](INFO): Kernel Reporting Different Version From Configuration. Kernel Expected: #1 PREEMPT Thu Feb 21 11:17:40 PST 2019 Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021 2024-11-01T17:13:13.895Z,1730481193.895 [SBIT](INFO): Beginning SBIT in 114.000000 seconds. 2024-11-01T17:13:13.895Z,1730481193.895 [IBIT](INFO): Initialize IBIT Component. 2024-11-01T17:13:13.896Z,1730481193.896 [CBIT](DEBUG): Initialize CBIT Component. 2024-11-01T17:13:13.897Z,1730481193.897 [logger ThreadHandler](INFO): Handler Thread ID is 537 2024-11-01T17:13:13.909Z,1730481193.909 [CBIT](DEBUG): Initialized mux pins. 2024-11-01T17:13:13.909Z,1730481193.909 [CBIT](DEBUG): Initializing the watchdog timer. 2024-11-01T17:13:13.917Z,1730481193.917 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 538 2024-11-01T17:13:13.929Z,1730481193.929 [DAT ThreadHandler](INFO): Handler Thread ID is 539 2024-11-01T17:13:13.930Z,1730481193.930 [DAT](INFO): Powering up 2024-11-01T17:13:13.930Z,1730481193.930 [DAT](DEBUG): Initializing DAT. 2024-11-01T17:13:13.933Z,1730481193.933 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2024-11-01T17:13:13.933Z,1730481193.933 [CBIT](DEBUG): Initializing heartbeat. 2024-11-01T17:13:13.935Z,1730481193.935 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 541 2024-11-01T17:13:13.937Z,1730481193.937 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2024-11-01T17:13:13.946Z,1730481193.946 [Onboard ThreadHandler](INFO): Handler Thread ID is 542 2024-11-01T17:13:13.975Z,1730481193.975 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 543 2024-11-01T17:13:13.993Z,1730481193.993 [TrnDataBridge ThreadHandler](INFO): Handler Thread ID is 544 2024-11-01T17:13:13.994Z,1730481193.994 [TrnDataBridge](INFO): Start 2024-11-01T17:13:13.994Z,1730481193.994 [TrnDataBridge](IMPORTANT): LCM Instance1 2024-11-01T17:13:14.005Z,1730481194.005 [CBIT](DEBUG): Deactivating GF circuits. 2024-11-01T17:13:14.005Z,1730481194.005 [CBIT](DEBUG): Deactivating emergency mode. 2024-11-01T17:13:14.025Z,1730481194.025 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 546 2024-11-01T17:13:14.033Z,1730481194.033 [WetLabsBB2FL](INFO): Powering up 2024-11-01T17:13:14.035Z,1730481194.035 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 548 2024-11-01T17:13:14.038Z,1730481194.038 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2024-11-01T17:13:14.038Z,1730481194.038 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2024-11-01T17:13:14.038Z,1730481194.038 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2024-11-01T17:13:14.038Z,1730481194.038 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2024-11-01T17:13:14.038Z,1730481194.038 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2024-11-01T17:13:14.038Z,1730481194.038 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2024-11-01T17:13:14.039Z,1730481194.039 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2024-11-01T17:13:14.039Z,1730481194.039 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2024-11-01T17:13:14.045Z,1730481194.045 [CBIT](DEBUG): Backplane powered. 2024-11-01T17:13:14.050Z,1730481194.050 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser 2024-11-01T17:13:14.050Z,1730481194.050 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl 2024-11-01T17:13:14.051Z,1730481194.051 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl 2024-11-01T17:13:14.052Z,1730481194.052 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl 2024-11-01T17:13:14.100Z,1730481194.100 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into: 2024-11-01T17:13:14.121Z,1730481194.121 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2024-11-01T17:13:14.149Z,1730481194.149 [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-11-01T17:13:14.149Z,1730481194.149 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl 2024-11-01T17:13:14.150Z,1730481194.150 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl 2024-11-01T17:13:14.151Z,1730481194.151 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl 2024-11-01T17:13:14.377Z,1730481194.377 [Radio_Surface](INFO): Powering up 2024-11-01T17:13:14.438Z,1730481194.438 [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-11-01T17:13:14.463Z,1730481194.463 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2024-11-01T17:13:14.465Z,1730481194.465 [Default:A.Wait](DEBUG): Construct Wait. 2024-11-01T17:13:14.502Z,1730481194.502 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2024-11-01T17:13:14.538Z,1730481194.538 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2024-11-01T17:13:14.540Z,1730481194.540 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2024-11-01T17:13:14.560Z,1730481194.560 [Default:E.Execute](DEBUG): Construct Execute. 2024-11-01T17:13:14.563Z,1730481194.563 [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-11-01T17:13:14.602Z,1730481194.602 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,NAL9602,Power24vConverter,RDI_Pathfinder,Sonardyne_Nano,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,DockingStepper,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2024-11-01T17:13:14.626Z,1730481194.626 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2024-11-01T17:13:14.690Z,1730481194.690 [Depth_Keller](ERROR): Pressure or depth reading out of range: -1.000394 decibar, -0.993022 m 2024-11-01T17:13:14.691Z,1730481194.691 [Power24vConverter](INFO): Powering up. 2024-11-01T17:13:14.692Z,1730481194.692 [RDI_Pathfinder](IMPORTANT): Expecting PD13 message format 2024-11-01T17:13:14.702Z,1730481194.702 [Sonardyne_Nano](INFO): Initializing. 2024-11-01T17:13:14.741Z,1730481194.741 [DepthRateCalculator](ERROR): Depth measurement is not active 2024-11-01T17:13:14.766Z,1730481194.766 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2024-11-01T17:13:14.773Z,1730481194.773 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2024-11-01T17:13:14.774Z,1730481194.774 [ElevatorServo](DEBUG): Initializing EZServoServo. 2024-11-01T17:13:14.782Z,1730481194.782 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2024-11-01T17:13:14.783Z,1730481194.783 [DockingStepper](INFO): Start 2024-11-01T17:13:14.783Z,1730481194.783 [DockingStepper](DEBUG): Initializing EZServoServo. 2024-11-01T17:13:14.789Z,1730481194.789 [DockingStepper](DEBUG): Initializing DockingStepper. 2024-11-01T17:13:14.790Z,1730481194.790 [MassServo](DEBUG): Initializing EZServoServo. 2024-11-01T17:13:14.797Z,1730481194.797 [MassServo](DEBUG): Initializing MassServo. 2024-11-01T17:13:14.798Z,1730481194.798 [RudderServo](DEBUG): Initializing EZServoServo. 2024-11-01T17:13:14.805Z,1730481194.805 [RudderServo](DEBUG): Initializing RudderServo. 2024-11-01T17:13:14.806Z,1730481194.806 [ThrusterServo](DEBUG): Initializing EZServoServo. 2024-11-01T17:13:14.814Z,1730481194.814 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2024-11-01T17:13:15.080Z,1730481195.080 [DockingStepper](INFO): Starting 2024-11-01T17:13:15.436Z,1730481195.436 [DockingStepper](INFO): Starting 2024-11-01T17:13:15.961Z,1730481195.961 [DockingStepper](INFO): Starting 2024-11-01T17:13:16.010Z,1730481196.010 [DockingStepper](INFO): Init string: /1z15041aE13561N3m50 2024-11-01T17:13:16.273Z,1730481196.273 [DockingStepper](INFO): Starting 2024-11-01T17:13:16.631Z,1730481196.631 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART 2024-11-01T17:13:16.641Z,1730481196.641 [WetLabsBB2FL](INFO): Powering down 2024-11-01T17:13:16.674Z,1730481196.674 [DockingStepper](INFO): Starting 2024-11-01T17:13:17.053Z,1730481197.053 [DockingStepper](INFO): Starting 2024-11-01T17:13:17.502Z,1730481197.502 [DockingStepper](INFO): Starting 2024-11-01T17:13:17.526Z,1730481197.526 [DockingStepper](INFO): Sent speed cmd:/1V10000 Response:ÿ/0@ 2024-11-01T17:13:17.971Z,1730481197.971 [DockingStepper](INFO): Starting 2024-11-01T17:13:18.286Z,1730481198.286 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2103 2024-11-01T17:13:18.796Z,1730481198.796 [DockingStepper](INFO): Pause 2024-11-01T17:13:26.790Z,1730481206.790 [DAT](INFO): DAT read: 2024-11-01T17:13:26.791Z,1730481206.791 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series 2024-11-01T17:13:28.556Z,1730481208.556 [DAT](INFO): DAT read: MF Frequency Band 2024-11-01T17:13:28.806Z,1730481208.806 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.17.2 2024-11-01T17:13:28.807Z,1730481208.807 [DAT](INFO): DAT read: Nov 1 2024 17:13:22 2024-11-01T17:13:29.814Z,1730481209.814 [DAT](INFO): DAT read: Features enabled [Bearing] 2024-11-01T17:13:29.815Z,1730481209.815 [DAT](INFO): DAT read: CONNECT 00600 bits/sec 1 of 4, Rate 1/2 CC 25.00ms MGP 2024-11-01T17:13:29.816Z,1730481209.816 [DAT](INFO): commRate: 600 2024-11-01T17:13:31.881Z,1730481211.881 [DAT](INFO): entering command mode 2024-11-01T17:13:32.082Z,1730481212.082 [DAT](INFO): DAT read: 2024-11-01T17:13:32.082Z,1730481212.082 [DAT](INFO): DAT read: user:1> 2024-11-01T17:13:32.082Z,1730481212.082 [DAT](INFO): setting verbose to 3 2024-11-01T17:13:32.334Z,1730481212.334 [DAT](INFO): DAT read: user:1> 2024-11-01T17:13:32.335Z,1730481212.335 [DAT](INFO): DAT read: Verbose | 3 2024-11-01T17:13:32.335Z,1730481212.335 [DAT](INFO): set verbose to 3 2024-11-01T17:13:32.336Z,1730481212.336 [DAT](INFO): setting DatVerbose to 27440 2024-11-01T17:13:32.586Z,1730481212.586 [DAT](INFO): DAT read: user:2> 2024-11-01T17:13:32.587Z,1730481212.587 [DAT](INFO): DAT read: DatVerbose | 27440 2024-11-01T17:13:32.587Z,1730481212.587 [DAT](INFO): set DatVerbose to 27440 2024-11-01T17:13:32.587Z,1730481212.587 [DAT](INFO): setting transmit power to 8 2024-11-01T17:13:32.838Z,1730481212.838 [DAT](INFO): DAT read: user:3> 2024-11-01T17:13:32.839Z,1730481212.839 [DAT](INFO): DAT read: TxPower | 8 (Max) 2024-11-01T17:13:32.839Z,1730481212.839 [DAT](INFO): set transmit power to 8 2024-11-01T17:13:32.839Z,1730481212.839 [DAT](INFO): setting local address to 10 2024-11-01T17:13:33.090Z,1730481213.090 [DAT](INFO): DAT read: user:4> 2024-11-01T17:13:33.091Z,1730481213.091 [DAT](INFO): DAT read: LocalAddr | 10 2024-11-01T17:13:33.091Z,1730481213.091 [DAT](INFO): set local address to 10 2024-11-01T17:13:33.092Z,1730481213.092 [DAT](INFO): Setting time to: 17:13:33 And date to:11/1/2024 2024-11-01T17:13:33.342Z,1730481213.342 [DAT](INFO): DAT read: user:5> 2024-11-01T17:13:33.343Z,1730481213.343 [DAT](INFO): DAT read: Fri Nov 1, 2024 17:13:33 2024-11-01T17:13:33.343Z,1730481213.343 [DAT](INFO): Local DAT time set to Fri Nov 1, 2024 17:13:33 2024-11-01T17:13:42.926Z,1730481222.926 [NAL9602](INFO): Powering up NAL9602 2024-11-01T17:13:53.847Z,1730481233.847 [NAL9602](INFO): NAL9602 initialized 2024-11-01T17:15:07.198Z,1730481307.198 [CommandExec](IMPORTANT): got command maintain sensor NAL9602.latitude_fix 36.8 degree 2024-11-01T17:15:07.202Z,1730481307.202 [ComponentRegistry](DEBUG): SyncComponent "Maintain_NAL9602.latitude_fix" handled in the control thread. 2024-11-01T17:15:07.202Z,1730481307.202 [CommandExec](IMPORTANT): got command maintain sensor NAL9602.longitude_fix -122.0 degree 2024-11-01T17:15:07.206Z,1730481307.206 [ComponentRegistry](DEBUG): SyncComponent "Maintain_NAL9602.longitude_fix" handled in the control thread. 2024-11-01T17:15:07.400Z,1730481307.400 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,NAL9602,Power24vConverter,RDI_Pathfinder,Sonardyne_Nano,PAR_Licor,Depth_Keller,PAR_Licor,Maintain_NAL9602.latitude_fix,Maintain_NAL9602.longitude_fix,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,DockingStepper,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2024-11-01T17:15:08.643Z,1730481308.643 [SBIT](IMPORTANT): Beginning Startup BIT 2024-11-01T17:15:08.651Z,1730481308.651 [CBIT](IMPORTANT): Beginning ground fault scan 2024-11-01T17:15:10.341Z,1730481310.341 [ElevatorServo](FAULT): Overload Error 2024-11-01T17:15:10.341Z,1730481310.341 [ElevatorServo] Hardware Fault, FailCount= 1 2024-11-01T17:15:10.341Z,1730481310.341 [ElevatorServo](ERROR): Hardware Fault 2024-11-01T17:15:10.458Z,1730481310.458 [CBIT](ERROR): Hardware Fault in component: ElevatorServo 2024-11-01T17:15:10.624Z,1730481310.624 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2024-11-01T17:15:10.624Z,1730481310.624 [ElevatorServo](INFO): Powering down 2024-11-01T17:15:11.454Z,1730481311.454 [ElevatorServo](DEBUG): Initializing EZServoServo. 2024-11-01T17:15:11.574Z,1730481311.574 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2024-11-01T17:15:11.634Z,1730481311.634 [CBIT](INFO): Clearing failed state for component ElevatorServo 2024-11-01T17:15:11.634Z,1730481311.634 [ElevatorServo] No Fault, FailCount= 1 2024-11-01T17:15:16.401Z,1730481316.401 [ElevatorServo](FAULT): Overload Error 2024-11-01T17:15:16.401Z,1730481316.401 [ElevatorServo] Hardware Fault, FailCount= 2 2024-11-01T17:15:16.401Z,1730481316.401 [ElevatorServo](ERROR): Hardware Fault 2024-11-01T17:15:16.469Z,1730481316.469 [CBIT](ERROR): Hardware Fault in component: ElevatorServo 2024-11-01T17:15:16.702Z,1730481316.702 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2024-11-01T17:15:16.702Z,1730481316.702 [ElevatorServo](INFO): Powering down 2024-11-01T17:15:17.519Z,1730481317.519 [ElevatorServo](DEBUG): Initializing EZServoServo. 2024-11-01T17:15:17.606Z,1730481317.606 [CommandExec](IMPORTANT): got command set NAL9602.time_fix 1730481311 second 2024-11-01T17:15:17.640Z,1730481317.640 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2024-11-01T17:15:17.678Z,1730481317.678 [CBIT](INFO): Clearing failed state for component ElevatorServo 2024-11-01T17:15:17.678Z,1730481317.678 [ElevatorServo] No Fault, FailCount= 2 2024-11-01T17:15:18.853Z,1730481318.853 [CommandExec](IMPORTANT): got command failComponent 2024-11-01T17:15:18.854Z,1730481318.854 [CommandExec](IMPORTANT): Failed components: 2024-11-01T17:15:18.854Z,1730481318.854 [CommandExec](IMPORTANT): No failed Components. 2024-11-01T17:15:19.546Z,1730481319.546 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): 0.008703 CHAN A1 (24V): 0.003582 CHAN A2 (12V): -0.005920 CHAN A3 (5V): -0.000727 CHAN B0 (3.3V): 0.000829 CHAN B1 (3.15aV): 0.001597 CHAN B2 (3.15bV): -0.000025 CHAN B3 (GND): 0.001959 OPEN: 0.005052 Full Scale: +/- 1 mA 2024-11-01T17:15:21.811Z,1730481321.811 [SBIT](FAULT): Elevator: EXPECTED:15.000000 ACTUAL:17.648121 2024-11-01T17:15:22.789Z,1730481322.789 [ElevatorServo](FAULT): Overload Error 2024-11-01T17:15:22.789Z,1730481322.789 [ElevatorServo] Hardware Fault, FailCount= 3 2024-11-01T17:15:22.789Z,1730481322.789 [ElevatorServo](ERROR): Hardware Fault 2024-11-01T17:15:22.830Z,1730481322.830 [CBIT](ERROR): Hardware Fault in component: ElevatorServo 2024-11-01T17:15:22.830Z,1730481322.830 [CBIT](CRITICAL): Hardware Fault in component: ElevatorServo 2024-11-01T17:15:23.147Z,1730481323.147 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2024-11-01T17:15:23.147Z,1730481323.147 [ElevatorServo](INFO): Powering down 2024-11-01T17:15:23.151Z,1730481323.151 [CommandExec](FAULT): Scheduling is paused 2024-11-01T17:15:23.151Z,1730481323.151 [CBIT](INFO): Critical error at 20241101T171522 2024-11-01T17:15:23.152Z,1730481323.152 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2024-11-01T17:15:23.948Z,1730481323.948 [ElevatorServo](DEBUG): Initializing EZServoServo. 2024-11-01T17:15:24.063Z,1730481324.063 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2024-11-01T17:15:25.306Z,1730481325.306 [CommandExec](IMPORTANT): got command failComponent 2024-11-01T17:15:25.306Z,1730481325.306 [CommandExec](IMPORTANT): Failed components: 2024-11-01T17:15:25.306Z,1730481325.306 [CommandExec](IMPORTANT): ElevatorServo: Hardware Fault 2024-11-01T17:15:29.186Z,1730481329.186 [CommandExec](IMPORTANT): got command failComponent none ElevatorServo 2024-11-01T17:15:29.187Z,1730481329.187 [ElevatorServo] No Fault, FailCount= 3 2024-11-01T17:15:29.187Z,1730481329.187 [CommandExec](IMPORTANT): ElevatorServo failureMode is No Fault 2024-11-01T17:15:33.273Z,1730481333.273 [ElevatorServo](FAULT): Overload Error 2024-11-01T17:15:33.273Z,1730481333.273 [ElevatorServo] Hardware Fault, FailCount= 4 2024-11-01T17:15:33.273Z,1730481333.273 [ElevatorServo](ERROR): Hardware Fault 2024-11-01T17:15:33.391Z,1730481333.391 [CBIT](ERROR): Hardware Fault in component: ElevatorServo 2024-11-01T17:15:33.391Z,1730481333.391 [CBIT](CRITICAL): Hardware Fault in component: ElevatorServo 2024-11-01T17:15:33.666Z,1730481333.666 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2024-11-01T17:15:33.666Z,1730481333.666 [ElevatorServo](INFO): Powering down 2024-11-01T17:15:33.755Z,1730481333.755 [CBIT](INFO): Critical error at 20241101T171533 2024-11-01T17:15:34.510Z,1730481334.510 [ElevatorServo](DEBUG): Initializing EZServoServo. 2024-11-01T17:15:34.630Z,1730481334.630 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2024-11-01T17:15:41.982Z,1730481341.982 [CommandExec](IMPORTANT): got command failComponent none ElevatorServo 2024-11-01T17:15:41.982Z,1730481341.982 [ElevatorServo] No Fault, FailCount= 4 2024-11-01T17:15:41.982Z,1730481341.982 [CommandExec](IMPORTANT): ElevatorServo failureMode is No Fault 2024-11-01T17:15:46.285Z,1730481346.285 [ElevatorServo](FAULT): Overload Error 2024-11-01T17:15:46.285Z,1730481346.285 [ElevatorServo] Hardware Fault, FailCount= 5 2024-11-01T17:15:46.285Z,1730481346.285 [ElevatorServo](ERROR): Hardware Fault 2024-11-01T17:15:46.370Z,1730481346.370 [CBIT](ERROR): Hardware Fault in component: ElevatorServo 2024-11-01T17:15:46.370Z,1730481346.370 [CBIT](CRITICAL): Hardware Fault in component: ElevatorServo 2024-11-01T17:15:46.624Z,1730481346.624 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2024-11-01T17:15:46.624Z,1730481346.624 [ElevatorServo](INFO): Powering down 2024-11-01T17:15:46.688Z,1730481346.688 [CBIT](INFO): Critical error at 20241101T171546 2024-11-01T17:15:47.409Z,1730481347.409 [ElevatorServo](DEBUG): Initializing EZServoServo. 2024-11-01T17:15:47.527Z,1730481347.527 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2024-11-01T17:15:48.623Z,1730481348.623 [SBIT](ERROR): Could not read elevatorAngleReader_. 2024-11-01T17:15:48.623Z,1730481348.623 [SBIT](FAULT): Control surface position failure. 2024-11-01T17:15:50.832Z,1730481350.832 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.005546 2024-11-01T17:16:02.007Z,1730481362.007 [SBIT](ERROR): Could not read elevatorAngleReader_. 2024-11-01T17:16:02.007Z,1730481362.007 [SBIT](FAULT): Control surface position failure. 2024-11-01T17:16:02.467Z,1730481362.467 [SBIT](CRITICAL): SBIT FAILED 2024-11-01T17:16:02.467Z,1730481362.467 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2024-11-01T17:16:02.468Z,1730481362.468 [SBIT](IMPORTANT): CTD_Seabird.loadAtStartup=0 bool; 2024-11-01T17:16:02.468Z,1730481362.468 [SBIT](IMPORTANT): DockingStepper.closedValue=16450 count; 2024-11-01T17:16:02.468Z,1730481362.468 [SBIT](IMPORTANT): DockingStepper.slideValue=10800 count; 2024-11-01T17:16:02.468Z,1730481362.468 [SBIT](IMPORTANT): DropWeight.loadAtStartup=0 bool; 2024-11-01T17:16:02.468Z,1730481362.468 [SBIT](IMPORTANT): Express linearApproximation DATMMP.acoustic_contact_range 15.000000 meter; 2024-11-01T17:16:02.468Z,1730481362.468 [SBIT](IMPORTANT): Express linearApproximation TrackAcousticContact.range_to_contact 5.000000 meter; 2024-11-01T17:16:02.468Z,1730481362.468 [SBIT](IMPORTANT): Express linearApproximation TrnDataBridge.mmse_lat 0.000200 angular_degree; 2024-11-01T17:16:02.469Z,1730481362.469 [SBIT](IMPORTANT): Express linearApproximation TrnDataBridge.mmse_lon 0.000200 angular_degree; 2024-11-01T17:16:02.473Z,1730481362.473 [SBIT](IMPORTANT): LineCapture.interceptTimeout=5 second; 2024-11-01T17:16:02.473Z,1730481362.473 [SBIT](IMPORTANT): LineCapture.kiHeadingFinalApproach=0.02 reciprocal_second; 2024-11-01T17:16:02.473Z,1730481362.473 [SBIT](IMPORTANT): LineCapture.kiHeadingTerminalGuidance=0.02 reciprocal_second; 2024-11-01T17:16:02.473Z,1730481362.473 [SBIT](IMPORTANT): LineCapture.navigationGain=3 none; 2024-11-01T17:16:02.473Z,1730481362.473 [SBIT](IMPORTANT): LineCapture.rolloutSpeed=0 meter_per_second; 2024-11-01T17:16:02.474Z,1730481362.474 [SBIT](IMPORTANT): RudderServo.offsetAngle=0.2 degree; 2024-11-01T17:16:02.474Z,1730481362.474 [SBIT](IMPORTANT): Undock.reverseThrustTimeout=20 second; 2024-11-01T17:16:02.474Z,1730481362.474 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=317.403036 cubic_centimeter; 2024-11-01T17:16:02.474Z,1730481362.474 [SBIT](IMPORTANT): VerticalControl.kdPitchMass=1.25 second; 2024-11-01T17:16:02.474Z,1730481362.474 [SBIT](IMPORTANT): VerticalControl.kiPitchMass=1.25 reciprocal_second; 2024-11-01T17:16:02.474Z,1730481362.474 [SBIT](IMPORTANT): VerticalControl.kpPitchMass=1.25 none; 2024-11-01T17:16:02.474Z,1730481362.474 [SBIT](IMPORTANT): VerticalControl.massDeadband=0.05 centimeter; 2024-11-01T17:16:02.474Z,1730481362.474 [SBIT](IMPORTANT): VerticalControl.massDefault=23.583194 millimeter; 2024-11-01T17:16:02.474Z,1730481362.474 [SBIT](IMPORTANT): VerticalControl.massOnlyForceInt=0 bool; 2024-11-01T17:16:02.474Z,1730481362.474 [SBIT](IMPORTANT): WetLabsUBAT.loadAtStartup=0 bool; 2024-11-01T17:16:02.476Z,1730481362.476 [CBIT](INFO): Critical error at 20241101T171602 2024-11-01T17:16:02.866Z,1730481362.866 [MissionManager](IMPORTANT): Started mission Startup 2024-11-01T17:16:02.867Z,1730481362.867 [Startup] Running Loop=1 2024-11-01T17:16:02.867Z,1730481362.867 [Startup](DEBUG): Aggregate::initialize Startup 2024-11-01T17:16:02.867Z,1730481362.867 [Startup:A.GoToSurface] Running Loop=1 2024-11-01T17:16:02.867Z,1730481362.867 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2024-11-01T17:16:02.867Z,1730481362.867 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2024-11-01T17:16:02.868Z,1730481362.868 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2024-11-01T17:16:02.868Z,1730481362.868 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2024-11-01T17:16:02.869Z,1730481362.869 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2024-11-01T17:16:02.874Z,1730481362.874 [Startup:A.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2024-11-01T17:16:02.874Z,1730481362.874 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2024-11-01T17:16:02.876Z,1730481362.876 [Startup:StartupSatComms] Running Loop=1 2024-11-01T17:16:02.876Z,1730481362.876 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2024-11-01T17:16:02.876Z,1730481362.876 [Startup:StartupSatComms:A] Running Loop=1 2024-11-01T17:16:03.222Z,1730481363.222 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2024-11-01T17:16:03.222Z,1730481363.222 [Startup:StartupSatComms:A] Stopped 2024-11-01T17:16:03.222Z,1730481363.222 [Startup:StartupSatComms:B] Running Loop=1 2024-11-01T17:16:03.630Z,1730481363.630 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2024-11-01T17:16:08.566Z,1730481368.566 [CommandExec](IMPORTANT): got command failComponent none ElevatorServo 2024-11-01T17:16:08.566Z,1730481368.566 [ElevatorServo] No Fault, FailCount= 5 2024-11-01T17:16:08.566Z,1730481368.566 [CommandExec](IMPORTANT): ElevatorServo failureMode is No Fault 2024-11-01T17:16:10.757Z,1730481370.757 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20241101T163725/Courier0013.lzma 2024-11-01T17:16:11.759Z,1730481371.759 [DataOverHttps](INFO): Moved sent file to Logs/20241101T163725/Courier0013.lzma.bak 2024-11-01T17:16:11.759Z,1730481371.759 [DataOverHttps](INFO): SBD MOMSN=23359762 2024-11-01T17:16:12.557Z,1730481372.557 [ElevatorServo](FAULT): Overload Error 2024-11-01T17:16:12.557Z,1730481372.557 [ElevatorServo] Hardware Fault, FailCount= 6 2024-11-01T17:16:12.557Z,1730481372.557 [ElevatorServo](ERROR): Hardware Fault 2024-11-01T17:16:12.586Z,1730481372.586 [CBIT](ERROR): Hardware Fault in component: ElevatorServo 2024-11-01T17:16:12.586Z,1730481372.586 [CBIT](CRITICAL): Hardware Fault in component: ElevatorServo 2024-11-01T17:16:12.991Z,1730481372.991 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2024-11-01T17:16:12.991Z,1730481372.991 [ElevatorServo](INFO): Powering down 2024-11-01T17:16:13.019Z,1730481373.019 [CBIT](INFO): Critical error at 20241101T171612 2024-11-01T17:16:13.820Z,1730481373.820 [ElevatorServo](DEBUG): Initializing EZServoServo. 2024-11-01T17:16:13.978Z,1730481373.978 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2024-11-01T17:16:28.350Z,1730481388.350 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20241101T170856/Courier0000.lzma 2024-11-01T17:16:29.351Z,1730481389.351 [DataOverHttps](INFO): Moved sent file to Logs/20241101T170856/Courier0000.lzma.bak 2024-11-01T17:16:29.351Z,1730481389.351 [DataOverHttps](INFO): SBD MOMSN=23359764 2024-11-01T17:16:45.745Z,1730481405.745 [DataOverHttps](INFO): Sending 287 bytes from file Logs/20241101T171302/Courier0000.lzma 2024-11-01T17:16:46.747Z,1730481406.747 [DataOverHttps](INFO): Moved sent file to Logs/20241101T171302/Courier0000.lzma.bak 2024-11-01T17:16:46.747Z,1730481406.747 [DataOverHttps](INFO): SBD MOMSN=23359767 2024-11-01T17:17:03.393Z,1730481423.393 [Startup:StartupSatComms:B](INFO): Timed out from 2024-11-01T17:16:03.2Z 2024-11-01T17:17:03.393Z,1730481423.393 [Startup:StartupSatComms:B] Stopped 2024-11-01T17:17:03.393Z,1730481423.393 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2024-11-01T17:17:03.393Z,1730481423.393 [Startup:StartupSatComms] Stopped 2024-11-01T17:17:03.393Z,1730481423.393 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2024-11-01T17:17:03.394Z,1730481423.394 [Startup](INFO): Completed Startup 2024-11-01T17:17:03.395Z,1730481423.395 [MissionManager](INFO): Startup is completed. 2024-11-01T17:17:03.395Z,1730481423.395 [MissionManager](INFO): Uninitializing Mission Startup 2024-11-01T17:17:03.395Z,1730481423.395 [Startup] Stopped 2024-11-01T17:17:03.395Z,1730481423.395 [Startup](DEBUG): Aggregate::uninitialize Startup 2024-11-01T17:17:03.395Z,1730481423.395 [Startup:A.GoToSurface] Stopped 2024-11-01T17:17:03.395Z,1730481423.395 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2024-11-01T17:17:03.402Z,1730481423.402 [DataOverHttps](INFO): Sending 527 bytes from file Logs/20241101T163725/Express0015.lzma 2024-11-01T17:17:03.805Z,1730481423.805 [MissionManager](IMPORTANT): Started mission Default 2024-11-01T17:17:03.805Z,1730481423.805 [Default] Running Loop=1 2024-11-01T17:17:03.805Z,1730481423.805 [Default](DEBUG): Aggregate::initialize Default 2024-11-01T17:17:03.805Z,1730481423.805 [Default:B.GoToSurface] Running Loop=1 2024-11-01T17:17:03.805Z,1730481423.805 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2024-11-01T17:17:03.806Z,1730481423.806 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2024-11-01T17:17:03.806Z,1730481423.806 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2024-11-01T17:17:03.806Z,1730481423.806 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2024-11-01T17:17:03.807Z,1730481423.807 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2024-11-01T17:17:03.807Z,1730481423.807 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2024-11-01T17:17:03.807Z,1730481423.807 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2024-11-01T17:17:03.807Z,1730481423.807 [Default:A.Wait] Running Loop=1 2024-11-01T17:17:03.807Z,1730481423.807 [Default:A.Wait](DEBUG): Initialize Wait Component. 2024-11-01T17:17:04.262Z,1730481424.262 [RDI_Pathfinder](ERROR): only read 2 of 4 data items for water velocity. Device response is::WS,-3278,-32768,V 2024-11-01T17:17:04.403Z,1730481424.403 [DataOverHttps](INFO): Moved sent file to Logs/20241101T163725/Express0015.lzma.bak 2024-11-01T17:17:04.403Z,1730481424.403 [DataOverHttps](INFO): SBD MOMSN=23359774 2024-11-01T17:17:17.162Z,1730481437.162 [Default:A.Wait](INFO): Done Waiting. 2024-11-01T17:17:17.162Z,1730481437.162 [Default:A.Wait] Stopped 2024-11-01T17:17:17.162Z,1730481437.162 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2024-11-01T17:17:17.570Z,1730481437.570 [Default:CheckIn] Running Loop=1 2024-11-01T17:17:17.570Z,1730481437.570 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-11-01T17:17:17.570Z,1730481437.570 [Default:CheckIn:Read_GPS] Running Loop=1 2024-11-01T17:17:17.938Z,1730481437.938 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2024-11-01T17:18:14.516Z,1730481494.516 [RDI_Pathfinder](ERROR): only read 2 of 4 data items for bottom velocity. Device response is::BS,-32768,-32768, 2024-11-01T17:18:57.714Z,1730481537.714 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2024-11-01T17:21:30.445Z,1730481690.445 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6. 2024-11-01T17:21:30.449Z,1730481690.449 [BPC1](INFO): Received data from all battery sticks. 2024-11-01T17:22:17.737Z,1730481737.737 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-11-01T17:17:17.6Z 2024-11-01T17:22:17.737Z,1730481737.737 [Default:CheckIn:Read_GPS] Stopped 2024-11-01T17:22:17.737Z,1730481737.737 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-11-01T17:22:18.154Z,1730481738.154 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications 2024-11-01T17:22:25.381Z,1730481745.381 [DataOverHttps](INFO): Sending 214 bytes from file Logs/20241101T171302/Courier0004.lzma 2024-11-01T17:22:26.383Z,1730481746.383 [DataOverHttps](INFO): Moved sent file to Logs/20241101T171302/Courier0004.lzma.bak 2024-11-01T17:22:26.383Z,1730481746.383 [DataOverHttps](INFO): SBD MOMSN=23359838 2024-11-01T17:22:35.989Z,1730481755.989 [CommandExec](IMPORTANT): got command failComponent 2024-11-01T17:22:35.990Z,1730481755.990 [CommandExec](IMPORTANT): Failed components: 2024-11-01T17:22:35.990Z,1730481755.990 [CommandExec](IMPORTANT): ElevatorServo: Hardware Fault 2024-11-01T17:22:43.126Z,1730481763.126 [DataOverHttps](INFO): Sending 12487 bytes from file Logs/20241101T170856/Express0001.lzma 2024-11-01T17:22:46.115Z,1730481766.115 [DataOverHttps](INFO): Moved sent file to Logs/20241101T170856/Express0001.lzma.bak 2024-11-01T17:22:46.115Z,1730481766.115 [DataOverHttps](INFO): SBD MOMSN=23359841 2024-11-01T17:22:46.139Z,1730481766.139 [CommandExec](IMPORTANT): got command configSet ElevatorServo.loadAtStartup 0 bool persist 2024-11-01T17:22:46.139Z,1730481766.139 [CommandExec](IMPORTANT): configSet ElevatorServo.loadAtStartup requires a restart to take effect. 2024-11-01T17:22:48.846Z,1730481768.846 [CommandExec](IMPORTANT): got command restart application 2024-11-01T17:22:49.849Z,1730481769.849 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2024-11-01T17:22:49.849Z,1730481769.849 [CommandExec](INFO): Uninitializing the command executive. 2024-11-01T17:22:49.849Z,1730481769.849 [CommandExec](INFO): Uninitializing the command scheduler. 2024-11-01T17:22:49.850Z,1730481769.850 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-11-01T17:22:49.885Z,1730481769.885 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2024-11-01T17:22:49.885Z,1730481769.885 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2024-11-01T17:22:49.885Z,1730481769.885 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-11-01T17:22:49.886Z,1730481769.886 [NavChartDb](INFO): Join timeout helper Thread ID is 576 2024-11-01T17:22:49.921Z,1730481769.921 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2024-11-01T17:22:49.922Z,1730481769.922 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-11-01T17:22:49.929Z,1730481769.929 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2024-11-01T17:22:49.929Z,1730481769.929 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-11-01T17:22:49.930Z,1730481769.930 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 577 2024-11-01T17:22:49.961Z,1730481769.961 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2024-11-01T17:22:49.962Z,1730481769.962 [WetLabsBB2FL](INFO): Powering down 2024-11-01T17:22:49.962Z,1730481769.962 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-11-01T17:22:49.969Z,1730481769.969 [ComponentRegistry](INFO): Shutting down TrnDataBridge ThreadHandler 2024-11-01T17:22:49.969Z,1730481769.969 [TrnDataBridge ThreadHandler](INFO): Thread cancelled. 2024-11-01T17:22:49.970Z,1730481769.970 [TrnDataBridge](INFO): Join timeout helper Thread ID is 578 2024-11-01T17:22:50.374Z,1730481770.374 [TrnDataBridge ThreadHandler](INFO): Uninitializing protected caller thread. 2024-11-01T17:22:50.374Z,1730481770.374 [TrnDataBridge ThreadHandler](INFO): Thread cancelled. 2024-11-01T17:22:50.377Z,1730481770.377 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2024-11-01T17:22:50.377Z,1730481770.377 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-11-01T17:22:50.377Z,1730481770.377 [Radio_Surface](INFO): Join timeout helper Thread ID is 579 2024-11-01T17:22:50.434Z,1730481770.434 [NAL9602](INFO): Not Powering down - fast GPS 2024-11-01T17:22:50.629Z,1730481770.629 [Radio_Surface](INFO): Powering down 2024-11-01T17:22:50.630Z,1730481770.630 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2024-11-01T17:22:50.630Z,1730481770.630 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-11-01T17:22:50.633Z,1730481770.633 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2024-11-01T17:22:50.633Z,1730481770.633 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-11-01T17:22:50.633Z,1730481770.633 [Onboard](INFO): Join timeout helper Thread ID is 580 2024-11-01T17:22:54.441Z,1730481774.441 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2024-11-01T17:22:54.441Z,1730481774.441 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-11-01T17:22:54.458Z,1730481774.458 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2024-11-01T17:22:54.458Z,1730481774.458 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-11-01T17:22:54.459Z,1730481774.459 [DataOverHttps](INFO): Join timeout helper Thread ID is 581 2024-11-01T17:22:54.989Z,1730481774.989 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2024-11-01T17:22:54.992Z,1730481774.992 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-11-01T17:22:55.006Z,1730481775.006 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler 2024-11-01T17:22:55.006Z,1730481775.006 [DAT ThreadHandler](INFO): Thread cancelled. 2024-11-01T17:22:55.006Z,1730481775.006 [DAT](INFO): Join timeout helper Thread ID is 582 2024-11-01T17:22:55.025Z,1730481775.025 [DAT](INFO): Powering down 2024-11-01T17:22:55.098Z,1730481775.098 [DAT ThreadHandler](INFO): Uninitializing protected caller thread. 2024-11-01T17:22:55.098Z,1730481775.098 [DAT](INFO): Powering down 2024-11-01T17:22:55.099Z,1730481775.099 [DAT ThreadHandler](INFO): Thread cancelled. 2024-11-01T17:22:55.106Z,1730481775.106 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2024-11-01T17:22:55.106Z,1730481775.106 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-11-01T17:22:55.106Z,1730481775.106 [BackseatComponent](INFO): Join timeout helper Thread ID is 583 2024-11-01T17:22:55.282Z,1730481775.282 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2024-11-01T17:22:55.282Z,1730481775.282 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-11-01T17:22:55.294Z,1730481775.294 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2024-11-01T17:22:55.294Z,1730481775.294 [logger ThreadHandler](INFO): Thread cancelled. 2024-11-01T17:22:55.294Z,1730481775.294 [logger](INFO): Join timeout helper Thread ID is 584 2024-11-01T17:22:55.295Z,1730481775.295 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2024-11-01T17:22:55.295Z,1730481775.295 [logger ThreadHandler](INFO): Thread cancelled. 2024-11-01T17:22:55.296Z,1730481775.296 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2024-11-01T17:22:55.296Z,1730481775.296 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-11-01T17:22:55.297Z,1730481775.297 [CommandLine](INFO): Join timeout helper Thread ID is 585 2024-11-01T17:22:55.381Z,1730481775.381 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2024-11-01T17:22:55.382Z,1730481775.382 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-11-01T17:22:55.402Z,1730481775.402 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2024-11-01T17:22:55.402Z,1730481775.402 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-11-01T17:22:55.402Z,1730481775.402 [CommandExec](INFO): Join timeout helper Thread ID is 586 2024-11-01T17:22:55.403Z,1730481775.403 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2024-11-01T17:22:55.403Z,1730481775.403 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-11-01T17:22:55.404Z,1730481775.404 [controlThread](INFO): Join timeout helper Thread ID is 587 2024-11-01T17:22:55.661Z,1730481775.661 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2024-11-01T17:22:55.661Z,1730481775.661 [controlThread](DEBUG): Uninitializing ControlThread 2024-11-01T17:22:55.662Z,1730481775.662 [AHRS_M2](INFO): Powering down 2024-11-01T17:22:55.734Z,1730481775.734 [NAL9602](INFO): Powering down 2024-11-01T17:22:55.805Z,1730481775.805 [RDI_Pathfinder](INFO): Powering down 2024-11-01T17:22:55.806Z,1730481775.806 [Sonardyne_Nano](INFO): Powering down 2024-11-01T17:22:55.926Z,1730481775.926 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2024-11-01T17:22:55.927Z,1730481775.927 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2024-11-01T17:22:55.927Z,1730481775.927 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2024-11-01T17:22:55.928Z,1730481775.928 [MissionManager](INFO): Uninitializing Mission Default 2024-11-01T17:22:55.928Z,1730481775.928 [Default] Stopped 2024-11-01T17:22:55.928Z,1730481775.928 [Default](DEBUG): Aggregate::uninitialize Default 2024-11-01T17:22:55.928Z,1730481775.928 [Default:B.GoToSurface] Stopped 2024-11-01T17:22:55.928Z,1730481775.928 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2024-11-01T17:22:55.928Z,1730481775.928 [Default:CheckIn] Stopped 2024-11-01T17:22:55.928Z,1730481775.928 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-11-01T17:22:55.928Z,1730481775.928 [Default:CheckIn:Read_Iridium] Stopped 2024-11-01T17:22:55.931Z,1730481775.931 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2024-11-01T17:22:55.931Z,1730481775.931 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2024-11-01T17:22:55.932Z,1730481775.932 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2024-11-01T17:22:55.932Z,1730481775.932 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2024-11-01T17:22:55.932Z,1730481775.932 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2024-11-01T17:22:55.932Z,1730481775.932 [BuoyancyServo](INFO): Powering down 2024-11-01T17:22:55.945Z,1730481775.945 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2024-11-01T17:22:55.945Z,1730481775.945 [ElevatorServo](INFO): Powering down 2024-11-01T17:22:55.946Z,1730481775.946 [DockingStepper](DEBUG): Uninitialize Docking Stepper. 2024-11-01T17:22:55.946Z,1730481775.946 [DockingStepper](INFO): Powering down 2024-11-01T17:22:55.947Z,1730481775.947 [MassServo](DEBUG): Uninitialize Mass Servo. 2024-11-01T17:22:55.947Z,1730481775.947 [MassServo](INFO): Powering down 2024-11-01T17:22:55.948Z,1730481775.948 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2024-11-01T17:22:55.948Z,1730481775.948 [RudderServo](INFO): Powering down 2024-11-01T17:22:55.949Z,1730481775.949 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2024-11-01T17:22:55.949Z,1730481775.949 [ThrusterServo](INFO): Powering down 2024-11-01T17:22:55.950Z,1730481775.950 [SBIT](DEBUG): Uninitialize SBIT Component. 2024-11-01T17:22:55.950Z,1730481775.950 [IBIT](DEBUG): Uninitialize IBIT Component. 2024-11-01T17:22:55.950Z,1730481775.950 [CBIT](DEBUG): Uninitialize CBIT Component. 2024-11-01T17:22:55.950Z,1730481775.950 [CBIT](DEBUG): Powering off loads. 2024-11-01T17:22:55.961Z,1730481775.961 [CBIT](DEBUG): Disabling WDT. 2024-11-01T17:22:55.973Z,1730481775.973 [CBIT](DEBUG): Opening all GF detection circuits. 2024-11-01T17:22:55.974Z,1730481775.974 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-11-01T17:22:56.035Z,1730481776.035 [TrnDataBridge ThreadHandler](INFO): Thread cancelled. 2024-11-01T17:22:56.044Z,1730481776.044 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-11-01T17:22:56.046Z,1730481776.046 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-11-01T17:22:56.052Z,1730481776.052 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-11-01T17:22:56.058Z,1730481776.058 [DAT ThreadHandler](INFO): Thread cancelled. 2024-11-01T17:22:56.098Z,1730481776.098 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-11-01T17:22:56.278Z,1730481776.278 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-11-01T17:22:56.288Z,1730481776.288 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-11-01T17:22:56.353Z,1730481776.353 [logger ThreadHandler](INFO): Thread cancelled.