2024-05-15T21:15:45.928Z,1715807745.928 [Supervisor](DEBUG): Initializing supervisor. 2024-05-15T21:15:45.932Z,1715807745.932 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2024-05-15T21:15:45.933Z,1715807745.933 [SyncHandler](INFO): Protected caller Thread ID is 841 2024-05-15T21:15:45.933Z,1715807745.933 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2024-05-15T21:15:45.934Z,1715807745.934 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2024-05-15T21:15:45.935Z,1715807745.935 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 842 2024-05-15T21:15:45.938Z,1715807745.938 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2024-05-15T21:15:45.956Z,1715807745.956 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2024-05-15T21:15:45.957Z,1715807745.957 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2024-05-15T21:15:45.957Z,1715807745.957 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 843 2024-05-15T21:15:45.961Z,1715807745.961 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2024-05-15T21:15:45.962Z,1715807745.962 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2024-05-15T21:15:45.962Z,1715807745.962 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 844 2024-05-15T21:15:45.965Z,1715807745.965 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2024-05-15T21:15:45.965Z,1715807745.965 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2024-05-15T21:15:45.966Z,1715807745.966 [logger ThreadHandler](INFO): Protected caller Thread ID is 845 2024-05-15T21:15:45.969Z,1715807745.969 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2024-05-15T21:15:45.970Z,1715807745.970 [Supervisor](INFO): Looking for Config files in directory: Config/ 2024-05-15T21:15:45.974Z,1715807745.974 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2024-05-15T21:15:46.081Z,1715807746.081 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2024-05-15T21:15:46.083Z,1715807746.083 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2024-05-15T21:15:46.853Z,1715807746.853 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2024-05-15T21:15:46.855Z,1715807746.855 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2024-05-15T21:15:47.098Z,1715807747.098 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2024-05-15T21:15:47.100Z,1715807747.100 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2024-05-15T21:15:47.193Z,1715807747.193 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2024-05-15T21:15:47.340Z,1715807747.340 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2024-05-15T21:15:47.342Z,1715807747.342 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2024-05-15T21:15:47.434Z,1715807747.434 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2024-05-15T21:15:47.553Z,1715807747.553 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2024-05-15T21:15:47.554Z,1715807747.554 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2024-05-15T21:15:47.961Z,1715807747.961 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2024-05-15T21:15:47.963Z,1715807747.963 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2024-05-15T21:15:48.512Z,1715807748.512 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2024-05-15T21:15:48.513Z,1715807748.513 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2024-05-15T21:15:48.744Z,1715807748.744 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2024-05-15T21:15:48.745Z,1715807748.745 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2024-05-15T21:15:48.943Z,1715807748.943 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2024-05-15T21:15:48.944Z,1715807748.944 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2024-05-15T21:15:49.495Z,1715807749.495 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2024-05-15T21:15:49.872Z,1715807749.872 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2024-05-15T21:15:50.388Z,1715807750.388 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2024-05-15T21:15:50.390Z,1715807750.390 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2024-05-15T21:15:50.631Z,1715807750.631 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2024-05-15T21:15:50.633Z,1715807750.633 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2024-05-15T21:15:51.022Z,1715807751.022 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2024-05-15T21:15:51.023Z,1715807751.023 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2024-05-15T21:15:51.385Z,1715807751.385 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2024-05-15T21:15:51.387Z,1715807751.387 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-pontus/ 2024-05-15T21:15:51.389Z,1715807751.389 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/secure.cfg 2024-05-15T21:15:51.485Z,1715807751.485 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Sensor.cfg 2024-05-15T21:15:51.660Z,1715807751.660 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Servo.cfg 2024-05-15T21:15:51.779Z,1715807751.779 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Simulator.cfg 2024-05-15T21:15:51.876Z,1715807751.876 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/logger.cfg 2024-05-15T21:15:51.982Z,1715807751.982 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/vehicle.cfg 2024-05-15T21:15:52.107Z,1715807752.107 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Battery.cfg 2024-05-15T21:15:52.378Z,1715807752.378 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2024-05-15T21:15:52.380Z,1715807752.380 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Navigation.cfg 2024-05-15T21:15:52.500Z,1715807752.500 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/BIT.cfg 2024-05-15T21:15:52.604Z,1715807752.604 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Science.cfg 2024-05-15T21:15:52.757Z,1715807752.757 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Control.cfg 2024-05-15T21:15:52.867Z,1715807752.867 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg 2024-05-15T21:15:52.886Z,1715807752.886 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2024-05-15T21:15:53.027Z,1715807753.027 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2024-05-15T21:15:53.029Z,1715807753.029 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2024-05-15T21:15:53.099Z,1715807753.099 [VerticalControl](DEBUG): Construct VerticalControl. 2024-05-15T21:15:53.158Z,1715807753.158 [VerticalControl] Loaded 2024-05-15T21:15:53.158Z,1715807753.158 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2024-05-15T21:15:53.161Z,1715807753.161 [HorizontalControl](DEBUG): Construct HorizontalControl. 2024-05-15T21:15:53.208Z,1715807753.208 [HorizontalControl] Loaded 2024-05-15T21:15:53.208Z,1715807753.208 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2024-05-15T21:15:53.210Z,1715807753.210 [SpeedControl](DEBUG): Construct SpeedControl. 2024-05-15T21:15:53.213Z,1715807753.213 [SpeedControl] Loaded 2024-05-15T21:15:53.214Z,1715807753.214 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2024-05-15T21:15:53.216Z,1715807753.216 [LoopControl](DEBUG): Construct LoopControl. 2024-05-15T21:15:53.217Z,1715807753.217 [LoopControl] Loaded 2024-05-15T21:15:53.217Z,1715807753.217 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2024-05-15T21:15:53.217Z,1715807753.217 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2024-05-15T21:15:53.219Z,1715807753.219 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2024-05-15T21:15:53.288Z,1715807753.288 [DepthRateCalculator] Loaded 2024-05-15T21:15:53.288Z,1715807753.288 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2024-05-15T21:15:53.293Z,1715807753.293 [PitchRateCalculator] Loaded 2024-05-15T21:15:53.293Z,1715807753.293 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2024-05-15T21:15:53.303Z,1715807753.303 [SpeedCalculator] Loaded 2024-05-15T21:15:53.303Z,1715807753.303 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2024-05-15T21:15:53.307Z,1715807753.307 [YawRateCalculator] Loaded 2024-05-15T21:15:53.307Z,1715807753.307 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2024-05-15T21:15:53.326Z,1715807753.326 [ElevatorOffsetCalculator] Loaded 2024-05-15T21:15:53.326Z,1715807753.326 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2024-05-15T21:15:53.326Z,1715807753.326 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2024-05-15T21:15:53.327Z,1715807753.327 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2024-05-15T21:15:53.369Z,1715807753.369 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2024-05-15T21:15:53.370Z,1715807753.370 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2024-05-15T21:15:53.452Z,1715807753.452 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2024-05-15T21:15:53.452Z,1715807753.452 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2024-05-15T21:15:53.848Z,1715807753.848 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2024-05-15T21:15:53.848Z,1715807753.848 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2024-05-15T21:15:54.057Z,1715807754.057 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2024-05-15T21:15:54.058Z,1715807754.058 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2024-05-15T21:15:55.325Z,1715807755.325 [AHRS_M2] Loaded 2024-05-15T21:15:55.326Z,1715807755.326 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2024-05-15T21:15:55.581Z,1715807755.581 [BackseatComponent] Loaded 2024-05-15T21:15:55.582Z,1715807755.582 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2024-05-15T21:15:55.583Z,1715807755.583 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 409C24E0 2024-05-15T21:15:55.583Z,1715807755.583 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 927 2024-05-15T21:15:55.586Z,1715807755.586 [LcmUniversalReporter] Loaded 2024-05-15T21:15:55.586Z,1715807755.586 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread. 2024-05-15T21:15:56.378Z,1715807756.378 [BPC1] Loaded 2024-05-15T21:15:56.378Z,1715807756.378 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2024-05-15T21:15:56.517Z,1715807756.517 [DataOverHttps] Loaded 2024-05-15T21:15:56.517Z,1715807756.517 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2024-05-15T21:15:56.518Z,1715807756.518 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 409F24E0 2024-05-15T21:15:56.519Z,1715807756.519 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 928 2024-05-15T21:15:56.541Z,1715807756.541 [Depth_Keller] Loaded 2024-05-15T21:15:56.541Z,1715807756.541 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2024-05-15T21:15:56.604Z,1715807756.604 [NAL9602] Loaded 2024-05-15T21:15:56.605Z,1715807756.605 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2024-05-15T21:15:56.634Z,1715807756.634 [Onboard] Loaded 2024-05-15T21:15:56.634Z,1715807756.634 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2024-05-15T21:15:56.635Z,1715807756.635 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 40A224E0 2024-05-15T21:15:56.635Z,1715807756.635 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 929 2024-05-15T21:15:56.649Z,1715807756.649 [Power24vConverter] Loaded 2024-05-15T21:15:56.649Z,1715807756.649 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2024-05-15T21:15:56.664Z,1715807756.664 [Radio_Surface] Loaded 2024-05-15T21:15:56.664Z,1715807756.664 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2024-05-15T21:15:56.665Z,1715807756.665 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 40A524E0 2024-05-15T21:15:56.665Z,1715807756.665 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 930 2024-05-15T21:15:56.713Z,1715807756.713 [RDI_Pathfinder] Loaded 2024-05-15T21:15:56.713Z,1715807756.713 [ComponentRegistry](DEBUG): SyncComponent "RDI_Pathfinder" handled in the control thread. 2024-05-15T21:15:56.806Z,1715807756.806 [DAT] Loaded 2024-05-15T21:15:56.806Z,1715807756.806 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread. 2024-05-15T21:15:56.807Z,1715807756.807 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 40A824E0 2024-05-15T21:15:56.807Z,1715807756.807 [DAT ThreadHandler](INFO): Protected caller Thread ID is 931 2024-05-15T21:15:56.808Z,1715807756.808 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2024-05-15T21:15:56.809Z,1715807756.809 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2024-05-15T21:15:56.943Z,1715807756.943 [DeadReckonUsingMultipleVelocitySources] Loaded 2024-05-15T21:15:56.943Z,1715807756.943 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2024-05-15T21:15:56.957Z,1715807756.957 [NavChart] Loaded 2024-05-15T21:15:56.957Z,1715807756.957 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2024-05-15T21:15:56.963Z,1715807756.963 [UniversalFixResidualReporter] Loaded 2024-05-15T21:15:56.963Z,1715807756.963 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2024-05-15T21:15:56.963Z,1715807756.963 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2024-05-15T21:15:56.964Z,1715807756.964 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2024-05-15T21:15:57.134Z,1715807757.134 [SBIT](DEBUG): Construct Startup Built In Test. 2024-05-15T21:15:57.144Z,1715807757.144 [SBIT] Loaded 2024-05-15T21:15:57.144Z,1715807757.144 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2024-05-15T21:15:57.147Z,1715807757.147 [IBIT](DEBUG): Construct Initiated Built In Test. 2024-05-15T21:15:57.159Z,1715807757.159 [IBIT] Loaded 2024-05-15T21:15:57.159Z,1715807757.159 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2024-05-15T21:15:57.165Z,1715807757.165 [CBIT](DEBUG): Construct Continuous Built In Test. 2024-05-15T21:15:57.269Z,1715807757.269 [CBIT] Loaded 2024-05-15T21:15:57.269Z,1715807757.269 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2024-05-15T21:15:57.270Z,1715807757.270 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2024-05-15T21:15:57.270Z,1715807757.270 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2024-05-15T21:15:57.431Z,1715807757.431 [BuoyancyServo] Loaded 2024-05-15T21:15:57.431Z,1715807757.431 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2024-05-15T21:15:57.454Z,1715807757.454 [ElevatorServo] Loaded 2024-05-15T21:15:57.454Z,1715807757.454 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2024-05-15T21:15:57.483Z,1715807757.483 [DockingStepper] Loaded 2024-05-15T21:15:57.483Z,1715807757.483 [ComponentRegistry](DEBUG): SyncComponent "DockingStepper" handled in the control thread. 2024-05-15T21:15:57.505Z,1715807757.505 [MassServo] Loaded 2024-05-15T21:15:57.505Z,1715807757.505 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2024-05-15T21:15:57.526Z,1715807757.526 [RudderServo] Loaded 2024-05-15T21:15:57.526Z,1715807757.526 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2024-05-15T21:15:57.545Z,1715807757.545 [ThrusterServo] Loaded 2024-05-15T21:15:57.545Z,1715807757.545 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread. 2024-05-15T21:15:57.546Z,1715807757.546 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2024-05-15T21:15:57.546Z,1715807757.546 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2024-05-15T21:15:57.562Z,1715807757.562 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2024-05-15T21:15:57.562Z,1715807757.562 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2024-05-15T21:15:57.783Z,1715807757.783 [CTD_Seabird] Loaded 2024-05-15T21:15:57.784Z,1715807757.784 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2024-05-15T21:15:57.785Z,1715807757.785 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40BD64E0 2024-05-15T21:15:57.785Z,1715807757.785 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 932 2024-05-15T21:15:57.820Z,1715807757.820 [ESPComponent] Loaded 2024-05-15T21:15:57.821Z,1715807757.821 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread. 2024-05-15T21:15:57.843Z,1715807757.843 [PAR_Licor] Loaded 2024-05-15T21:15:57.843Z,1715807757.843 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2024-05-15T21:15:57.887Z,1715807757.887 [WetLabsBB2FL] Loaded 2024-05-15T21:15:57.887Z,1715807757.887 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2024-05-15T21:15:57.888Z,1715807757.888 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40C064E0 2024-05-15T21:15:57.889Z,1715807757.889 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 933 2024-05-15T21:15:57.909Z,1715807757.909 [WetLabsUBAT] Loaded 2024-05-15T21:15:57.910Z,1715807757.910 [ComponentRegistry](DEBUG): Component "WetLabsUBAT" handled in its own thread. 2024-05-15T21:15:57.911Z,1715807757.911 [WetLabsUBAT ThreadHandler](DEBUG): Created PCaller Thread at 40C364E0 2024-05-15T21:15:57.911Z,1715807757.911 [WetLabsUBAT ThreadHandler](INFO): Protected caller Thread ID is 934 2024-05-15T21:15:57.912Z,1715807757.912 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2024-05-15T21:15:57.918Z,1715807757.918 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2024-05-15T21:15:57.921Z,1715807757.921 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2024-05-15T21:15:57.932Z,1715807757.932 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2024-05-15T21:15:57.933Z,1715807757.933 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C664E0 2024-05-15T21:15:57.933Z,1715807757.933 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 935 2024-05-15T21:15:57.937Z,1715807757.937 [Supervisor](INFO): Main Thread ID is 832 2024-05-15T21:15:57.937Z,1715807757.937 [Supervisor](DEBUG): Running supervisor. 2024-05-15T21:15:57.938Z,1715807757.938 [CommandExec ThreadHandler](INFO): Handler Thread ID is 936 2024-05-15T21:15:57.939Z,1715807757.939 [CommandExec](INFO): Initializing the command executive. 2024-05-15T21:15:57.940Z,1715807757.940 [CommandLine ThreadHandler](INFO): Handler Thread ID is 937 2024-05-15T21:15:57.942Z,1715807757.942 [controlThread ThreadHandler](INFO): Handler Thread ID is 938 2024-05-15T21:15:57.942Z,1715807757.942 [controlThread](DEBUG): Initializing ControlThread 2024-05-15T21:15:57.943Z,1715807757.943 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2024-05-15T21:15:57.945Z,1715807757.945 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2024-05-15T21:15:57.946Z,1715807757.946 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2024-05-15T21:15:57.946Z,1715807757.946 [LoopControl](DEBUG): Initialize LoopControlComponent. 2024-05-15T21:15:57.946Z,1715807757.946 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2024-05-15T21:15:57.947Z,1715807757.947 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2024-05-15T21:15:57.947Z,1715807757.947 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2024-05-15T21:15:57.947Z,1715807757.947 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2024-05-15T21:15:57.948Z,1715807757.948 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2024-05-15T21:15:57.953Z,1715807757.953 [NavChart](DEBUG): Initialize NavChart Navigation. 2024-05-15T21:15:57.954Z,1715807757.954 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2024-05-15T21:15:57.954Z,1715807757.954 [SBIT](INFO): Initialize SBIT Component. 2024-05-15T21:15:57.954Z,1715807757.954 [SBIT](IMPORTANT): git: 2024-04-25-8-gd038f3ad8 2024-05-15T21:15:57.955Z,1715807757.955 [SBIT](INFO): git hash: d038f3ad8d1c28abd1f1c526114d3be7769b8b67 2024-05-15T21:15:57.955Z,1715807757.955 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2024-05-15T21:15:57.956Z,1715807757.956 [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-05-15T21:15:57.957Z,1715807757.957 [SBIT](INFO): Beginning SBIT in 99.000000 seconds. 2024-05-15T21:15:57.958Z,1715807757.958 [IBIT](INFO): Initialize IBIT Component. 2024-05-15T21:15:57.958Z,1715807757.958 [CBIT](DEBUG): Initialize CBIT Component. 2024-05-15T21:15:57.959Z,1715807757.959 [logger ThreadHandler](INFO): Handler Thread ID is 939 2024-05-15T21:15:57.972Z,1715807757.972 [CBIT](DEBUG): Initialized mux pins. 2024-05-15T21:15:57.972Z,1715807757.972 [CBIT](DEBUG): Initializing the watchdog timer. 2024-05-15T21:15:57.976Z,1715807757.976 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 940 2024-05-15T21:15:57.985Z,1715807757.985 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 941 2024-05-15T21:15:57.986Z,1715807757.986 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2024-05-15T21:15:57.992Z,1715807757.992 [Onboard ThreadHandler](INFO): Handler Thread ID is 942 2024-05-15T21:15:57.997Z,1715807757.997 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2024-05-15T21:15:57.997Z,1715807757.997 [CBIT](DEBUG): Initializing heartbeat. 2024-05-15T21:15:58.016Z,1715807758.016 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 943 2024-05-15T21:15:58.032Z,1715807758.032 [DAT ThreadHandler](INFO): Handler Thread ID is 944 2024-05-15T21:15:58.033Z,1715807758.033 [DAT](INFO): Powering up 2024-05-15T21:15:58.033Z,1715807758.033 [DAT](DEBUG): Initializing DAT. 2024-05-15T21:15:58.037Z,1715807758.037 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 946 2024-05-15T21:15:58.038Z,1715807758.038 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2024-05-15T21:15:58.042Z,1715807758.042 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 948 2024-05-15T21:15:58.044Z,1715807758.044 [WetLabsBB2FL](INFO): Powering up 2024-05-15T21:15:58.046Z,1715807758.046 [WetLabsUBAT ThreadHandler](INFO): Handler Thread ID is 950 2024-05-15T21:15:58.049Z,1715807758.049 [WetLabsUBAT](INFO): Powering up 2024-05-15T21:15:58.050Z,1715807758.050 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 952 2024-05-15T21:15:58.058Z,1715807758.058 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2024-05-15T21:15:58.059Z,1715807758.059 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2024-05-15T21:15:58.059Z,1715807758.059 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2024-05-15T21:15:58.059Z,1715807758.059 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2024-05-15T21:15:58.059Z,1715807758.059 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2024-05-15T21:15:58.059Z,1715807758.059 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2024-05-15T21:15:58.059Z,1715807758.059 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2024-05-15T21:15:58.060Z,1715807758.060 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2024-05-15T21:15:58.068Z,1715807758.068 [CBIT](DEBUG): Deactivating GF circuits. 2024-05-15T21:15:58.068Z,1715807758.068 [CBIT](DEBUG): Deactivating emergency mode. 2024-05-15T21:15:58.108Z,1715807758.108 [CBIT](DEBUG): Backplane powered. 2024-05-15T21:15:58.113Z,1715807758.113 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser 2024-05-15T21:15:58.113Z,1715807758.113 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl 2024-05-15T21:15:58.114Z,1715807758.114 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl 2024-05-15T21:15:58.129Z,1715807758.129 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl 2024-05-15T21:15:58.179Z,1715807758.179 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into: 2024-05-15T21:15:58.184Z,1715807758.184 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2024-05-15T21:15:58.228Z,1715807758.228 [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-15T21:15:58.229Z,1715807758.229 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl 2024-05-15T21:15:58.229Z,1715807758.229 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl 2024-05-15T21:15:58.232Z,1715807758.232 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl 2024-05-15T21:15:58.420Z,1715807758.420 [Radio_Surface](INFO): Powering up 2024-05-15T21:15:58.528Z,1715807758.528 [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-15T21:15:58.550Z,1715807758.550 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2024-05-15T21:15:58.551Z,1715807758.551 [Default:A.Wait](DEBUG): Construct Wait. 2024-05-15T21:15:58.553Z,1715807758.553 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2024-05-15T21:15:58.594Z,1715807758.594 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2024-05-15T21:15:58.596Z,1715807758.596 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2024-05-15T21:15:58.618Z,1715807758.618 [Default:E.Execute](DEBUG): Construct Execute. 2024-05-15T21:15:58.621Z,1715807758.621 [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-15T21:15:58.640Z,1715807758.640 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,NAL9602,Power24vConverter,RDI_Pathfinder,ESPComponent,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-05-15T21:15:58.646Z,1715807758.646 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2024-05-15T21:15:58.818Z,1715807758.818 [Depth_Keller](ERROR): Pressure or depth reading out of range: -1.000394 decibar, -0.993016 m 2024-05-15T21:15:58.818Z,1715807758.818 [Power24vConverter](INFO): Powering up. 2024-05-15T21:15:58.819Z,1715807758.819 [RDI_Pathfinder](IMPORTANT): Expecting PD13 message format 2024-05-15T21:15:58.880Z,1715807758.880 [DepthRateCalculator](ERROR): Depth measurement is not active 2024-05-15T21:15:58.905Z,1715807758.905 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2024-05-15T21:15:58.912Z,1715807758.912 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2024-05-15T21:15:58.913Z,1715807758.913 [ElevatorServo](DEBUG): Initializing EZServoServo. 2024-05-15T21:15:58.920Z,1715807758.920 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2024-05-15T21:15:58.921Z,1715807758.921 [DockingStepper](INFO): Start 2024-05-15T21:15:58.921Z,1715807758.921 [DockingStepper](DEBUG): Initializing EZServoServo. 2024-05-15T21:15:58.928Z,1715807758.928 [DockingStepper](DEBUG): Initializing DockingStepper. 2024-05-15T21:15:58.929Z,1715807758.929 [MassServo](DEBUG): Initializing EZServoServo. 2024-05-15T21:15:58.936Z,1715807758.936 [MassServo](DEBUG): Initializing MassServo. 2024-05-15T21:15:58.937Z,1715807758.937 [RudderServo](DEBUG): Initializing EZServoServo. 2024-05-15T21:15:58.944Z,1715807758.944 [RudderServo](DEBUG): Initializing RudderServo. 2024-05-15T21:15:58.945Z,1715807758.945 [ThrusterServo](DEBUG): Initializing EZServoServo. 2024-05-15T21:15:58.952Z,1715807758.952 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2024-05-15T21:15:59.116Z,1715807759.116 [DockingStepper](INFO): Starting 2024-05-15T21:15:59.476Z,1715807759.476 [DockingStepper](INFO): Starting 2024-05-15T21:16:00.000Z,1715807760.000 [DockingStepper](INFO): Starting 2024-05-15T21:16:00.049Z,1715807760.049 [DockingStepper](INFO): Init string: /1z14959aE13561N3m50 2024-05-15T21:16:00.284Z,1715807760.284 [DockingStepper](INFO): Starting 2024-05-15T21:16:00.656Z,1715807760.656 [WetLabsBB2FL](INFO): Powering down 2024-05-15T21:16:00.687Z,1715807760.687 [DockingStepper](INFO): Starting 2024-05-15T21:16:01.091Z,1715807761.091 [DockingStepper](INFO): Starting 2024-05-15T21:16:01.544Z,1715807761.544 [DockingStepper](INFO): Starting 2024-05-15T21:16:01.569Z,1715807761.569 [DockingStepper](INFO): Sent speed cmd:/1V10000 Response:ÿ/0@ 2024-05-15T21:16:02.004Z,1715807762.004 [DockingStepper](INFO): Starting 2024-05-15T21:16:02.748Z,1715807762.748 [DockingStepper](INFO): Pause 2024-05-15T21:16:05.072Z,1715807765.072 [CTD_Seabird](ERROR): Device message queue exceeded the allowed limit. 2024-05-15T21:16:07.348Z,1715807767.348 [WetLabsUBAT](INFO): Powering down 2024-05-15T21:16:11.645Z,1715807771.645 [DAT](INFO): DAT read: 2024-05-15T21:16:11.647Z,1715807771.647 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series 2024-05-15T21:16:13.157Z,1715807773.157 [DAT](INFO): DAT read: MF Frequency Band 2024-05-15T21:16:13.158Z,1715807773.158 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.17.2 2024-05-15T21:16:13.159Z,1715807773.159 [DAT](INFO): DAT read: May 15 2024 21:15:10 2024-05-15T21:16:14.419Z,1715807774.419 [DAT](INFO): DAT read: Features enabled [Bearing] 2024-05-15T21:16:14.423Z,1715807774.423 [DAT](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP 2024-05-15T21:16:14.424Z,1715807774.424 [DAT](INFO): commRate: 800 2024-05-15T21:16:16.489Z,1715807776.489 [DAT](INFO): entering command mode 2024-05-15T21:16:16.685Z,1715807776.685 [DAT](INFO): DAT read: 2024-05-15T21:16:16.685Z,1715807776.685 [DAT](INFO): DAT read: user:1> 2024-05-15T21:16:16.685Z,1715807776.685 [DAT](INFO): setting verbose to 3 2024-05-15T21:16:16.937Z,1715807776.937 [DAT](INFO): DAT read: user:1> 2024-05-15T21:16:16.938Z,1715807776.938 [DAT](INFO): DAT read: Verbose | 3 2024-05-15T21:16:16.939Z,1715807776.939 [DAT](INFO): set verbose to 3 2024-05-15T21:16:16.939Z,1715807776.939 [DAT](INFO): setting DatVerbose to 27440 2024-05-15T21:16:17.189Z,1715807777.189 [DAT](INFO): DAT read: user:2> 2024-05-15T21:16:17.190Z,1715807777.190 [DAT](INFO): DAT read: DatVerbose | 27440 2024-05-15T21:16:17.190Z,1715807777.190 [DAT](INFO): set DatVerbose to 27440 2024-05-15T21:16:17.190Z,1715807777.190 [DAT](INFO): setting transmit power to 8 2024-05-15T21:16:17.441Z,1715807777.441 [DAT](INFO): DAT read: user:3> 2024-05-15T21:16:17.442Z,1715807777.442 [DAT](INFO): DAT read: TxPower | 8 (Max) 2024-05-15T21:16:17.442Z,1715807777.442 [DAT](INFO): set transmit power to 8 2024-05-15T21:16:17.442Z,1715807777.442 [DAT](INFO): setting local address to 10 2024-05-15T21:16:17.693Z,1715807777.693 [DAT](INFO): DAT read: user:4> 2024-05-15T21:16:17.694Z,1715807777.694 [DAT](INFO): DAT read: LocalAddr | 10 2024-05-15T21:16:17.694Z,1715807777.694 [DAT](INFO): set local address to 10 2024-05-15T21:16:17.701Z,1715807777.701 [DAT](INFO): Setting time to: 21:16:17 And date to:5/15/2024 2024-05-15T21:16:17.945Z,1715807777.945 [DAT](INFO): DAT read: user:5> 2024-05-15T21:16:17.946Z,1715807777.946 [DAT](INFO): DAT read: Wed May 15, 2024 21:16:17 2024-05-15T21:16:17.946Z,1715807777.946 [DAT](INFO): Local DAT time set to Wed May 15, 2024 21:16:17 2024-05-15T21:16:26.933Z,1715807786.933 [NAL9602](INFO): Powering up NAL9602 2024-05-15T21:16:30.792Z,1715807790.792 [MassServo](ERROR): getPosition uart error serial timeout 2024-05-15T21:16:30.792Z,1715807790.792 [MassServo](FAULT): Invalid EZ Servo response:"\r" 2024-05-15T21:16:30.793Z,1715807790.793 [MassServo] Communications Fault, FailCount= 1 2024-05-15T21:16:30.793Z,1715807790.793 [MassServo](ERROR): Communications Fault 2024-05-15T21:16:30.797Z,1715807790.797 [CBIT](ERROR): Communications Fault in component: MassServo 2024-05-15T21:16:31.009Z,1715807791.009 [MassServo](DEBUG): Uninitialize Mass Servo. 2024-05-15T21:16:31.010Z,1715807791.010 [MassServo](INFO): Powering down 2024-05-15T21:16:31.826Z,1715807791.826 [MassServo](DEBUG): Initializing EZServoServo. 2024-05-15T21:16:31.945Z,1715807791.945 [MassServo](DEBUG): Initializing MassServo. 2024-05-15T21:16:31.949Z,1715807791.949 [CBIT](INFO): Clearing failed state for component MassServo 2024-05-15T21:16:31.950Z,1715807791.950 [MassServo] No Fault, FailCount= 1 2024-05-15T21:16:37.841Z,1715807797.841 [NAL9602](INFO): NAL9602 initialized 2024-05-15T21:17:37.665Z,1715807857.665 [SBIT](IMPORTANT): Beginning Startup BIT 2024-05-15T21:17:37.669Z,1715807857.669 [CBIT](IMPORTANT): Beginning ground fault scan 2024-05-15T21:17:48.631Z,1715807868.631 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): -0.007801 CHAN A1 (24V): 0.003983 CHAN A2 (12V): -0.006065 CHAN A3 (5V): -0.001001 CHAN B0 (3.3V): 0.000741 CHAN B1 (3.15aV): 0.000351 CHAN B2 (3.15bV): 0.000543 CHAN B3 (GND): 0.000923 OPEN: -0.002528 Full Scale: +/- 1 mA 2024-05-15T21:18:32.108Z,1715807912.108 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004664 2024-05-15T21:18:32.703Z,1715807912.703 [SBIT](IMPORTANT): SBIT PASSED 2024-05-15T21:18:32.703Z,1715807912.703 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2024-05-15T21:18:32.704Z,1715807912.704 [SBIT](IMPORTANT): BPC1.batteryMissingStickThreshold=2 count; 2024-05-15T21:18:32.704Z,1715807912.704 [SBIT](IMPORTANT): DockingStepper.closedValue=16500 count; 2024-05-15T21:18:32.704Z,1715807912.704 [SBIT](IMPORTANT): DockingStepper.loadAtStartup=1 bool; 2024-05-15T21:18:32.704Z,1715807912.704 [SBIT](IMPORTANT): DockingStepper.openValue=7500 count; 2024-05-15T21:18:32.704Z,1715807912.704 [SBIT](IMPORTANT): DockingStepper.simulateHardware=0 bool; 2024-05-15T21:18:32.704Z,1715807912.704 [SBIT](IMPORTANT): DropWeight.loadAtStartup=0 bool; 2024-05-15T21:18:32.704Z,1715807912.704 [SBIT](IMPORTANT): ESPComponent.loadAtStartup=1 bool; 2024-05-15T21:18:32.704Z,1715807912.704 [SBIT](IMPORTANT): ESPComponent.sampleTimeout=2 minute; 2024-05-15T21:18:32.704Z,1715807912.704 [SBIT](IMPORTANT): ESPComponent.simulateHardware=1 bool; 2024-05-15T21:18:32.705Z,1715807912.705 [SBIT](IMPORTANT): Express linearApproximation WetLabsUBAT.flow_rate 0.300000 liter_per_second; 2024-05-15T21:18:32.705Z,1715807912.705 [SBIT](IMPORTANT): Express linearApproximation downwelling_photosynthetic_photon_flux_in_sea_water 100.000000 micromole_per_second_per_square_meter; 2024-05-15T21:18:32.705Z,1715807912.705 [SBIT](IMPORTANT): PowerOnly.loadAtStartup=0 bool; 2024-05-15T21:18:32.705Z,1715807912.705 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=700 cubic_centimeter; 2024-05-15T21:18:32.705Z,1715807912.705 [SBIT](IMPORTANT): VerticalControl.kpDepth=0.09 radian_per_meter; 2024-05-15T21:18:32.705Z,1715807912.705 [SBIT](IMPORTANT): VerticalControl.kpPitchElevator=0.5 none; 2024-05-15T21:18:32.705Z,1715807912.705 [SBIT](IMPORTANT): VerticalControl.massDefault=-19.999430 millimeter; 2024-05-15T21:18:32.706Z,1715807912.706 [SBIT](IMPORTANT): VerticalControl.stopDepthExcursion=20 meter; 2024-05-15T21:18:33.116Z,1715807913.116 [MissionManager](IMPORTANT): Started mission Startup 2024-05-15T21:18:33.116Z,1715807913.116 [Startup] Running Loop=1 2024-05-15T21:18:33.116Z,1715807913.116 [Startup](DEBUG): Aggregate::initialize Startup 2024-05-15T21:18:33.116Z,1715807913.116 [Startup:A.GoToSurface] Running Loop=1 2024-05-15T21:18:33.116Z,1715807913.116 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2024-05-15T21:18:33.117Z,1715807913.117 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2024-05-15T21:18:33.117Z,1715807913.117 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2024-05-15T21:18:33.118Z,1715807913.118 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2024-05-15T21:18:33.119Z,1715807913.119 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2024-05-15T21:18:33.119Z,1715807913.119 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2024-05-15T21:18:33.121Z,1715807913.121 [Startup:StartupSatComms] Running Loop=1 2024-05-15T21:18:33.121Z,1715807913.121 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2024-05-15T21:18:33.121Z,1715807913.121 [Startup:StartupSatComms:A] Running Loop=1 2024-05-15T21:18:33.543Z,1715807913.543 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2024-05-15T21:18:58.150Z,1715807938.150 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2024-05-15T21:18:58.150Z,1715807938.150 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-05-15T21:18:58.161Z,1715807938.161 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-05-15T21:18:58.566Z,1715807938.566 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-05-15T21:18:58.566Z,1715807938.566 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2024-05-15T21:19:08.295Z,1715807948.295 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-15T21:19:20.755Z,1715807960.755 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-15T21:19:33.429Z,1715807973.429 [Startup:StartupSatComms:A](INFO): Timed out from 2024-05-15T21:18:33.1Z 2024-05-15T21:19:33.429Z,1715807973.429 [Startup:StartupSatComms:A] Stopped 2024-05-15T21:19:33.429Z,1715807973.429 [Startup:StartupSatComms:B] Running Loop=1 2024-05-15T21:19:33.684Z,1715807973.684 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-15T21:19:33.701Z,1715807973.701 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2024-05-15T21:19:41.810Z,1715807981.810 [CommandExec](IMPORTANT): got command report mod Dock.dock_voltage_present 2024-05-15T21:19:41.939Z,1715807981.939 [Reporter](INFO): Dock.dock_voltage_present 0 bool 2024-05-15T21:19:42.055Z,1715807982.055 [DataOverHttps](INFO): Sending 195 bytes from file Logs/20240515T204421/Courier0000.lzma 2024-05-15T21:19:43.056Z,1715807983.056 [DataOverHttps](INFO): Moved sent file to Logs/20240515T204421/Courier0000.lzma.bak 2024-05-15T21:19:43.056Z,1715807983.056 [DataOverHttps](INFO): SBD MOMSN=21024008 2024-05-15T21:19:46.747Z,1715807986.747 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-15T21:19:59.675Z,1715807999.675 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-15T21:20:00.657Z,1715808000.657 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20240515T211545/Courier0000.lzma 2024-05-15T21:20:01.659Z,1715808001.659 [DataOverHttps](INFO): Moved sent file to Logs/20240515T211545/Courier0000.lzma.bak 2024-05-15T21:20:01.660Z,1715808001.660 [DataOverHttps](INFO): SBD MOMSN=21024034 2024-05-15T21:20:12.200Z,1715808012.200 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-15T21:20:12.559Z,1715808012.559 [CommandExec](IMPORTANT): got command docking standby 2024-05-15T21:20:12.559Z,1715808012.559 [CommandExec](IMPORTANT): Switching docking moudle to STANDBY. 2024-05-15T21:20:13.023Z,1715808013.023 [DockingStepper](INFO): Resume 2024-05-15T21:20:13.460Z,1715808013.460 [DockingStepper](INFO): Resuming 2024-05-15T21:20:13.491Z,1715808013.491 [Reporter](INFO): Dock.dock_voltage_present 0 bool 2024-05-15T21:20:13.858Z,1715808013.858 [DockingStepper](INFO): Start 2024-05-15T21:20:13.858Z,1715808013.858 [DockingStepper](DEBUG): Initializing EZServoServo. 2024-05-15T21:20:13.979Z,1715808013.979 [DockingStepper](DEBUG): Initializing DockingStepper. 2024-05-15T21:20:14.267Z,1715808014.267 [DockingStepper](INFO): Starting 2024-05-15T21:20:14.748Z,1715808014.748 [DockingStepper](INFO): Starting 2024-05-15T21:20:15.073Z,1715808015.073 [DockingStepper](INFO): Starting 2024-05-15T21:20:15.130Z,1715808015.130 [DockingStepper](INFO): Init string: /1z14975aE13561N3m50 2024-05-15T21:20:15.494Z,1715808015.494 [DockingStepper](INFO): Starting 2024-05-15T21:20:15.983Z,1715808015.983 [DockingStepper](INFO): Starting 2024-05-15T21:20:16.273Z,1715808016.273 [DockingStepper](INFO): Starting 2024-05-15T21:20:16.706Z,1715808016.706 [DockingStepper](INFO): Starting 2024-05-15T21:20:16.734Z,1715808016.734 [DockingStepper](INFO): Sent speed cmd:/1V10000 Response:ÿ/0@ 2024-05-15T21:20:17.096Z,1715808017.096 [DockingStepper](INFO): Starting 2024-05-15T21:20:17.110Z,1715808017.110 [Reporter](INFO): Dock.dock_voltage_present 0 bool 2024-05-15T21:20:19.504Z,1715808019.504 [DataOverHttps](INFO): Sending 643 bytes from file Logs/20240515T204421/Express0001.lzma 2024-05-15T21:20:20.503Z,1715808020.503 [DataOverHttps](INFO): Moved sent file to Logs/20240515T204421/Express0001.lzma.bak 2024-05-15T21:20:20.504Z,1715808020.504 [DataOverHttps](INFO): SBD MOMSN=21024037 2024-05-15T21:20:25.203Z,1715808025.203 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-15T21:20:33.743Z,1715808033.743 [Startup:StartupSatComms:B](INFO): Timed out from 2024-05-15T21:19:33.4Z 2024-05-15T21:20:33.743Z,1715808033.743 [Startup:StartupSatComms:B] Stopped 2024-05-15T21:20:33.743Z,1715808033.743 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2024-05-15T21:20:33.743Z,1715808033.743 [Startup:StartupSatComms] Stopped 2024-05-15T21:20:33.743Z,1715808033.743 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2024-05-15T21:20:33.744Z,1715808033.744 [Startup](INFO): Completed Startup 2024-05-15T21:20:33.744Z,1715808033.744 [MissionManager](INFO): Startup is completed. 2024-05-15T21:20:33.745Z,1715808033.745 [MissionManager](INFO): Uninitializing Mission Startup 2024-05-15T21:20:33.745Z,1715808033.745 [Startup] Stopped 2024-05-15T21:20:33.745Z,1715808033.745 [Startup](DEBUG): Aggregate::uninitialize Startup 2024-05-15T21:20:33.745Z,1715808033.745 [Startup:A.GoToSurface] Stopped 2024-05-15T21:20:33.745Z,1715808033.745 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2024-05-15T21:20:34.109Z,1715808034.109 [MissionManager](IMPORTANT): Started mission Default 2024-05-15T21:20:34.109Z,1715808034.109 [Default] Running Loop=1 2024-05-15T21:20:34.109Z,1715808034.109 [Default](DEBUG): Aggregate::initialize Default 2024-05-15T21:20:34.109Z,1715808034.109 [Default:B.GoToSurface] Running Loop=1 2024-05-15T21:20:34.114Z,1715808034.114 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2024-05-15T21:20:34.114Z,1715808034.114 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2024-05-15T21:20:34.115Z,1715808034.115 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2024-05-15T21:20:34.115Z,1715808034.115 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2024-05-15T21:20:34.115Z,1715808034.115 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2024-05-15T21:20:34.116Z,1715808034.116 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2024-05-15T21:20:34.116Z,1715808034.116 [Default:A.Wait] Running Loop=1 2024-05-15T21:20:34.116Z,1715808034.116 [Default:A.Wait](DEBUG): Initialize Wait Component. 2024-05-15T21:20:37.817Z,1715808037.817 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-15T21:20:41.020Z,1715808041.020 [DataOverHttps](INFO): Sending 1175 bytes from file Logs/20240515T211545/Express0001.lzma 2024-05-15T21:20:42.019Z,1715808042.019 [DataOverHttps](INFO): Moved sent file to Logs/20240515T211545/Express0001.lzma.bak 2024-05-15T21:20:42.020Z,1715808042.020 [DataOverHttps](INFO): SBD MOMSN=21024046 2024-05-15T21:20:47.249Z,1715808047.249 [Default:A.Wait](INFO): Done Waiting. 2024-05-15T21:20:47.249Z,1715808047.249 [Default:A.Wait] Stopped 2024-05-15T21:20:47.249Z,1715808047.249 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2024-05-15T21:20:47.631Z,1715808047.631 [Default:CheckIn] Running Loop=1 2024-05-15T21:20:47.632Z,1715808047.632 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-05-15T21:20:47.632Z,1715808047.632 [Default:CheckIn:Read_GPS] Running Loop=1 2024-05-15T21:20:47.967Z,1715808047.967 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2024-05-15T21:20:54.003Z,1715808054.003 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-15T21:21:09.759Z,1715808069.759 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-15T21:21:24.732Z,1715808084.732 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-05-15T21:21:30.650Z,1715808090.650 [CommandExec](IMPORTANT): got command get Dock.dock_voltage_present 2024-05-15T21:21:30.651Z,1715808090.651 [CommandExec](IMPORTANT): Dock.dock_voltage_present 0 bool 2024-05-15T21:21:39.079Z,1715808099.079 [CommandExec](IMPORTANT): got command docking standby 2024-05-15T21:21:39.079Z,1715808099.079 [CommandExec](IMPORTANT): Switching docking moudle to STANDBY. 2024-05-15T21:21:41.278Z,1715808101.278 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2024-05-15T21:21:59.087Z,1715808119.087 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2024-05-15T21:21:59.087Z,1715808119.087 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-05-15T21:21:59.259Z,1715808119.259 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-05-15T21:21:59.683Z,1715808119.683 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-05-15T21:21:59.683Z,1715808119.683 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2024-05-15T21:23:02.889Z,1715808182.889 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,212301.00,A,3648.16255,N,12147.28666,W,0.680,0.00,150524,,,A*77 2024-05-15T21:23:02.900Z,1715808182.900 [NAL9602](INFO): GPS fix at 20240515T212301: (36.802709, -121.788111) 2024-05-15T21:23:02.911Z,1715808182.911 [Default:CheckIn:Read_GPS] Stopped 2024-05-15T21:23:02.911Z,1715808182.911 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-05-15T21:23:03.384Z,1715808183.384 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications 2024-05-15T21:23:14.175Z,1715808194.175 [DataOverHttps](INFO): Sending 223 bytes from file Logs/20240515T211545/Courier0004.lzma 2024-05-15T21:23:15.175Z,1715808195.175 [DataOverHttps](INFO): Moved sent file to Logs/20240515T211545/Courier0004.lzma.bak 2024-05-15T21:23:15.176Z,1715808195.176 [DataOverHttps](INFO): SBD MOMSN=21024083 2024-05-15T21:23:16.575Z,1715808196.575 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-05-15T21:23:34.693Z,1715808214.693 [DataOverHttps](INFO): Sending 467 bytes from file Logs/20240515T211545/Express0005.lzma 2024-05-15T21:23:35.035Z,1715808215.035 [NAL9602](INFO): Not Powering down - fast GPS 2024-05-15T21:23:35.663Z,1715808215.663 [DataOverHttps](INFO): Moved sent file to Logs/20240515T211545/Express0005.lzma.bak 2024-05-15T21:23:35.664Z,1715808215.664 [DataOverHttps](INFO): SBD MOMSN=21024086 2024-05-15T21:23:38.693Z,1715808218.693 [Default:CheckIn:Read_Iridium] Stopped 2024-05-15T21:23:38.693Z,1715808218.693 [Default:CheckIn:C.Wait] Running Loop=1 2024-05-15T21:23:38.693Z,1715808218.693 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-05-15T21:24:03.560Z,1715808243.560 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-05-15T21:24:09.652Z,1715808249.652 [RDI_Pathfinder](ERROR): only read 2 of 4 data items for water velocity. Device response is::WS,-32768,32768,V 2024-05-15T21:24:20.529Z,1715808260.529 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-05-15T21:24:37.953Z,1715808277.953 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-05-15T21:24:49.675Z,1715808289.675 [RDI_Pathfinder](ERROR): only read 0 of 4 data items for beam range. Device response is::RA, V 2024-05-15T21:24:55.364Z,1715808295.364 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-05-15T21:25:12.294Z,1715808312.294 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-05-15T21:25:29.260Z,1715808329.260 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-05-15T21:25:46.633Z,1715808346.633 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-05-15T21:26:04.006Z,1715808364.006 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-05-15T21:26:21.451Z,1715808381.451 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-05-15T21:26:27.963Z,1715808387.963 [CommandExec](IMPORTANT): got command restart system 2024-05-15T21:26:30.034Z,1715808390.034 [Supervisor](INFO): Stop Mission called by Supervisor::terminate 2024-05-15T21:26:30.034Z,1715808390.034 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2024-05-15T21:26:30.035Z,1715808390.035 [CommandExec](INFO): Uninitializing the command executive. 2024-05-15T21:26:30.035Z,1715808390.035 [CommandExec](INFO): Uninitializing the command scheduler. 2024-05-15T21:26:30.035Z,1715808390.035 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-05-15T21:26:30.194Z,1715808390.194 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2024-05-15T21:26:30.194Z,1715808390.194 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2024-05-15T21:26:30.194Z,1715808390.194 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-05-15T21:26:30.195Z,1715808390.195 [NavChartDb](INFO): Join timeout helper Thread ID is 1002 2024-05-15T21:26:30.586Z,1715808390.586 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2024-05-15T21:26:30.586Z,1715808390.586 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-05-15T21:26:30.594Z,1715808390.594 [ComponentRegistry](INFO): Shutting down WetLabsUBAT ThreadHandler 2024-05-15T21:26:30.594Z,1715808390.594 [WetLabsUBAT ThreadHandler](INFO): Thread cancelled. 2024-05-15T21:26:30.594Z,1715808390.594 [WetLabsUBAT](INFO): Join timeout helper Thread ID is 1003 2024-05-15T21:26:30.882Z,1715808390.882 [WetLabsUBAT ThreadHandler](INFO): Uninitializing protected caller thread. 2024-05-15T21:26:30.882Z,1715808390.882 [WetLabsUBAT](INFO): Powering down 2024-05-15T21:26:30.883Z,1715808390.883 [WetLabsUBAT ThreadHandler](INFO): Thread cancelled. 2024-05-15T21:26:30.897Z,1715808390.897 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2024-05-15T21:26:30.897Z,1715808390.897 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-05-15T21:26:30.901Z,1715808390.901 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 1004 2024-05-15T21:26:31.226Z,1715808391.226 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2024-05-15T21:26:31.226Z,1715808391.226 [WetLabsBB2FL](INFO): Powering down 2024-05-15T21:26:31.227Z,1715808391.227 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-05-15T21:26:31.243Z,1715808391.243 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2024-05-15T21:26:31.243Z,1715808391.243 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-05-15T21:26:31.245Z,1715808391.245 [CTD_Seabird](INFO): Join timeout helper Thread ID is 1005 2024-05-15T21:26:31.602Z,1715808391.602 [CTD_Seabird](INFO): Powering down 2024-05-15T21:26:31.614Z,1715808391.614 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2024-05-15T21:26:31.615Z,1715808391.615 [CTD_Seabird](INFO): Powering down 2024-05-15T21:26:31.626Z,1715808391.626 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-05-15T21:26:31.631Z,1715808391.631 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler 2024-05-15T21:26:31.631Z,1715808391.631 [DAT ThreadHandler](INFO): Thread cancelled. 2024-05-15T21:26:31.632Z,1715808391.632 [DAT](INFO): Join timeout helper Thread ID is 1006 2024-05-15T21:26:31.662Z,1715808391.662 [DAT](INFO): Powering down 2024-05-15T21:26:31.734Z,1715808391.734 [DAT ThreadHandler](INFO): Uninitializing protected caller thread. 2024-05-15T21:26:31.735Z,1715808391.735 [DAT](INFO): Powering down 2024-05-15T21:26:31.735Z,1715808391.735 [DAT ThreadHandler](INFO): Thread cancelled. 2024-05-15T21:26:31.751Z,1715808391.751 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2024-05-15T21:26:31.751Z,1715808391.751 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-05-15T21:26:31.751Z,1715808391.751 [Radio_Surface](INFO): Join timeout helper Thread ID is 1007 2024-05-15T21:26:32.134Z,1715808392.134 [Radio_Surface](INFO): Powering down 2024-05-15T21:26:32.135Z,1715808392.135 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2024-05-15T21:26:32.135Z,1715808392.135 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-05-15T21:26:32.142Z,1715808392.142 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2024-05-15T21:26:32.142Z,1715808392.142 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-05-15T21:26:32.143Z,1715808392.143 [Onboard](INFO): Join timeout helper Thread ID is 1008 2024-05-15T21:26:32.439Z,1715808392.439 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2024-05-15T21:26:34.430Z,1715808394.430 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2024-05-15T21:26:34.431Z,1715808394.431 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-05-15T21:26:34.463Z,1715808394.463 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2024-05-15T21:26:34.463Z,1715808394.463 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-05-15T21:26:34.464Z,1715808394.464 [DataOverHttps](INFO): Join timeout helper Thread ID is 1009 2024-05-15T21: