2024-07-01T15:42:43.113Z,1719848563.113 [Supervisor](DEBUG): Initializing supervisor. 2024-07-01T15:42:43.117Z,1719848563.117 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2024-07-01T15:42:43.118Z,1719848563.118 [SyncHandler](INFO): Protected caller Thread ID is 837 2024-07-01T15:42:43.118Z,1719848563.118 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2024-07-01T15:42:43.119Z,1719848563.119 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2024-07-01T15:42:43.119Z,1719848563.119 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 838 2024-07-01T15:42:43.123Z,1719848563.123 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2024-07-01T15:42:43.140Z,1719848563.140 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2024-07-01T15:42:43.142Z,1719848563.142 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2024-07-01T15:42:43.142Z,1719848563.142 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 839 2024-07-01T15:42:43.146Z,1719848563.146 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2024-07-01T15:42:43.147Z,1719848563.147 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2024-07-01T15:42:43.147Z,1719848563.147 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 840 2024-07-01T15:42:43.149Z,1719848563.149 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2024-07-01T15:42:43.150Z,1719848563.150 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2024-07-01T15:42:43.151Z,1719848563.151 [logger ThreadHandler](INFO): Protected caller Thread ID is 841 2024-07-01T15:42:43.154Z,1719848563.154 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2024-07-01T15:42:43.154Z,1719848563.154 [Supervisor](INFO): Looking for Config files in directory: Config/ 2024-07-01T15:42:43.159Z,1719848563.159 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2024-07-01T15:42:43.649Z,1719848563.649 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2024-07-01T15:42:43.649Z,1719848563.649 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2024-07-01T15:42:43.880Z,1719848563.880 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2024-07-01T15:42:43.881Z,1719848563.881 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2024-07-01T15:42:43.976Z,1719848563.976 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2024-07-01T15:42:44.226Z,1719848564.226 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2024-07-01T15:42:44.228Z,1719848564.228 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2024-07-01T15:42:44.318Z,1719848564.318 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2024-07-01T15:42:44.425Z,1719848564.425 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2024-07-01T15:42:44.427Z,1719848564.427 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2024-07-01T15:42:44.790Z,1719848564.790 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2024-07-01T15:42:44.791Z,1719848564.791 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2024-07-01T15:42:44.936Z,1719848564.936 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2024-07-01T15:42:44.937Z,1719848564.937 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2024-07-01T15:42:45.510Z,1719848565.510 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2024-07-01T15:42:45.512Z,1719848565.512 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2024-07-01T15:42:45.716Z,1719848565.716 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2024-07-01T15:42:45.716Z,1719848565.716 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2024-07-01T15:42:46.151Z,1719848566.151 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2024-07-01T15:42:46.151Z,1719848566.151 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2024-07-01T15:42:46.462Z,1719848566.462 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2024-07-01T15:42:46.462Z,1719848566.462 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2024-07-01T15:42:47.028Z,1719848567.028 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2024-07-01T15:42:47.029Z,1719848567.029 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2024-07-01T15:42:47.897Z,1719848567.897 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2024-07-01T15:42:47.898Z,1719848567.898 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2024-07-01T15:42:48.274Z,1719848568.274 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2024-07-01T15:42:48.276Z,1719848568.276 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2024-07-01T15:42:48.522Z,1719848568.522 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2024-07-01T15:42:48.524Z,1719848568.524 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-triton/ 2024-07-01T15:42:48.527Z,1719848568.527 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/vehicle.cfg 2024-07-01T15:42:48.658Z,1719848568.658 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/secure.cfg 2024-07-01T15:42:48.752Z,1719848568.752 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Science.cfg 2024-07-01T15:42:48.903Z,1719848568.903 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Simulator.cfg 2024-07-01T15:42:49.001Z,1719848569.001 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Battery.cfg 2024-07-01T15:42:49.277Z,1719848569.277 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2024-07-01T15:42:49.277Z,1719848569.277 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/logger.cfg 2024-07-01T15:42:49.394Z,1719848569.394 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Servo.cfg 2024-07-01T15:42:49.513Z,1719848569.513 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Navigation.cfg 2024-07-01T15:42:49.621Z,1719848569.621 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Sensor.cfg 2024-07-01T15:42:49.783Z,1719848569.783 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Control.cfg 2024-07-01T15:42:49.891Z,1719848569.891 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/BIT.cfg 2024-07-01T15:42:49.990Z,1719848569.990 [Supervisor](FAULT): Ignoring configuration overrides from Data/persisted.cfg 2024-07-01T15:42:49.994Z,1719848569.994 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2024-07-01T15:42:50.010Z,1719848570.010 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2024-07-01T15:42:50.011Z,1719848570.011 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2024-07-01T15:42:50.153Z,1719848570.153 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2024-07-01T15:42:50.154Z,1719848570.154 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2024-07-01T15:42:50.223Z,1719848570.223 [VerticalControl](DEBUG): Construct VerticalControl. 2024-07-01T15:42:50.284Z,1719848570.284 [VerticalControl] Loaded 2024-07-01T15:42:50.284Z,1719848570.284 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2024-07-01T15:42:50.287Z,1719848570.287 [HorizontalControl](DEBUG): Construct HorizontalControl. 2024-07-01T15:42:50.334Z,1719848570.334 [HorizontalControl] Loaded 2024-07-01T15:42:50.334Z,1719848570.334 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2024-07-01T15:42:50.336Z,1719848570.336 [SpeedControl](DEBUG): Construct SpeedControl. 2024-07-01T15:42:50.339Z,1719848570.339 [SpeedControl] Loaded 2024-07-01T15:42:50.340Z,1719848570.340 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2024-07-01T15:42:50.342Z,1719848570.342 [LoopControl](DEBUG): Construct LoopControl. 2024-07-01T15:42:50.343Z,1719848570.343 [LoopControl] Loaded 2024-07-01T15:42:50.343Z,1719848570.343 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2024-07-01T15:42:50.343Z,1719848570.343 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2024-07-01T15:42:50.344Z,1719848570.344 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2024-07-01T15:42:50.529Z,1719848570.529 [BuoyancyServo] Loaded 2024-07-01T15:42:50.529Z,1719848570.529 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2024-07-01T15:42:50.551Z,1719848570.551 [ElevatorServo] Loaded 2024-07-01T15:42:50.551Z,1719848570.551 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2024-07-01T15:42:50.572Z,1719848570.572 [MassServo] Loaded 2024-07-01T15:42:50.572Z,1719848570.572 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2024-07-01T15:42:50.592Z,1719848570.592 [RudderServo] Loaded 2024-07-01T15:42:50.592Z,1719848570.592 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2024-07-01T15:42:50.608Z,1719848570.608 [ThrusterHE] Loaded 2024-07-01T15:42:50.609Z,1719848570.609 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread. 2024-07-01T15:42:50.609Z,1719848570.609 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2024-07-01T15:42:50.610Z,1719848570.610 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2024-07-01T15:42:50.680Z,1719848570.680 [DepthRateCalculator] Loaded 2024-07-01T15:42:50.680Z,1719848570.680 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2024-07-01T15:42:50.685Z,1719848570.685 [PitchRateCalculator] Loaded 2024-07-01T15:42:50.685Z,1719848570.685 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2024-07-01T15:42:50.695Z,1719848570.695 [SpeedCalculator] Loaded 2024-07-01T15:42:50.695Z,1719848570.695 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2024-07-01T15:42:50.699Z,1719848570.699 [YawRateCalculator] Loaded 2024-07-01T15:42:50.699Z,1719848570.699 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2024-07-01T15:42:50.718Z,1719848570.718 [ElevatorOffsetCalculator] Loaded 2024-07-01T15:42:50.718Z,1719848570.718 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2024-07-01T15:42:50.718Z,1719848570.718 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2024-07-01T15:42:50.719Z,1719848570.719 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2024-07-01T15:42:50.855Z,1719848570.855 [DeadReckonUsingMultipleVelocitySources] Loaded 2024-07-01T15:42:50.856Z,1719848570.856 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2024-07-01T15:42:50.869Z,1719848570.869 [NavChart] Loaded 2024-07-01T15:42:50.869Z,1719848570.869 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2024-07-01T15:42:50.875Z,1719848570.875 [UniversalFixResidualReporter] Loaded 2024-07-01T15:42:50.875Z,1719848570.875 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2024-07-01T15:42:50.876Z,1719848570.876 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2024-07-01T15:42:50.876Z,1719848570.876 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2024-07-01T15:42:51.635Z,1719848571.635 [AHRS_M2] Loaded 2024-07-01T15:42:51.636Z,1719848571.636 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2024-07-01T15:42:51.889Z,1719848571.889 [BackseatComponent] Loaded 2024-07-01T15:42:51.889Z,1719848571.889 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2024-07-01T15:42:51.890Z,1719848571.890 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 4090B4E0 2024-07-01T15:42:51.890Z,1719848571.890 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 923 2024-07-01T15:42:51.893Z,1719848571.893 [LcmUniversalReporter] Loaded 2024-07-01T15:42:51.893Z,1719848571.893 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread. 2024-07-01T15:42:51.900Z,1719848571.900 [BioacousticsDataBridge] Loaded 2024-07-01T15:42:51.900Z,1719848571.900 [ComponentRegistry](DEBUG): SyncComponent "BioacousticsDataBridge" handled in the control thread. 2024-07-01T15:42:52.992Z,1719848572.992 [BPC1] Loaded 2024-07-01T15:42:52.992Z,1719848572.992 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2024-07-01T15:42:53.132Z,1719848573.132 [DataOverHttps] Loaded 2024-07-01T15:42:53.132Z,1719848573.132 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2024-07-01T15:42:53.133Z,1719848573.133 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 4093B4E0 2024-07-01T15:42:53.134Z,1719848573.134 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 924 2024-07-01T15:42:53.156Z,1719848573.156 [Depth_Keller] Loaded 2024-07-01T15:42:53.157Z,1719848573.157 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2024-07-01T15:42:53.176Z,1719848573.176 [DropWeight] Loaded 2024-07-01T15:42:53.176Z,1719848573.176 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2024-07-01T15:42:53.240Z,1719848573.240 [NAL9602] Loaded 2024-07-01T15:42:53.240Z,1719848573.240 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2024-07-01T15:42:53.270Z,1719848573.270 [Onboard] Loaded 2024-07-01T15:42:53.270Z,1719848573.270 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2024-07-01T15:42:53.271Z,1719848573.271 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 4096B4E0 2024-07-01T15:42:53.271Z,1719848573.271 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 925 2024-07-01T15:42:53.285Z,1719848573.285 [Power24vConverter] Loaded 2024-07-01T15:42:53.286Z,1719848573.286 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2024-07-01T15:42:53.301Z,1719848573.301 [Radio_Surface] Loaded 2024-07-01T15:42:53.301Z,1719848573.301 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2024-07-01T15:42:53.302Z,1719848573.302 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 4099B4E0 2024-07-01T15:42:53.303Z,1719848573.303 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 926 2024-07-01T15:42:53.318Z,1719848573.318 [Sonardyne_Nano] Loaded 2024-07-01T15:42:53.318Z,1719848573.318 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread. 2024-07-01T15:42:53.319Z,1719848573.319 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2024-07-01T15:42:53.319Z,1719848573.319 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2024-07-01T15:42:53.403Z,1719848573.403 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2024-07-01T15:42:53.404Z,1719848573.404 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2024-07-01T15:42:53.614Z,1719848573.614 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2024-07-01T15:42:53.615Z,1719848573.615 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2024-07-01T15:42:53.658Z,1719848573.658 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2024-07-01T15:42:53.658Z,1719848573.658 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2024-07-01T15:42:53.878Z,1719848573.878 [CTD_Seabird] Loaded 2024-07-01T15:42:53.879Z,1719848573.879 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2024-07-01T15:42:53.880Z,1719848573.880 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40ADB4E0 2024-07-01T15:42:53.880Z,1719848573.880 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 927 2024-07-01T15:42:53.902Z,1719848573.902 [PAR_Licor] Loaded 2024-07-01T15:42:53.902Z,1719848573.902 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2024-07-01T15:42:53.948Z,1719848573.948 [WetLabsBB2FL] Loaded 2024-07-01T15:42:53.948Z,1719848573.948 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2024-07-01T15:42:53.949Z,1719848573.949 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40B0B4E0 2024-07-01T15:42:53.950Z,1719848573.950 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 928 2024-07-01T15:42:53.950Z,1719848573.950 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2024-07-01T15:42:53.951Z,1719848573.951 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2024-07-01T15:42:54.347Z,1719848574.347 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2024-07-01T15:42:54.348Z,1719848574.348 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2024-07-01T15:42:54.518Z,1719848574.518 [SBIT](DEBUG): Construct Startup Built In Test. 2024-07-01T15:42:54.527Z,1719848574.527 [SBIT] Loaded 2024-07-01T15:42:54.527Z,1719848574.527 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2024-07-01T15:42:54.530Z,1719848574.530 [IBIT](DEBUG): Construct Initiated Built In Test. 2024-07-01T15:42:54.543Z,1719848574.543 [IBIT] Loaded 2024-07-01T15:42:54.543Z,1719848574.543 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2024-07-01T15:42:54.549Z,1719848574.549 [CBIT](DEBUG): Construct Continuous Built In Test. 2024-07-01T15:42:54.653Z,1719848574.653 [CBIT] Loaded 2024-07-01T15:42:54.653Z,1719848574.653 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2024-07-01T15:42:54.654Z,1719848574.654 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2024-07-01T15:42:54.660Z,1719848574.660 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2024-07-01T15:42:54.663Z,1719848574.663 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2024-07-01T15:42:54.674Z,1719848574.674 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2024-07-01T15:42:54.675Z,1719848574.675 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C074E0 2024-07-01T15:42:54.676Z,1719848574.676 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 929 2024-07-01T15:42:54.680Z,1719848574.680 [Supervisor](INFO): Main Thread ID is 830 2024-07-01T15:42:54.680Z,1719848574.680 [Supervisor](DEBUG): Running supervisor. 2024-07-01T15:42:54.681Z,1719848574.681 [CommandExec ThreadHandler](INFO): Handler Thread ID is 930 2024-07-01T15:42:54.681Z,1719848574.681 [CommandExec](INFO): Initializing the command executive. 2024-07-01T15:42:54.683Z,1719848574.683 [CommandLine ThreadHandler](INFO): Handler Thread ID is 931 2024-07-01T15:42:54.685Z,1719848574.685 [controlThread ThreadHandler](INFO): Handler Thread ID is 932 2024-07-01T15:42:54.685Z,1719848574.685 [controlThread](DEBUG): Initializing ControlThread 2024-07-01T15:42:54.686Z,1719848574.686 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2024-07-01T15:42:54.688Z,1719848574.688 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2024-07-01T15:42:54.688Z,1719848574.688 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2024-07-01T15:42:54.689Z,1719848574.689 [LoopControl](DEBUG): Initialize LoopControlComponent. 2024-07-01T15:42:54.690Z,1719848574.690 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2024-07-01T15:42:54.691Z,1719848574.691 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2024-07-01T15:42:54.691Z,1719848574.691 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2024-07-01T15:42:54.691Z,1719848574.691 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2024-07-01T15:42:54.692Z,1719848574.692 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2024-07-01T15:42:54.693Z,1719848574.693 [NavChart](DEBUG): Initialize NavChart Navigation. 2024-07-01T15:42:54.693Z,1719848574.693 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2024-07-01T15:42:54.701Z,1719848574.701 [SBIT](INFO): Initialize SBIT Component. 2024-07-01T15:42:54.702Z,1719848574.702 [SBIT](IMPORTANT): git: 2024-06-03 2024-07-01T15:42:54.702Z,1719848574.702 [SBIT](INFO): git hash: 7fa19da3a148abf4baea4b65318d99ca26f8c915 2024-07-01T15:42:54.702Z,1719848574.702 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2024-07-01T15:42:54.703Z,1719848574.703 [SBIT](INFO): Kernel Reporting Different Version From Configuration. Kernel Expected: #1 PREEMPT Tue Dec 18 21:19:28 PST 2018 Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021 2024-07-01T15:42:54.704Z,1719848574.704 [SBIT](INFO): Beginning SBIT in 20.000000 seconds. 2024-07-01T15:42:54.705Z,1719848574.705 [IBIT](INFO): Initialize IBIT Component. 2024-07-01T15:42:54.706Z,1719848574.706 [CBIT](DEBUG): Initialize CBIT Component. 2024-07-01T15:42:54.707Z,1719848574.707 [logger ThreadHandler](INFO): Handler Thread ID is 933 2024-07-01T15:42:54.717Z,1719848574.717 [CBIT](DEBUG): Initialized mux pins. 2024-07-01T15:42:54.717Z,1719848574.717 [CBIT](FAULT): LAST RESTART WAS UNINTENTIONAL. 2024-07-01T15:42:54.717Z,1719848574.717 [CBIT](DEBUG): Initializing the watchdog timer. 2024-07-01T15:42:54.725Z,1719848574.725 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 934 2024-07-01T15:42:54.737Z,1719848574.737 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 935 2024-07-01T15:42:54.739Z,1719848574.739 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2024-07-01T15:42:54.741Z,1719848574.741 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2024-07-01T15:42:54.742Z,1719848574.742 [CBIT](DEBUG): Initializing heartbeat. 2024-07-01T15:42:54.749Z,1719848574.749 [Onboard ThreadHandler](INFO): Handler Thread ID is 936 2024-07-01T15:42:54.767Z,1719848574.767 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 937 2024-07-01T15:42:54.786Z,1719848574.786 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 938 2024-07-01T15:42:54.787Z,1719848574.787 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2024-07-01T15:42:54.790Z,1719848574.790 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 940 2024-07-01T15:42:54.793Z,1719848574.793 [WetLabsBB2FL](INFO): Powering up 2024-07-01T15:42:54.795Z,1719848574.795 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 942 2024-07-01T15:42:54.802Z,1719848574.802 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2024-07-01T15:42:54.802Z,1719848574.802 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2024-07-01T15:42:54.802Z,1719848574.802 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2024-07-01T15:42:54.803Z,1719848574.803 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2024-07-01T15:42:54.803Z,1719848574.803 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2024-07-01T15:42:54.803Z,1719848574.803 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2024-07-01T15:42:54.803Z,1719848574.803 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2024-07-01T15:42:54.803Z,1719848574.803 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2024-07-01T15:42:54.813Z,1719848574.813 [CBIT](DEBUG): Deactivating GF circuits. 2024-07-01T15:42:54.813Z,1719848574.813 [CBIT](DEBUG): Deactivating emergency mode. 2024-07-01T15:42:54.853Z,1719848574.853 [CBIT](DEBUG): Backplane powered. 2024-07-01T15:42:54.854Z,1719848574.854 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser 2024-07-01T15:42:54.855Z,1719848574.855 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl 2024-07-01T15:42:54.855Z,1719848574.855 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl 2024-07-01T15:42:54.866Z,1719848574.866 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl 2024-07-01T15:42:54.899Z,1719848574.899 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into: 2024-07-01T15:42:54.903Z,1719848574.903 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2024-07-01T15:42:54.943Z,1719848574.943 [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-07-01T15:42:54.943Z,1719848574.943 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl 2024-07-01T15:42:54.944Z,1719848574.944 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl 2024-07-01T15:42:54.947Z,1719848574.947 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl 2024-07-01T15:42:55.173Z,1719848575.173 [Radio_Surface](INFO): Powering up 2024-07-01T15:42:55.261Z,1719848575.261 [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-07-01T15:42:55.288Z,1719848575.288 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2024-07-01T15:42:55.289Z,1719848575.289 [Default:A.Wait](DEBUG): Construct Wait. 2024-07-01T15:42:55.291Z,1719848575.291 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2024-07-01T15:42:55.323Z,1719848575.323 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2024-07-01T15:42:55.350Z,1719848575.350 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2024-07-01T15:42:55.364Z,1719848575.364 [Default:E.Execute](DEBUG): Construct Execute. 2024-07-01T15:42:55.369Z,1719848575.369 [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-07-01T15:42:55.385Z,1719848575.385 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BioacousticsDataBridge,BPC1,Depth_Keller,DropWeight,NAL9602,Power24vConverter,Sonardyne_Nano,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2024-07-01T15:42:55.405Z,1719848575.405 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2024-07-01T15:42:55.563Z,1719848575.563 [Power24vConverter](INFO): Powering up. 2024-07-01T15:42:55.564Z,1719848575.564 [Sonardyne_Nano](INFO): Initializing. 2024-07-01T15:42:55.611Z,1719848575.611 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2024-07-01T15:42:55.618Z,1719848575.618 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2024-07-01T15:42:55.619Z,1719848575.619 [ElevatorServo](DEBUG): Initializing EZServoServo. 2024-07-01T15:42:55.625Z,1719848575.625 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2024-07-01T15:42:55.626Z,1719848575.626 [MassServo](DEBUG): Initializing EZServoServo. 2024-07-01T15:42:55.633Z,1719848575.633 [MassServo](DEBUG): Initializing MassServo. 2024-07-01T15:42:55.634Z,1719848575.634 [RudderServo](DEBUG): Initializing EZServoServo. 2024-07-01T15:42:55.641Z,1719848575.641 [RudderServo](DEBUG): Initializing RudderServo. 2024-07-01T15:42:55.642Z,1719848575.642 [ThrusterHE](DEBUG): Initializing EZServoServo. 2024-07-01T15:42:55.649Z,1719848575.649 [ThrusterHE](DEBUG): Initializing ThrusterHE. 2024-07-01T15:42:55.842Z,1719848575.842 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2024-07-01T15:42:55.842Z,1719848575.842 [DropWeight] Hardware Fault, FailCount= 1 2024-07-01T15:42:55.842Z,1719848575.842 [DropWeight](ERROR): Hardware Fault 2024-07-01T15:42:55.880Z,1719848575.880 [CommandExec](FAULT): Scheduling is paused 2024-07-01T15:42:55.880Z,1719848575.880 [CBIT](INFO): Critical error at 20240701T154255 2024-07-01T15:42:55.881Z,1719848575.881 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2024-07-01T15:42:55.891Z,1719848575.891 [CBIT](ERROR): Hardware Fault in component: DropWeight 2024-07-01T15:42:55.892Z,1719848575.892 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2024-07-01T15:42:56.222Z,1719848576.222 [CBIT](INFO): Critical error at 20240701T154255 2024-07-01T15:42:56.905Z,1719848576.905 [WetLabsBB2FL](INFO): Powering down 2024-07-01T15:42:57.820Z,1719848577.820 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART 2024-07-01T15:42:59.073Z,1719848579.073 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2107 2024-07-01T15:43:01.235Z,1719848581.235 [ThrusterHE](ERROR): Zero Speed Commanded. 2024-07-01T15:43:04.742Z,1719848584.742 [CBIT](CRITICAL): Environmental Failure. Press:14.902016 PSI. Humidity:43%. Temp:25 C. ABORTING MISSION 2024-07-01T15:43:05.116Z,1719848585.116 [CBIT](INFO): Critical error at 20240701T154304 2024-07-01T15:43:15.217Z,1719848595.217 [SBIT](IMPORTANT): Beginning Startup BIT 2024-07-01T15:43:15.242Z,1719848595.242 [CBIT](IMPORTANT): Beginning ground fault scan 2024-07-01T15:43:23.274Z,1719848603.274 [NAL9602](INFO): Powering up NAL9602 2024-07-01T15:43:26.132Z,1719848606.132 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): 0.017561 CHAN A1 (24V): -0.006174 CHAN A2 (12V): -0.004739 CHAN A3 (5V): -0.002933 CHAN B0 (3.3V): -0.000649 CHAN B1 (3.15aV): -0.000896 CHAN B2 (3.15bV): -0.000910 CHAN B3 (GND): -0.000322 OPEN: -0.005132 Full Scale: +/- 1 mA 2024-07-01T15:43:34.183Z,1719848614.183 [NAL9602](INFO): NAL9602 initialized 2024-07-01T15:44:09.343Z,1719848649.343 [SBIT](IMPORTANT): SBIT PASSED 2024-07-01T15:44:09.344Z,1719848649.344 [SBIT](FAULT): Ignoring configuration overrides from Data/persisted.cfg 2024-07-01T15:44:09.746Z,1719848649.746 [MissionManager](IMPORTANT): Started mission Startup 2024-07-01T15:44:09.746Z,1719848649.746 [Startup] Running Loop=1 2024-07-01T15:44:09.746Z,1719848649.746 [Startup](DEBUG): Aggregate::initialize Startup 2024-07-01T15:44:09.746Z,1719848649.746 [Startup:A.GoToSurface] Running Loop=1 2024-07-01T15:44:09.746Z,1719848649.746 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2024-07-01T15:44:09.747Z,1719848649.747 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2024-07-01T15:44:09.747Z,1719848649.747 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2024-07-01T15:44:09.748Z,1719848649.748 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2024-07-01T15:44:09.748Z,1719848649.748 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2024-07-01T15:44:09.748Z,1719848649.748 [Startup:A.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2024-07-01T15:44:09.749Z,1719848649.749 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2024-07-01T15:44:09.750Z,1719848649.750 [Startup:StartupSatComms] Running Loop=1 2024-07-01T15:44:09.751Z,1719848649.751 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2024-07-01T15:44:09.751Z,1719848649.751 [Startup:StartupSatComms:A] Running Loop=1 2024-07-01T15:44:10.156Z,1719848650.156 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2024-07-01T15:45:09.948Z,1719848709.948 [Startup:StartupSatComms:A](INFO): Timed out from 2024-07-01T15:44:09.8Z 2024-07-01T15:45:09.948Z,1719848709.948 [Startup:StartupSatComms:A] Stopped 2024-07-01T15:45:09.948Z,1719848709.948 [Startup:StartupSatComms:B] Running Loop=1 2024-07-01T15:45:10.346Z,1719848710.346 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2024-07-01T15:42:20.745Z,1719848540.745 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.005031 2024-07-01T15:42:40.848Z,1719848560.848 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240626T185922/Courier0502.lzma 2024-07-01T15:42:41.844Z,1719848561.844 [DataOverHttps](INFO): Moved sent file to Logs/20240626T185922/Courier0502.lzma.bak 2024-07-01T15:42:41.845Z,1719848561.845 [DataOverHttps](INFO): SBD MOMSN=21311334 2024-07-01T15:43:10.581Z,1719848590.581 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20240628T004730/Courier0000.lzma 2024-07-01T15:43:11.584Z,1719848591.584 [DataOverHttps](INFO): Moved sent file to Logs/20240628T004730/Courier0000.lzma.bak 2024-07-01T15:43:11.584Z,1719848591.584 [DataOverHttps](INFO): SBD MOMSN=21311336 2024-07-01T15:43:35.364Z,1719848615.364 [DataOverHttps](INFO): Sending 319 bytes from file Logs/20240628T004952/Courier0000.lzma 2024-07-01T15:43:36.364Z,1719848616.364 [DataOverHttps](INFO): Moved sent file to Logs/20240628T004952/Courier0000.lzma.bak 2024-07-01T15:43:36.364Z,1719848616.364 [DataOverHttps](INFO): SBD MOMSN=21311339 2024-07-01T15:43:54.690Z,1719848634.690 [DataOverHttps](INFO): Sending 271 bytes from file Logs/20240701T153359/Courier0000.lzma 2024-07-01T15:43:55.691Z,1719848635.691 [DataOverHttps](INFO): Moved sent file to Logs/20240701T153359/Courier0000.lzma.bak 2024-07-01T15:43:55.692Z,1719848635.692 [DataOverHttps](INFO): SBD MOMSN=21311345 2024-07-01T15:44:13.789Z,1719848653.789 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20240701T153359/Courier0004.lzma 2024-07-01T15:44:14.792Z,1719848654.792 [DataOverHttps](INFO): Moved sent file to Logs/20240701T153359/Courier0004.lzma.bak 2024-07-01T15:44:14.792Z,1719848654.792 [DataOverHttps](INFO): SBD MOMSN=21311351 2024-07-01T15:44:32.266Z,1719848672.266 [DataOverHttps](INFO): Sending 318 bytes from file Logs/20240701T154243/Courier0000.lzma 2024-07-01T15:44:33.268Z,1719848673.268 [DataOverHttps](INFO): Moved sent file to Logs/20240701T154243/Courier0000.lzma.bak 2024-07-01T15:44:33.268Z,1719848673.268 [DataOverHttps](INFO): SBD MOMSN=21311353 2024-07-01T15:44:55.379Z,1719848695.379 [DataOverHttps](INFO): Sending 384 bytes from file Logs/20240626T185922/Express0503.lzma 2024-07-01T15:44:56.380Z,1719848696.380 [DataOverHttps](INFO): Moved sent file to Logs/20240626T185922/Express0503.lzma.bak 2024-07-01T15:44:56.380Z,1719848696.380 [DataOverHttps](INFO): SBD MOMSN=21311359 2024-07-01T15:45:16.245Z,1719848716.245 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20240628T004730/Express0001.lzma 2024-07-01T15:45:17.248Z,1719848717.248 [DataOverHttps](INFO): Moved sent file to Logs/20240628T004730/Express0001.lzma.bak 2024-07-01T15:45:17.248Z,1719848717.248 [DataOverHttps](INFO): SBD MOMSN=21311378 2024-07-01T15:45:38.388Z,1719848738.388 [DataOverHttps](INFO): Sending 854 bytes from file Logs/20240628T004952/Express0001.lzma 2024-07-01T15:45:39.388Z,1719848739.388 [DataOverHttps](INFO): Moved sent file to Logs/20240628T004952/Express0001.lzma.bak 2024-07-01T15:45:39.388Z,1719848739.388 [DataOverHttps](INFO): SBD MOMSN=21311380 2024-07-01T15:45:55.074Z,1719848755.074 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2024-07-01T15:45:55.074Z,1719848755.074 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-07-01T15:45:55.085Z,1719848755.085 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-07-01T15:45:55.496Z,1719848755.496 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-07-01T15:45:55.496Z,1719848755.496 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2024-07-01T15:45:59.661Z,1719848759.661 [DataOverHttps](INFO): Sending 77 bytes from file Logs/20240628T004952/Express0005.lzma 2024-07-01T15:46:00.664Z,1719848760.664 [DataOverHttps](INFO): Moved sent file to Logs/20240628T004952/Express0005.lzma.bak 2024-07-01T15:46:00.664Z,1719848760.664 [DataOverHttps](INFO): SBD MOMSN=21311404 2024-07-01T15:46:10.047Z,1719848770.047 [Startup:StartupSatComms:B](INFO): Timed out from 2024-07-01T15:45:09.9Z 2024-07-01T15:46:10.047Z,1719848770.047 [Startup:StartupSatComms:B] Stopped 2024-07-01T15:46:10.050Z,1719848770.050 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2024-07-01T15:46:10.050Z,1719848770.050 [Startup:StartupSatComms] Stopped 2024-07-01T15:46:10.050Z,1719848770.050 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2024-07-01T15:46:10.051Z,1719848770.051 [Startup](INFO): Completed Startup 2024-07-01T15:46:10.051Z,1719848770.051 [MissionManager](INFO): Startup is completed. 2024-07-01T15:46:10.051Z,1719848770.051 [MissionManager](INFO): Uninitializing Mission Startup 2024-07-01T15:46:10.051Z,1719848770.051 [Startup] Stopped 2024-07-01T15:46:10.051Z,1719848770.051 [Startup](DEBUG): Aggregate::uninitialize Startup 2024-07-01T15:46:10.052Z,1719848770.052 [Startup:A.GoToSurface] Stopped 2024-07-01T15:46:10.052Z,1719848770.052 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2024-07-01T15:46:10.435Z,1719848770.435 [MissionManager](IMPORTANT): Started mission Default 2024-07-01T15:46:10.435Z,1719848770.435 [Default] Running Loop=1 2024-07-01T15:46:10.435Z,1719848770.435 [Default](DEBUG): Aggregate::initialize Default 2024-07-01T15:46:10.435Z,1719848770.435 [Default:B.GoToSurface] Running Loop=1 2024-07-01T15:46:10.435Z,1719848770.435 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2024-07-01T15:46:10.435Z,1719848770.435 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2024-07-01T15:46:10.436Z,1719848770.436 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2024-07-01T15:46:10.436Z,1719848770.436 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2024-07-01T15:46:10.436Z,1719848770.436 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2024-07-01T15:46:10.436Z,1719848770.436 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2024-07-01T15:46:10.437Z,1719848770.437 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2024-07-01T15:46:10.437Z,1719848770.437 [Default:A.Wait] Running Loop=1 2024-07-01T15:46:10.437Z,1719848770.437 [Default:A.Wait](DEBUG): Initialize Wait Component. 2024-07-01T15:46:22.864Z,1719848782.864 [DataOverHttps](INFO): Sending 1508 bytes from file Logs/20240701T153359/Express0001.lzma 2024-07-01T15:46:23.788Z,1719848783.788 [Default:A.Wait](INFO): Done Waiting. 2024-07-01T15:46:23.788Z,1719848783.788 [Default:A.Wait] Stopped 2024-07-01T15:46:23.788Z,1719848783.788 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2024-07-01T15:46:23.864Z,1719848783.864 [DataOverHttps](INFO): Moved sent file to Logs/20240701T153359/Express0001.lzma.bak 2024-07-01T15:46:23.864Z,1719848783.864 [DataOverHttps](INFO): SBD MOMSN=21311407 2024-07-01T15:46:24.185Z,1719848784.185 [Default:CheckIn] Running Loop=1 2024-07-01T15:46:24.185Z,1719848784.185 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-07-01T15:46:24.185Z,1719848784.185 [Default:CheckIn:Read_GPS] Running Loop=1 2024-07-01T15:46:24.592Z,1719848784.592 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2024-07-01T15:47:15.871Z,1719848835.871 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-07-01T15:47:32.019Z,1719848852.019 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-07-01T15:47:46.159Z,1719848866.159 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-07-01T15:48:00.703Z,1719848880.703 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-07-01T15:48:14.439Z,1719848894.439 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-07-01T15:48:15.651Z,1719848895.651 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-07-01T15:48:28.175Z,1719848908.175 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-07-01T15:48:28.181Z,1719848908.181 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-07-01T15:48:36.667Z,1719848916.667 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2024-07-01T15:48:41.103Z,1719848921.103 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-07-01T15:48:42.315Z,1719848922.315 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-07-01T15:48:53.627Z,1719848933.627 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-07-01T15:48:56.091Z,1719848936.091 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2024-07-01T15:48:56.091Z,1719848936.091 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-07-01T15:48:56.102Z,1719848936.102 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-07-01T15:48:56.498Z,1719848936.498 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-07-01T15:48:56.498Z,1719848936.498 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2024-07-01T15:48:57.264Z,1719848937.264 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-07-01T15:49:06.151Z,1719848946.151 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-07-01T15:49:11.403Z,1719848951.403 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-07-01T15:49:19.079Z,1719848959.079 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-07-01T15:49:25.947Z,1719848965.947 [BPC1](ERROR): BPC1A got IPBS message with 5 sticks (min is 7). 2024-07-01T15:49:32.422Z,1719848972.422 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-07-01T15:49:44.531Z,1719848984.531 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-07-01T15:49:57.056Z,1719848997.056 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-07-01T15:50:09.582Z,1719849009.582 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-07-01T15:50:22.912Z,1719849022.912 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-07-01T15:51:24.351Z,1719849084.351 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-07-01T15:46:24.2Z 2024-07-01T15:51:24.351Z,1719849084.351 [Default:CheckIn:Read_GPS] Stopped 2024-07-01T15:51:24.351Z,1719849084.351 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-07-01T15:51:24.772Z,1719849084.772 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications 2024-07-01T15:51:33.601Z,1719849093.601 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240701T154243/Courier0004.lzma 2024-07-01T15:51:34.604Z,1719849094.604 [DataOverHttps](INFO): Moved sent file to Logs/20240701T154243/Courier0004.lzma.bak 2024-07-01T15:51:34.604Z,1719849094.604 [DataOverHttps](INFO): SBD MOMSN=21311447 2024-07-01T15:51:57.057Z,1719849117.057 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3 2024-07-01T15:51:57.057Z,1719849117.057 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-07-01T15:51:57.068Z,1719849117.068 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-07-01T15:51:57.472Z,1719849117.472 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-07-01T15:51:57.472Z,1719849117.472 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3 2024-07-01T15:51:57.713Z,1719849117.713 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20240701T153359/Express0005.lzma 2024-07-01T15:51:58.716Z,1719849118.716 [DataOverHttps](INFO): Moved sent file to Logs/20240701T153359/Express0005.lzma.bak 2024-07-01T15:51:58.716Z,1719849118.716 [DataOverHttps](INFO): SBD MOMSN=21311451 2024-07-01T15:52:18.991Z,1719849138.991 [DataOverHttps](INFO): Sending 727 bytes from file Logs/20240701T154243/Express0001.lzma 2024-07-01T15:52:19.992Z,1719849139.992 [DataOverHttps](INFO): Moved sent file to Logs/20240701T154243/Express0001.lzma.bak 2024-07-01T15:52:19.992Z,1719849139.992 [DataOverHttps](INFO): SBD MOMSN=21311459 2024-07-01T15:52:40.234Z,1719849160.234 [DataOverHttps](INFO): Sending 202 bytes from file Logs/20240701T154243/Express0005.lzma 2024-07-01T15:52:41.236Z,1719849161.236 [DataOverHttps](INFO): Moved sent file to Logs/20240701T154243/Express0005.lzma.bak 2024-07-01T15:52:41.236Z,1719849161.236 [DataOverHttps](INFO): SBD MOMSN=21311474 2024-07-01T15:52:46.760Z,1719849166.760 [Default:CheckIn:Read_Iridium] Stopped 2024-07-01T15:52:46.760Z,1719849166.760 [Default:CheckIn:C.Wait] Running Loop=1 2024-07-01T15:52:46.760Z,1719849166.760 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-07-01T15:52:56.450Z,1719849176.450 [Power24vConverter](INFO): Powering down. 2024-07-01T15:53:36.835Z,1719849216.835 [NAL9602](FAULT): GPS failed to acquire within timeout. 2024-07-01T15:53:36.835Z,1719849216.835 [NAL9602] Data Fault, FailCount= 1 2024-07-01T15:53:36.835Z,1719849216.835 [NAL9602](ERROR): Data Fault 2024-07-01T15:53:36.860Z,1719849216.860 [CBIT](ERROR): Data Fault in component: NAL9602 2024-07-01T15:53:37.251Z,1719849217.251 [NAL9602](INFO): Powering down 2024-07-01T15:53:38.134Z,1719849218.134 [CBIT](INFO): Clearing failed state for component NAL9602 2024-07-01T15:53:38.134Z,1719849218.134 [NAL9602] No Fault, FailCount= 1 2024-07-01T15:54:07.543Z,1719849247.543 [NAL9602](INFO): Powering up NAL9602 2024-07-01T15:54:18.465Z,1719849258.465 [NAL9602](INFO): NAL9602 initialized 2024-07-01T15:54:58.065Z,1719849298.065 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4 2024-07-01T15:54:58.065Z,1719849298.065 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-07-01T15:54:58.075Z,1719849298.075 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-07-01T15:54:58.526Z,1719849298.526 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-07-01T15:54:58.526Z,1719849298.526 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4 2024-07-01T15:56:51.155Z,1719849411.155 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-07-01T15:57:06.507Z,1719849426.507 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-07-01T15:57:20.243Z,1719849440.243 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-07-01T15:57:33.979Z,1719849453.979 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-07-01T15:57:40.443Z,1719849460.443 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-07-01T15:57:47.387Z,1719849467.387 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-07-01T15:57:47.387Z,1719849467.387 [Default:CheckIn:C.Wait] Stopped 2024-07-01T15:57:47.387Z,1719849467.387 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-07-01T15:57:47.387Z,1719849467.387 [Default:CheckIn:D] Running Loop=1 2024-07-01T15:57:47.714Z,1719849467.714 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-07-01T15:57:47.768Z,1719849467.768 [Default:CheckIn:D] Stopped 2024-07-01T15:57:47.768Z,1719849467.768 [Default:CheckIn:E] Running Loop=1 2024-07-01T15:57:48.167Z,1719849468.167 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 11.622213 min 2024-07-01T15:57:48.167Z,1719849468.167 [Default:CheckIn:E] Stopped 2024-07-01T15:57:48.167Z,1719849468.167 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-07-01T15:57:48.167Z,1719849468.167 [Default:CheckIn] Stopped 2024-07-01T15:57:48.167Z,1719849468.167 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-07-01T15:57:48.167Z,1719849468.167 [Default:CheckIn](INFO): Running loop #2 2024-07-01T15:57:48.168Z,1719849468.168 [Default:CheckIn] Running Loop=2 2024-07-01T15:57:48.168Z,1719849468.168 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-07-01T15:57:48.168Z,1719849468.168 [Default:CheckIn:Read_GPS] Running Loop=1 2024-07-01T15:57:55.795Z,1719849475.795 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-07-01T15:57:55.849Z,1719849475.849 [CBIT](INFO): Clearing failed state for component DropWeight 2024-07-01T15:57:55.849Z,1719849475.849 [DropWeight] No Fault, FailCount= 1 2024-07-01T15:57:59.056Z,1719849479.056 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5 2024-07-01T15:57:59.056Z,1719849479.056 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-07-01T15:57:59.067Z,1719849479.067 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-07-01T15:57:59.461Z,1719849479.461 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-07-01T15:57:59.461Z,1719849479.461 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5 2024-07-01T15:58:01.451Z,1719849481.451 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-07-01T15:58:11.147Z,1719849491.147 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-07-01T15:58:15.187Z,1719849495.187 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-07-01T15:58:26.099Z,1719849506.099 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-07-01T15:58:29.328Z,1719849509.328 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-07-01T15:58:41.451Z,1719849521.451 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-07-01T15:58:43.871Z,1719849523.871 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-07-01T15:58:56.396Z,1719849536.396 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-07-01T15:58:57.203Z,1719849537.203 [BPC1](ERROR): BPC1A got IPBS message with 5 sticks (min is 7). 2024-07-01T15:59:11.343Z,1719849551.343 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-07-01T15:59:26.291Z,1719849566.291 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-07-01T15:59:42.047Z,1719849582.047 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-07-01T15:59:57.414Z,1719849597.414 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-07-01T16:01:00.062Z,1719849660.062 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6 2024-07-01T16:01:00.062Z,1719849660.062 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-07-01T16:01:00.073Z,1719849660.073 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-07-01T16:01:00.462Z,1719849660.462 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-07-01T16:01:00.462Z,1719849660.462 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6 2024-07-01T16:02:48.323Z,1719849768.323 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-07-01T15:57:48.2Z 2024-07-01T16:02:48.323Z,1719849768.323 [Default:CheckIn:Read_GPS] Stopped 2024-07-01T16:02:48.323Z,1719849768.323 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-07-01T16:02:57.913Z,1719849777.913 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240701T154243/Courier0007.lzma 2024-07-01T16:02:58.916Z,1719849778.916 [DataOverHttps](INFO): Moved sent file to Logs/20240701T154243/Courier0007.lzma.bak 2024-07-01T16:02:58.916Z,1719849778.916 [DataOverHttps](INFO): SBD MOMSN=21311506 2024-07-01T16:03:18.746Z,1719849798.746 [DataOverHttps](INFO): Sending 182 bytes from file Logs/20240701T154243/Express0008.lzma 2024-07-01T16:03:19.748Z,1719849799.748 [DataOverHttps](INFO): Moved sent file to Logs/20240701T154243/Express0008.lzma.bak 2024-07-01T16:03:19.748Z,1719849799.748 [DataOverHttps](INFO): SBD MOMSN=21311508 2024-07-01T16:03:27.927Z,1719849807.927 [Default:CheckIn:Read_Iridium] Stopped 2024-07-01T16:03:27.927Z,1719849807.927 [Default:CheckIn:C.Wait] Running Loop=1 2024-07-01T16:03:27.927Z,1719849807.927 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-07-01T16:04:01.027Z,1719849841.027 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7 2024-07-01T16:04:01.027Z,1719849841.027 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-07-01T16:04:01.040Z,1719849841.040 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-07-01T16:04:01.576Z,1719849841.576 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-07-01T16:04:01.576Z,1719849841.576 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7 2024-07-01T16:04:19.611Z,1719849859.611 [NAL9602](FAULT): GPS failed to acquire within timeout. 2024-07-01T16:04:19.611Z,1719849859.611 [NAL9602] Data Fault, FailCount= 2 2024-07-01T16:04:19.612Z,1719849859.612 [NAL9602](ERROR): Data Fault 2024-07-01T16:04:19.686Z,1719849859.686 [CBIT](ERROR): Data Fault in component: NAL9602 2024-07-01T16:04:20.115Z,1719849860.115 [NAL9602](INFO): Powering down 2024-07-01T16:04:20.857Z,1719849860.857 [CBIT](INFO): Clearing failed state for component NAL9602 2024-07-01T16:04:20.857Z,1719849860.857 [NAL9602] No Fault, FailCount= 2 2024-07-01T16:04:46.179Z,1719849886.179 [CommandExec](IMPORTANT): got command restart system 2024-07-01T16:04:48.250Z,1719849888.250 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2024-07-01T16:04:48.250Z,1719849888.250 [CommandExec](INFO): Uninitializing the command executive. 2024-07-01T16:04:48.250Z,1719849888.250 [CommandExec](INFO): Uninitializing the command scheduler. 2024-07-01T16:04:48.251Z,1719849888.251 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-07-01T16:04:48.266Z,1719849888.266 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2024-07-01T16:04:48.266Z,1719849888.266 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2024-07-01T16:04:48.266Z,1719849888.266 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-07-01T16:04:48.267Z,1719849888.267 [NavChartDb](INFO): Join timeout helper Thread ID is 989 2024-07-01T16:04:48.486Z,1719849888.486 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2024-07-01T16:04:48.486Z,1719849888.486 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-07-01T16:04:48.502Z,1719849888.502 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2024-07-01T16:04:48.502Z,1719849888.502 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-07-01T16:04:48.502Z,1719849888.502 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 990 2024-07-01T16:04:48.522Z,1719849888.522 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2024-07-01T16:04:48.522Z,1719849888.522 [WetLabsBB2FL](INFO): Powering down 2024-07-01T16:04:48.523Z,1719849888.523 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-07-01T16:04:48.524Z,1719849888.524 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2024-07-01T16:04:48.524Z,1719849888.524 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-07-01T16:04:48.524Z,1719849888.524 [CTD_Seabird](INFO): Join timeout helper Thread ID is 991 2024-07-01T16:04:48.720Z,1719849888.720 [CTD_Seabird](INFO): Powering down 2024-07-01T16:04:48.734Z,1719849888.734 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2024-07-01T16:04:48.734Z,1719849888.734 [CTD_Seabird](INFO): Powering down 2024-07-01T16:04:48.746Z,1719849888.746 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-07-01T16:04:48.754Z,1719849888.754 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2024-07-01T16:04:48.754Z,1719849888.754 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-07-01T16:04:48.754Z,1719849888.754 [Radio_Surface](INFO): Join timeout helper Thread ID is 992 2024-07-01T16:04:48.898Z,1719849888.898 [Radio_Surface](INFO): Powering down 2024-07-01T16:04:48.899Z,1719849888.899 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2024-07-01T16:04:48.899Z,1719849888.899 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-07-01T16:04:48.916Z,1719849888.916 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2024-07-01T16:04:48.916Z,1719849888.916 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-07-01T16:04:48.917Z,1719849888.917 [Onboard](INFO): Join timeout helper Thread ID is 993 2024-07-01T16:04:49.618Z,1719849889.618 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2024-07-01T16:04:50.315Z,1719849890.315 [NAL9602](INFO): Powering up NAL9602 2024-07-01T16:04:51.654Z,1719849891.654 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2024-07-01T16:04:51.655Z,1719849891.655 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-07-01T16:04:51.676Z,1719849891.676 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2024-07-01T16:04:51.676Z,1719849891.676 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-07-01T16:04:51.677Z,1719849891.677 [DataOverHttps](INFO): Join timeout helper Thread ID is 994 2024-07-01T16:04:52.630Z,1719849892.630 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2024-07-01T16:04:52.630Z,1719849892.630 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-07-01T16:04:52.646Z,1719849892.646 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2024-07-01T16:04:52.647Z,1719849892.647 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-07-01T16:04:52.647Z,1719849892.647 [BackseatComponent](INFO): Join timeout helper Thread ID is 995 2024-07-01T16:04:52.694Z,1719849892.694 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2024-07-01T16:04:52.694Z,1719849892.694 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-07-01T16:04:52.716Z,1719849892.716 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2024-07-01T16:04:52.717Z,1719849892.717 [logger ThreadHandler](INFO): Thread cancelled. 2024-07-01T16:04:52.717Z,1719849892.717 [logger](INFO): Join timeout helper Thread ID is 996 2024-07-01T16:04:52.755Z,1719849892.755 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2024-07-01T16:04:52.756Z,1719849892.756 [logger ThreadHandler](INFO): Thread cancelled. 2024-07-01T16:04:52.775Z,1719849892.775 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2024-07-01T16:04:52.775Z,1719849892.775 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-07-01T16:04:52.775Z,1719849892.775 [CommandLine](INFO): Join timeout helper Thread ID is 997 2024-07-01T16:04:52.822Z,1719849892.822 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2024-07-01T16:04:52.822Z,1719849892.822 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-07-01T16:04:52.824Z,1719849892.824 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2024-07-01T16:04:52.824Z,1719849892.824 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-07-01T16:04:52.824Z,1719849892.824 [CommandExec](INFO): Join timeout helper Thread ID is 998 2024-07-01T16:04:52.827Z,1719849892.827 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2024-07-01T16:04:52.827Z,1719849892.827 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-07-01T16:04:52.827Z,1719849892.827 [controlThread](INFO): Join timeout helper Thread ID is 999 2024-07-01T16:04:53.122Z,1719849893.122 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2024-07-01T16:04:53.122Z,171984989